builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-020 starttime: 1505408515.16 results: success (0) revision: 943c2c2a1daf5cd0d3287c1974eb510615d5ed5b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-14 10:01:55.157127) ========= 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:55.157566) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 10:01:55.175842) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 10:01:55.572031) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 10:01:55.572347) ========= 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=af724c981e2a0f424dbabf99000001e7-1505405499.895789-329224352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-14 10:01:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 110M=0s 2017-09-14 10:01:55 (110 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127122 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 10:01:55.741315) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 10:01:55.741595) ========= 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=af724c981e2a0f424dbabf99000001e7-1505405499.895789-329224352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.024138 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 10:01:55.798644) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 12 secs) (at 2017-09-14 10:01:55.798943) ========= 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=af724c981e2a0f424dbabf99000001e7-1505405499.895789-329224352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-14 10:01:55,277 truncating revision to first 12 chars 2017-09-14 10:01:55,278 Setting DEBUG logging. 2017-09-14 10:01:55,278 attempt 1/10 2017-09-14 10:01:55,278 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:56,027 attempt 1/10 2017-09-14 10:01:56,794 current task status: no status available at this point. state: STARTED 2017-09-14 10:01:56,795 sleeping for 10.00s (attempt 1/10) 2017-09-14 10:02:06,805 attempt 2/10 2017-09-14 10:02:07,137 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-09-14 10:02:07,302 unpacking tar archive at: mozilla-central-943c2c2a1daf/testing/mozharness/ program finished with exit code 0 elapsedTime=12.330593 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 12 secs) (at 2017-09-14 10:02:08.154885) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 10:02:08.158338) ========= script_repo_revision: 943c2c2a1daf5cd0d3287c1974eb510615d5ed5b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 10:02:08.158889) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 10:02:08.159188) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 10:02:08.178667) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-09-14 10:02:08.179045) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=af724c981e2a0f424dbabf99000001e7-1505405499.895789-329224352 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 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 10:02:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:02:07 INFO - 'branch': 'Firefox', 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-020', 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.798031Z] 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:09 INFO - Running post-action listener: _resource_record_post_action 10:02:09 INFO - [mozharness: 2017-09-14 17:02:09.314221Z] Finished clobber step (success) 10:02:09 INFO - [mozharness: 2017-09-14 17:02:09.314317Z] Running read-buildbot-config step. 10:02:09 INFO - Running pre-action listener: _resource_record_pre_action 10:02:09 INFO - Running main action method: read_buildbot_config 10:02:09 INFO - Using buildbot properties: 10:02:09 INFO - { 10:02:09 INFO - "project": "", 10:02:09 INFO - "product": "firefox", 10:02:09 INFO - "who": "ryanvm@gmail.com", 10:02:09 INFO - "installer_path": "public/build/target.tar.bz2", 10:02:09 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 10:02:09 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 10:02:09 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 10:02:09 INFO - "stage_platform": "linux64-qr", 10:02:09 INFO - "basedir": "/builds/slave/test", 10:02:09 INFO - "buildnumber": 55, 10:02:09 INFO - "platform": "ubuntu64_hw_qr", 10:02:09 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:02:09 INFO - "slavebuilddir": "test", 10:02:09 INFO - "taskId": "VhV6Z5L_T1eZDkei5ftGAw", 10:02:09 INFO - "branch": "mozilla-central", 10:02:09 INFO - "script_repo_revision": "production", 10:02:09 INFO - "revision": "943c2c2a1daf5cd0d3287c1974eb510615d5ed5b", 10:02:09 INFO - "slavename": "talos-linux64-ix-020", 10:02:09 INFO - "repo_path": "mozilla-central" 10:02:09 INFO - } 10:02:09 INFO - Finding installer, test and symbols from parent task. 10:02:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VhV6Z5L_T1eZDkei5ftGAw'}, attempt #1 10:02:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VhV6Z5L_T1eZDkei5ftGAw'}, attempt #1 10:02:10 INFO - Task dependencies: BNjUtbdcSLq2BeuKb0u3jA 10:02:10 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.685260Z] Finished read-buildbot-config step (success) 10:02:10 INFO - [mozharness: 2017-09-14 17:02:10.685477Z] 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:13 INFO - Content-Length response header: 54593698 10:02:13 INFO - Bytes received: 54593698 10:02:24 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:24 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:24 INFO - Fetch https://queue.taskcluster.net/v1/task/BNjUtbdcSLq2BeuKb0u3jA/artifacts/public/build/target.talos.tests.zip into memory 10:02:26 INFO - Content-Length response header: 14500356 10:02:26 INFO - Bytes received: 14500356 10:02:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:26 INFO - trying https://queue.taskcluster.net/v1/task/BNjUtbdcSLq2BeuKb0u3jA/artifacts/public/build/target.tar.bz2 10:02:26 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:26 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:27 INFO - Downloaded 61376754 bytes. 10:02:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BNjUtbdcSLq2BeuKb0u3jA/artifacts/public/build/target.tar.bz2 10:02:28 INFO - mkdir: /builds/slave/test/properties 10:02:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:02:28 INFO - Writing to file /builds/slave/test/properties/build_url 10:02:28 INFO - Contents: 10:02:28 INFO - build_url:https://queue.taskcluster.net/v1/task/BNjUtbdcSLq2BeuKb0u3jA/artifacts/public/build/target.tar.bz2 10:02:28 INFO - Running post-action listener: _resource_record_post_action 10:02:28 INFO - Running post-action listener: find_tests_for_verification 10:02:28 INFO - Running post-action listener: set_extra_try_arguments 10:02:28 INFO - [mozharness: 2017-09-14 17:02:28.056716Z] Finished download-and-extract step (success) 10:02:28 INFO - [mozharness: 2017-09-14 17:02:28.056927Z] Running populate-webroot step. 10:02:28 INFO - Running pre-action listener: _resource_record_pre_action 10:02:28 INFO - Running main action method: populate_webroot 10:02:28 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:02:28 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:02:28 INFO - 'tests': ['tresize', 10:02:28 INFO - 'tcanvasmark']}, 10:02:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:02:28 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:02:28 INFO - 'tests': ['dromaeo_css', 10:02:28 INFO - 'kraken']}, 10:02:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:02:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:02:28 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 10:02:28 INFO - 'talos_options': ['--disable-stylo'], 10:02:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:02:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:02:28 INFO - 'tests': ['damp', 'tps']}, 10:02:28 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 10:02:28 INFO - 'talos_options': ['--disable-stylo'], 10:02:28 INFO - 'tests': ['damp', 'tps']}, 10:02:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:02:28 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:02:28 INFO - 'tests': ['dromaeo_dom']}, 10:02:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:02:28 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:02:28 INFO - 'tests': ['basic_compositor_video', 10:02:28 INFO - 'glvideo']}, 10:02:28 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:02:28 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:02:28 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 10:02:28 INFO - 'talos_options': ['--disable-stylo'], 10:02:28 INFO - 'tests': ['ts_paint_webext', 10:02:28 INFO - 'tp5o_webext']}, 10:02:28 INFO - 'other-e10s': {'tests': ['a11yr', 10:02:28 INFO - 'ts_paint', 10:02:28 INFO - 'tpaint', 10:02:28 INFO - 'sessionrestore', 10:02:28 INFO - 'sessionrestore_many_windows', 10:02:28 INFO - 'sessionrestore_no_auto_restore', 10:02:28 INFO - 'tabpaint']}, 10:02:28 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:02:28 INFO - 'tests': ['a11yr', 10:02:28 INFO - 'ts_paint', 10:02:28 INFO - 'tpaint', 10:02:28 INFO - 'sessionrestore', 10:02:28 INFO - 'sessionrestore_many_windows', 10:02:28 INFO - 'sessionrestore_no_auto_restore', 10:02:28 INFO - 'tabpaint']}, 10:02:28 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 10:02:28 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 10:02:28 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:02:28 INFO - 'tests': ['bloom_basic_singleton']}, 10:02:28 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:02:28 INFO - 'tests': ['bloom_basic']}, 10:02:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:02:28 INFO - 'tsvgr_opacity', 10:02:28 INFO - 'tart', 10:02:28 INFO - 'tscrollx', 10:02:28 INFO - 'tsvg_static']}, 10:02:28 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 10:02:28 INFO - 'tests': ['tsvgx', 10:02:28 INFO - 'tsvgr_opacity', 10:02:28 INFO - 'tart', 10:02:28 INFO - 'tscrollx', 10:02:28 INFO - 'tsvg_static']}, 10:02:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:02:28 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 10:02:28 INFO - 'talos_options': ['--disable-stylo'], 10:02:28 INFO - 'tests': ['tp5o']}, 10:02:28 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:02:28 INFO - 'talos_options': ['--mitmproxy', 10:02:28 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:02:28 INFO - '--firstNonBlankPaint'], 10:02:28 INFO - 'tests': ['tp6_google', 10:02:28 INFO - 'tp6_youtube', 10:02:28 INFO - 'tp6_amazon', 10:02:28 INFO - 'tp6_facebook']}, 10:02:28 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:02:28 INFO - 'talos_options': ['--disable-stylo', 10:02:28 INFO - '--mitmproxy', 10:02:28 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:02:28 INFO - '--firstNonBlankPaint'], 10:02:28 INFO - 'tests': ['tp6_google', 10:02:28 INFO - 'tp6_youtube', 10:02:28 INFO - 'tp6_amazon', 10:02:28 INFO - 'tp6_facebook']}, 10:02:28 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:02:28 INFO - 'talos_options': ['--stylo-threads=1', 10:02:28 INFO - '--mitmproxy', 10:02:28 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:02:28 INFO - '--firstNonBlankPaint'], 10:02:28 INFO - 'tests': ['tp6_google', 10:02:28 INFO - 'tp6_youtube', 10:02:28 INFO - 'tp6_amazon', 10:02:28 INFO - 'tp6_facebook']}, 10:02:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:02:28 INFO - 'talos_options': ['--xperf_path', 10:02:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:02:28 INFO - 'tests': ['tp5n']}, 10:02:28 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 10:02:28 INFO - 'talos_options': ['--disable-stylo', 10:02:28 INFO - '--xperf_path', 10:02:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:02:28 INFO - 'tests': ['tp5n']}}} 10:02:28 INFO - Running post-action listener: _resource_record_post_action 10:02:28 INFO - [mozharness: 2017-09-14 17:02:28.076459Z] Finished populate-webroot step (success) 10:02:28 INFO - [mozharness: 2017-09-14 17:02:28.076549Z] Running create-virtualenv step. 10:02:28 INFO - Running pre-action listener: _resource_record_pre_action 10:02:28 INFO - Running main action method: create_virtualenv 10:02:28 INFO - Creating virtualenv /builds/slave/test/build/venv 10:02:28 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:02:28 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 10:02:28 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 10:02:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:02:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:02:28 INFO - Installing distribute.............................................................................................................................................................................................done. 10:02:28 INFO - Installing pip...............done. 10:02:28 INFO - Return code: 0 10:02:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:02:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:02:29 INFO - Reading from file tmpfile_stdout 10:02:29 INFO - Output received: 10:02:29 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:29 INFO - Installing pip>=1.5 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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d34a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1edb090>, '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 0x1edbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed5f90>, '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': 'af724c981e2a0f424dbabf99000001e7-1505405499.895789-329224352', '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', 'pip>=1.5'] 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 pip>=1.5 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': 'af724c981e2a0f424dbabf99000001e7-1505405499.895789-329224352', 10:02:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:29 INFO - '_': '/tools/buildbot/bin/python'} 10:02:31 INFO - Ignoring indexes: http://pypi.python.org/simple/ 10:02:31 INFO - Downloading/unpacking pip>=1.5 10:02:31 INFO - Running setup.py egg_info for package pip 10:02:31 INFO - warning: no files found matching 'pip/cacert.pem' 10:02:31 INFO - warning: no files found matching '*.html' under directory 'docs' 10:02:31 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 10:02:31 INFO - no previously-included directories found matching 'docs/_build/_sources' 10:02:31 INFO - Installing collected packages: pip 10:02:31 INFO - Found existing installation: pip 1.1 10:02:31 INFO - Uninstalling pip: 10:02:31 INFO - Successfully uninstalled pip 10:02:31 INFO - Running setup.py install for pip 10:02:31 INFO - warning: no files found matching 'pip/cacert.pem' 10:02:31 INFO - warning: no files found matching '*.html' under directory 'docs' 10:02:31 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 10:02:31 INFO - no previously-included directories found matching 'docs/_build/_sources' 10:02:31 INFO - Installing pip script to /builds/slave/test/build/venv/bin 10:02:31 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 10:02:31 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 10:02:31 INFO - Successfully installed pip 10:02:31 INFO - Cleaning up... 10:02:31 INFO - Return code: 0 10:02:31 INFO - Installing psutil>=3.1.1 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', '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 0x1b6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d34a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1edb090>, '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 0x1edbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed5f90>, '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': 'af724c981e2a0f424dbabf99000001e7-1505405499.895789-329224352', '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', 'psutil>=3.1.1'] 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 psutil>=3.1.1 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': 'af724c981e2a0f424dbabf99000001e7-1505405499.895789-329224352', 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 psutil>=3.1.1 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:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:02:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:02:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:02:33 INFO - Installing collected packages: psutil 10:02:33 INFO - Running setup.py install for psutil 10:02:33 INFO - building 'psutil._psutil_linux' extension 10:02:33 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:33 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:33 INFO - building 'psutil._psutil_posix' extension 10:02:33 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:33 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:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:02:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:02:35 INFO - Successfully installed psutil 10:02:35 INFO - Cleaning up... 10:02:37 INFO - Return code: 0 10:02:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:02:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:37 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 0x1b6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d34a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1edb090>, '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 0x1edbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed5f90>, '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': 'af724c981e2a0f424dbabf99000001e7-1505405499.895789-329224352', '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:37 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:37 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:37 INFO - Using env: {'DISPLAY': ':0', 10:02:37 INFO - 'HOME': '/home/cltbld', 10:02:37 INFO - 'LANG': 'en_US.UTF-8', 10:02:37 INFO - 'LANGUAGE': 'en_US:en', 10:02:37 INFO - 'LOGNAME': 'cltbld', 10:02:37 INFO - 'MAIL': '/var/mail/cltbld', 10:02:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:37 INFO - 'MOZ_NO_REMOTE': '1', 10:02:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:37 INFO - 'NO_EM_RESTART': '1', 10:02:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:37 INFO - 'PWD': '/builds/slave/test', 10:02:37 INFO - 'SHELL': '/bin/bash', 10:02:37 INFO - 'SHLVL': '1', 10:02:37 INFO - 'TERM': 'linux', 10:02:37 INFO - 'TMOUT': '86400', 10:02:37 INFO - 'USER': 'cltbld', 10:02:37 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1505405499.895789-329224352', 10:02:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:37 INFO - '_': '/tools/buildbot/bin/python'} 10:02:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 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:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:02:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:02:39 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:39 INFO - Installing collected packages: mozsystemmonitor 10:02:39 INFO - Running setup.py install for mozsystemmonitor 10:02:39 INFO - Successfully installed mozsystemmonitor 10:02:39 INFO - Cleaning up... 10:02:40 INFO - Return code: 0 10:02:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:02:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:40 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 0x1b6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d34a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1edb090>, '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 0x1edbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed5f90>, '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': 'af724c981e2a0f424dbabf99000001e7-1505405499.895789-329224352', '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:40 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:40 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:40 INFO - Using env: {'DISPLAY': ':0', 10:02:40 INFO - 'HOME': '/home/cltbld', 10:02:40 INFO - 'LANG': 'en_US.UTF-8', 10:02:40 INFO - 'LANGUAGE': 'en_US:en', 10:02:40 INFO - 'LOGNAME': 'cltbld', 10:02:40 INFO - 'MAIL': '/var/mail/cltbld', 10:02:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:40 INFO - 'MOZ_NO_REMOTE': '1', 10:02:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:40 INFO - 'NO_EM_RESTART': '1', 10:02:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:40 INFO - 'PWD': '/builds/slave/test', 10:02:40 INFO - 'SHELL': '/bin/bash', 10:02:40 INFO - 'SHLVL': '1', 10:02:40 INFO - 'TERM': 'linux', 10:02:40 INFO - 'TMOUT': '86400', 10:02:40 INFO - 'USER': 'cltbld', 10:02:40 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1505405499.895789-329224352', 10:02:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:40 INFO - '_': '/tools/buildbot/bin/python'} 10:02:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:40 INFO - Downloading/unpacking jsonschema==2.5.1 10:02:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:02:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:02:41 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:41 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:41 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:41 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:41 INFO - Downloading functools32-3.2.3-2.tar.gz 10:02:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:02:41 INFO - warning: no files found matching '*.txt' 10:02:41 INFO - no previously-included directories found matching 'build' 10:02:41 INFO - no previously-included directories found matching 'dist' 10:02:41 INFO - no previously-included directories found matching '.git*' 10:02:41 INFO - Installing collected packages: jsonschema, functools32 10:02:41 INFO - Running setup.py install for functools32 10:02:41 INFO - warning: no files found matching '*.txt' 10:02:41 INFO - no previously-included directories found matching 'build' 10:02:41 INFO - no previously-included directories found matching 'dist' 10:02:41 INFO - no previously-included directories found matching '.git*' 10:02:41 INFO - Successfully installed jsonschema functools32 10:02:41 INFO - Cleaning up... 10:02:41 INFO - Return code: 0 10:02:41 INFO - Installing functools32==3.2.3-2 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', '--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 0x1b6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d34a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1edb090>, '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 0x1edbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed5f90>, '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': 'af724c981e2a0f424dbabf99000001e7-1505405499.895789-329224352', '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', '--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:41 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: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': 'af724c981e2a0f424dbabf99000001e7-1505405499.895789-329224352', 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 - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:02:42 INFO - Cleaning up... 10:02:42 INFO - Return code: 0 10:02:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:02:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d34a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1edb090>, '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 0x1edbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed5f90>, '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': 'af724c981e2a0f424dbabf99000001e7-1505405499.895789-329224352', '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:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:02:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:02:42 INFO - Using env: {'DISPLAY': ':0', 10:02:42 INFO - 'HOME': '/home/cltbld', 10:02:42 INFO - 'LANG': 'en_US.UTF-8', 10:02:42 INFO - 'LANGUAGE': 'en_US:en', 10:02:42 INFO - 'LOGNAME': 'cltbld', 10:02:42 INFO - 'MAIL': '/var/mail/cltbld', 10:02:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:42 INFO - 'MOZ_NO_REMOTE': '1', 10:02:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:42 INFO - 'NO_EM_RESTART': '1', 10:02:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:42 INFO - 'PWD': '/builds/slave/test', 10:02:42 INFO - 'SHELL': '/bin/bash', 10:02:42 INFO - 'SHLVL': '1', 10:02:42 INFO - 'TERM': 'linux', 10:02:42 INFO - 'TMOUT': '86400', 10:02:42 INFO - 'USER': 'cltbld', 10:02:42 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1505405499.895789-329224352', 10:02:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:42 INFO - '_': '/tools/buildbot/bin/python'} 10:02:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:42 INFO - Downloading/unpacking blobuploader==1.2.4 10:02:42 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:42 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:42 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:42 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 - Downloading blobuploader-1.2.4.tar.gz 10:02:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:02:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 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:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:02:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 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:43 INFO - Downloading docopt-0.6.1.tar.gz 10:02:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:02:44 INFO - Installing collected packages: blobuploader, requests, docopt 10:02:44 INFO - Running setup.py install for blobuploader 10:02:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:02:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:02:44 INFO - Running setup.py install for requests 10:02:44 INFO - Running setup.py install for docopt 10:02:44 INFO - Successfully installed blobuploader requests docopt 10:02:44 INFO - Cleaning up... 10:02:44 INFO - Return code: 0 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', '--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 0x1b6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d34a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1edb090>, '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 0x1edbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed5f90>, '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': 'af724c981e2a0f424dbabf99000001e7-1505405499.895789-329224352', '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', '--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:44 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: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': 'af724c981e2a0f424dbabf99000001e7-1505405499.895789-329224352', 10:02:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:44 INFO - '_': '/tools/buildbot/bin/python'} 10:02:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:02:44 INFO - Running setup.py (path:/tmp/pip-CNufcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:02:44 INFO - Running setup.py (path:/tmp/pip-iIdL7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:02:44 INFO - Running setup.py (path:/tmp/pip-6SpC0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:02:45 INFO - Running setup.py (path:/tmp/pip-r5Qg3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:02:45 INFO - Running setup.py (path:/tmp/pip-cIBZVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:02:45 INFO - Running setup.py (path:/tmp/pip-i5kmky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:02:45 INFO - Running setup.py (path:/tmp/pip-uekz3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:02:45 INFO - Running setup.py (path:/tmp/pip-ENsiKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:02:45 INFO - Running setup.py (path:/tmp/pip-RoJFk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:02:45 INFO - Running setup.py (path:/tmp/pip-KbxEvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:02:45 INFO - Running setup.py (path:/tmp/pip-tZxfZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:02:45 INFO - Running setup.py (path:/tmp/pip-pJPvo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:02:45 INFO - Running setup.py (path:/tmp/pip-ZeO5IN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:02:45 INFO - Running setup.py (path:/tmp/pip-n2zdug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:45 INFO - Running setup.py (path:/tmp/pip-ecbpeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:02:45 INFO - Running setup.py (path:/tmp/pip-PPfx0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:02:45 INFO - Running setup.py (path:/tmp/pip-du4Deg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:02:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:02:46 INFO - Running setup.py install for manifestparser 10:02:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:02:46 INFO - Running setup.py install for mozcrash 10:02:46 INFO - Running setup.py install for mozdebug 10:02:46 INFO - Running setup.py install for mozdevice 10:02:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:02:46 INFO - Running setup.py install for mozfile 10:02:46 INFO - Running setup.py install for mozhttpd 10:02:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:02:46 INFO - Running setup.py install for mozinfo 10:02:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:02:46 INFO - Running setup.py install for mozInstall 10:02:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:02:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:02:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:02:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:02:46 INFO - Running setup.py install for mozleak 10:02:46 INFO - Running setup.py install for mozlog 10:02:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:02:47 INFO - Running setup.py install for moznetwork 10:02:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:02:47 INFO - Running setup.py install for mozprocess 10:02:47 INFO - Running setup.py install for mozprofile 10:02:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:02:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:02:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:02:47 INFO - Running setup.py install for mozrunner 10:02:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:02:47 INFO - Running setup.py install for mozscreenshot 10:02:47 INFO - Running setup.py install for moztest 10:02:47 INFO - Running setup.py install for mozversion 10:02:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:02:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:02:47 INFO - Cleaning up... 10:02:47 INFO - Return code: 0 10:02:47 INFO - Installing None 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', '-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 0x1b6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d34a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1edb090>, '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 0x1edbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed5f90>, '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': 'af724c981e2a0f424dbabf99000001e7-1505405499.895789-329224352', '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', '-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:47 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: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': 'af724c981e2a0f424dbabf99000001e7-1505405499.895789-329224352', 10:02:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:47 INFO - '_': '/tools/buildbot/bin/python'} 10:02:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:02:48 INFO - Running setup.py (path:/tmp/pip-_wtud7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:02:48 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:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:02:48 INFO - Running setup.py (path:/tmp/pip-19uu63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:02:48 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:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:02:48 INFO - Running setup.py (path:/tmp/pip-2sVsvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:02:48 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:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:02:48 INFO - Running setup.py (path:/tmp/pip-Yhl5rS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:02:48 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:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:02:48 INFO - Running setup.py (path:/tmp/pip-tJLSCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:02:48 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:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:02:48 INFO - Running setup.py (path:/tmp/pip-nnmt05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:02:48 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:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:02:48 INFO - Running setup.py (path:/tmp/pip-_OKgyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:02:48 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:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:02:48 INFO - Running setup.py (path:/tmp/pip-1H7zMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:02:48 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:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:02:48 INFO - Running setup.py (path:/tmp/pip-0Kuvgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:02:48 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:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:02:48 INFO - Running setup.py (path:/tmp/pip-kC63Km-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:02:48 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:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:02:48 INFO - Running setup.py (path:/tmp/pip-MBtek9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:02:48 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:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:02:48 INFO - Running setup.py (path:/tmp/pip-HzdkOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:02:48 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:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:02:48 INFO - Running setup.py (path:/tmp/pip-UQDUeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:02:48 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:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:02:48 INFO - Running setup.py (path:/tmp/pip-vQ3q7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:02:49 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:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:49 INFO - Running setup.py (path:/tmp/pip-QJdq3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:49 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:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:02:49 INFO - Running setup.py (path:/tmp/pip-fh5vgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:02:49 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:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:02:49 INFO - Running setup.py (path:/tmp/pip-mg0SFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:02:49 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:49 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:49 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:49 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:49 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:49 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:49 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:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:02:49 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:49 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:49 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:49 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:50 INFO - Downloading blessings-1.6.tar.gz 10:02:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:02:50 INFO - Installing collected packages: blessings 10:02:50 INFO - Running setup.py install for blessings 10:02:50 INFO - Successfully installed blessings 10:02:50 INFO - Cleaning up... 10:02:50 INFO - Return code: 0 10:02:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:02:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:02:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:02:50 INFO - Reading from file tmpfile_stdout 10:02:50 INFO - Current package versions: 10:02:50 INFO - argparse == 1.2.1 10:02:50 INFO - blessings == 1.6 10:02:50 INFO - blobuploader == 1.2.4 10:02:50 INFO - docopt == 0.6.1 10:02:50 INFO - functools32 == 3.2.3-2 10:02:50 INFO - jsonschema == 2.5.1 10:02:50 INFO - manifestparser == 1.1 10:02:50 INFO - mozInstall == 1.13 10:02:50 INFO - mozcrash == 1.0 10:02:50 INFO - mozdebug == 0.1 10:02:50 INFO - mozdevice == 0.51 10:02:50 INFO - mozfile == 1.2 10:02:50 INFO - mozhttpd == 0.7 10:02:50 INFO - mozinfo == 0.10 10:02:50 INFO - mozleak == 0.1 10:02:50 INFO - mozlog == 3.5 10:02:50 INFO - moznetwork == 0.27 10:02:50 INFO - mozprocess == 0.25 10:02:50 INFO - mozprofile == 0.28 10:02:50 INFO - mozrunner == 6.13 10:02:50 INFO - mozscreenshot == 0.1 10:02:50 INFO - mozsystemmonitor == 0.3 10:02:50 INFO - moztest == 0.8 10:02:50 INFO - mozversion == 1.4 10:02:50 INFO - psutil == 3.1.1 10:02:50 INFO - requests == 1.2.3 10:02:50 INFO - wsgiref == 0.1.2 10:02:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:02:50 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:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:50 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:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:50 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 0x1b6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d34a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1edb090>, '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 0x1edbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed5f90>, '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': 'af724c981e2a0f424dbabf99000001e7-1505405499.895789-329224352', '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:50 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:50 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:50 INFO - Using env: {'DISPLAY': ':0', 10:02:50 INFO - 'HOME': '/home/cltbld', 10:02:50 INFO - 'LANG': 'en_US.UTF-8', 10:02:50 INFO - 'LANGUAGE': 'en_US:en', 10:02:50 INFO - 'LOGNAME': 'cltbld', 10:02:50 INFO - 'MAIL': '/var/mail/cltbld', 10:02:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:50 INFO - 'MOZ_NO_REMOTE': '1', 10:02:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:50 INFO - 'NO_EM_RESTART': '1', 10:02:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:50 INFO - 'PWD': '/builds/slave/test', 10:02:50 INFO - 'SHELL': '/bin/bash', 10:02:50 INFO - 'SHLVL': '1', 10:02:50 INFO - 'TERM': 'linux', 10:02:50 INFO - 'TMOUT': '86400', 10:02:50 INFO - 'USER': 'cltbld', 10:02:50 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1505405499.895789-329224352', 10:02:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:50 INFO - '_': '/tools/buildbot/bin/python'} 10:02:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:51 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:51 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:51 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:51 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:51 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:51 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:51 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:51 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:51 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:51 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:02:51 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:51 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:51 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:51 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:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 10:02:52 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:52 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:52 INFO - Installing collected packages: simplejson 10:02:52 INFO - Running setup.py install for simplejson 10:02:52 INFO - building 'simplejson._speedups' extension 10:02:52 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:53 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:53 INFO - Successfully installed simplejson 10:02:53 INFO - Cleaning up... 10:02:53 INFO - Return code: 0 10:02:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:02:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:53 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 0x1b6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d34a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1edb090>, '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 0x1edbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed5f90>, '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': 'af724c981e2a0f424dbabf99000001e7-1505405499.895789-329224352', '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:53 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:53 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:53 INFO - Using env: {'DISPLAY': ':0', 10:02:53 INFO - 'HOME': '/home/cltbld', 10:02:53 INFO - 'LANG': 'en_US.UTF-8', 10:02:53 INFO - 'LANGUAGE': 'en_US:en', 10:02:53 INFO - 'LOGNAME': 'cltbld', 10:02:53 INFO - 'MAIL': '/var/mail/cltbld', 10:02:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:53 INFO - 'MOZ_NO_REMOTE': '1', 10:02:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:53 INFO - 'NO_EM_RESTART': '1', 10:02:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:53 INFO - 'PWD': '/builds/slave/test', 10:02:53 INFO - 'SHELL': '/bin/bash', 10:02:53 INFO - 'SHLVL': '1', 10:02:53 INFO - 'TERM': 'linux', 10:02:53 INFO - 'TMOUT': '86400', 10:02:53 INFO - 'USER': 'cltbld', 10:02:53 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1505405499.895789-329224352', 10:02:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:53 INFO - '_': '/tools/buildbot/bin/python'} 10:02:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:02:53 INFO - Cleaning up... 10:02:53 INFO - Return code: 0 10:02:53 INFO - Running post-action listener: _resource_record_post_action 10:02:53 INFO - Running post-action listener: _start_resource_monitoring 10:02:53 INFO - Starting resource monitoring. 10:02:53 INFO - [mozharness: 2017-09-14 17:02:53.519024Z] Finished create-virtualenv step (success) 10:02:53 INFO - [mozharness: 2017-09-14 17:02:53.519545Z] Running install step. 10:02:53 INFO - Running pre-action listener: _resource_record_pre_action 10:02:53 INFO - Running main action method: install 10:02:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:02:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:02:53 INFO - Reading from file tmpfile_stdout 10:02:53 INFO - Detecting whether we're running mozinstall >=1.0... 10:02:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:02:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:02:53 INFO - Reading from file tmpfile_stdout 10:02:53 INFO - Output received: 10:02:53 INFO - Usage: mozinstall [options] installer 10:02:53 INFO - Options: 10:02:53 INFO - -h, --help show this help message and exit 10:02:53 INFO - -d DEST, --destination=DEST 10:02:53 INFO - Directory to install application into. [default: 10:02:53 INFO - "/builds/slave/test"] 10:02:53 INFO - --app=APP Application being installed. [default: firefox] 10:02:53 INFO - mkdir: /builds/slave/test/build/application 10:02:53 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:53 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:11 INFO - Reading from file tmpfile_stdout 10:03:11 INFO - Output received: 10:03:11 INFO - /builds/slave/test/build/application/firefox/firefox 10:03:11 INFO - Running post-action listener: _resource_record_post_action 10:03:11 INFO - [mozharness: 2017-09-14 17:03:11.607032Z] Finished install step (success) 10:03:11 INFO - [mozharness: 2017-09-14 17:03:11.607285Z] Running setup-mitmproxy step. 10:03:11 INFO - Running pre-action listener: _resource_record_pre_action 10:03:11 INFO - Running main action method: setup_mitmproxy 10:03:11 INFO - Skipping: mitmproxy is not required 10:03:11 INFO - Running post-action listener: _resource_record_post_action 10:03:11 INFO - [mozharness: 2017-09-14 17:03:11.608455Z] Finished setup-mitmproxy step (success) 10:03:11 INFO - [mozharness: 2017-09-14 17:03:11.608677Z] Running run-tests step. 10:03:11 INFO - Running pre-action listener: _resource_record_pre_action 10:03:11 INFO - Running pre-action listener: _set_gcov_prefix 10:03:11 INFO - Running main action method: run_tests 10:03:11 WARNING - Try message not found. 10:03:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:03:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:03:11 INFO - Python 2.7.3 10:03:11 INFO - Return code: 0 10:03:11 INFO - grabbing minidump binary from tooltool 10:03:11 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:11 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 0x1edb090>, '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 0x1edbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed5f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:03:11 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:11 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:11 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:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:03:11 INFO - Return code: 0 10:03:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:03:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:03:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:03:11 INFO - ENV: RUST_BACKTRACE is now full 10:03:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:03:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:03:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BNjUtbdcSLq2BeuKb0u3jA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BNjUtbdcSLq2BeuKb0u3jA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-020 --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:11 INFO - Using env: {'DISPLAY': ':0', 10:03:11 INFO - 'HOME': '/home/cltbld', 10:03:11 INFO - 'LANG': 'en_US.UTF-8', 10:03:11 INFO - 'LANGUAGE': 'en_US:en', 10:03:11 INFO - 'LOGNAME': 'cltbld', 10:03:11 INFO - 'MAIL': '/var/mail/cltbld', 10:03:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:03:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:03:11 INFO - 'MOZ_ACCELERATED': '1', 10:03:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:11 INFO - 'MOZ_NO_REMOTE': '1', 10:03:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:03:11 INFO - 'MOZ_WEBRENDER': '1', 10:03:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:03:11 INFO - 'NO_EM_RESTART': '1', 10:03:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:03:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:11 INFO - 'PWD': '/builds/slave/test', 10:03:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:03:11 INFO - 'RUST_BACKTRACE': 'full', 10:03:11 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:03:11 INFO - 'SHELL': '/bin/bash', 10:03:11 INFO - 'SHLVL': '1', 10:03:11 INFO - 'TERM': 'linux', 10:03:11 INFO - 'TMOUT': '86400', 10:03:11 INFO - 'USER': 'cltbld', 10:03:11 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1505405499.895789-329224352', 10:03:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:11 INFO - '_': '/tools/buildbot/bin/python'} 10:03:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BNjUtbdcSLq2BeuKb0u3jA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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:11 INFO - mozversion application_buildid: 20170914161400 10:03:11 INFO - mozversion application_changeset: 943c2c2a1daf5cd0d3287c1974eb510615d5ed5b 10:03:11 INFO - mozversion application_display_name: Nightly 10:03:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:03:11 INFO - mozversion application_name: Firefox 10:03:11 INFO - mozversion application_remotingname: firefox 10:03:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:03:11 INFO - mozversion application_vendor: Mozilla 10:03:11 INFO - mozversion application_version: 57.0a1 10:03:11 INFO - mozversion platform_buildid: 20170914161400 10:03:11 INFO - mozversion platform_changeset: 943c2c2a1daf5cd0d3287c1974eb510615d5ed5b 10:03:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:03:11 INFO - mozversion platform_version: 57.0a1 10:03:11 INFO - using testdate: 1505408591 10:03:11 INFO - actual date: 1505408591 10:03:11 INFO - starting webserver on 'localhost:33464' 10:03:11 INFO - SUITE-START | Running 2 tests 10:03:11 INFO - TEST-START | dromaeo_css 10:03:11 INFO - Initialising browser for dromaeo_css test... 10:03:11 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33464/getInfo.html -profile /tmp/tmpLzqDu4/profile 10:03:11 INFO - TEST-INFO | started process 23033 (/builds/slave/test/build/application/firefox/firefox http://localhost:33464/getInfo.html) 10:03:18 INFO - TEST-INFO | 23033: exit 0 10:03:19 INFO - Browser initialized. 10:03:19 INFO - Running cycle 1/1 for dromaeo_css test... 10:03:19 INFO - Using env: {'DISPLAY': ':0', 10:03:19 INFO - 'HOME': '/home/cltbld', 10:03:19 INFO - 'JSGC_DISABLE_POISONING': '1', 10:03:19 INFO - 'LANG': 'en_US.UTF-8', 10:03:19 INFO - 'LANGUAGE': 'en_US:en', 10:03:19 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 10:03:19 INFO - 'LOGNAME': 'cltbld', 10:03:19 INFO - 'MAIL': '/var/mail/cltbld', 10:03:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:03:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:03:19 INFO - 'MOZ_ACCELERATED': '1', 10:03:19 INFO - 'MOZ_CRASHREPORTER': '1', 10:03:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:19 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 10:03:19 INFO - 'MOZ_NO_REMOTE': '1', 10:03:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:03:19 INFO - 'MOZ_WEBRENDER': '1', 10:03:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:03:19 INFO - 'NO_EM_RESTART': '1', 10:03:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:03:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:19 INFO - 'PWD': '/builds/slave/test', 10:03:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:03:19 INFO - 'RUST_BACKTRACE': 'full', 10:03:19 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:03:19 INFO - 'SHELL': '/bin/bash', 10:03:19 INFO - 'SHLVL': '1', 10:03:19 INFO - 'TERM': 'linux', 10:03:19 INFO - 'TMOUT': '86400', 10:03:19 INFO - 'USER': 'cltbld', 10:03:19 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1505405499.895789-329224352', 10:03:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:19 INFO - '_': '/tools/buildbot/bin/python'} 10:03:19 INFO - TEST-INFO | started process 23279 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLzqDu4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:03:20 INFO - PID 23279 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 10:03:20 INFO - PID 23279 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 10:03:20 INFO - PID 23279 | 10:03:20 INFO - PID 23279 | (/builds/slave/test/build/application/firefox/firefox:23339): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 10:03:20 INFO - PID 23279 | 10:03:31 INFO - PID 23279 | RSS: Main: 214659072 10:03:31 INFO - PID 23279 | 10:06:28 INFO - PID 23279 | Cycle 1(1): loaded http://localhost:33464/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33464/tests/dromaeo/cssquery-ext.html) 10:06:30 INFO - PID 23279 | RSS: Main: 225583104 10:06:30 INFO - PID 23279 | 10:09:32 INFO - PID 23279 | Cycle 1(1): loaded http://localhost:33464/tests/dromaeo/cssquery-ext.html (next: http://localhost:33464/tests/dromaeo/cssquery-jquery.html) 10:09:32 INFO - PID 23279 | RSS: Main: 227303424 10:09:32 INFO - PID 23279 | 10:12:35 INFO - PID 23279 | Cycle 1(1): loaded http://localhost:33464/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33464/tests/dromaeo/cssquery-mootools.html) 10:12:35 INFO - PID 23279 | RSS: Main: 226930688 10:12:35 INFO - PID 23279 | 10:15:37 INFO - PID 23279 | Cycle 1(1): loaded http://localhost:33464/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33464/tests/dromaeo/cssquery-prototype.html) 10:15:38 INFO - PID 23279 | RSS: Main: 222396416 10:15:38 INFO - PID 23279 | 10:18:41 INFO - PID 23279 | Cycle 1(1): loaded http://localhost:33464/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33464/tests/dromaeo/cssquery-yui.html) 10:18:42 INFO - PID 23279 | RSS: Main: 223866880 10:18:42 INFO - PID 23279 | 10:21:44 INFO - PID 23279 | Cycle 1(1): loaded http://localhost:33464/tests/dromaeo/cssquery-yui.html (next: http://localhost:33464/tests/dromaeo/cssquery-dojo.html) 10:21:44 INFO - PID 23279 | RSS: Main: 230473728 10:21:44 INFO - PID 23279 | 10:21:44 INFO - PID 23279 | __start_tp_report 10:21:44 INFO - PID 23279 | _x_x_mozilla_page_load 10:21:44 INFO - PID 23279 | _x_x_mozilla_page_load_details 10:21:44 INFO - PID 23279 | |i|pagename|runs| 10:21:44 INFO - PID 23279 | |0;dojo.html;3118.9532157017643;3159.573457583227;3195.105370496262;3198.6801319868;3202.023382868226;6113.296970848353;6287.811365659032;6333.271673757519;6381.1066450696935;6409.807705768822;6215.56491045627;6240.4695600873865;6343.873122537547;6410.871782564346;6415.743370265195;5711.343195532525;5762.135679648044;5806.535477161817;5818.505427038707;5885.911711324334;5804.071348584227;5804.390538993408;5806.332271788756;5893.64638121712;5926.081457374093;5626.915596266059;5667.206591077232;5713.771449142029;5795.710214489259;5827.096799996008;5805.912911306334;5839.591228613998;5843.649381037151;5845.5908086433965;5847.970760146214;5679.432056794329;5741.45456181662;5761.423857614247;5821.446962538552;5849.532037436995;6115.327313995457;6183.258009038944;6246.344133865924;6360.9045864312075;6410.038494225903;6644.501662375341;6650.334966503311;6779.898301525481;6782.864342713118;6837.1111755471475;6774.593524388503;6818.931810681879;6864.5881247125335;6906.447484201251;6925.653717314164;6166.7533298667995;6296.118543403927;6317.368263173692;6334.1765570476;6415.775447859349;6864.073350097673;6919.308069193141;6921.307869213038;6926.896096558556;6940.514164008572;6519.8696026079215;6525.314841941623;6577.2436169841085;6581.967090164614;6625.17185351831;6606.966965165239;6689.665516724144;6695.363940425652;6850.691718872663;6856.931430685729;6705.865882682417;6759.763408280686;6806.319368063253;6829.624370659562;6837.3162683731225;6688.765893193812;6785.185777706608;6816.386525212754;6860.931390686129;6864.279250678706;5140.357455318085;5148.150555158357;5160.303359046556;5241.318628578337;5292.52367286946;4543.34121552373;4565.680402371869;4566.954330456653;4652.6975746577045;4688.718676879398;5829.387914269026;5904.645721256652;5911.940880591225;5937.70311484424;5946.554008449383;6713.925771876477;6806.387425131663;6882.724691012403;6887.621180835002;6905.067815844897;5638.520725738358;5790.739416726257;5815.9709201453725;5880.470757631833;5905.173275741399;5730.5129064030025;5736.426357364314;5768.769249229984;5775.740091695884;5800.53595712342;6522.804315870437;6536.901946470807;6546.738130474823;6555.704993275314;6582.670866456658;6758.986152077227;6875.381215690411;6918.135233095863;6928.515003949675;6932.584044957319;6563.737450501926;6619.735210591522;6624.867502650017;6699.799006029827;6729.427998620172;6535.901961470487;6615.106960560455;6715.26132125456;6751.797446076625;6813.3527314905;6717.05961165447;6806.149231346082;6837.62393068386;6872.037914692047;6889.138857642794;6585.934140658724;6639.203295604365;6656.068150459037;6670.366315200048;6671.099401580725;6548.738050477928;6607.273199948098;6680.766173183915;6681.33186681328;6695.933040669531;6227.564070515202;6508.153939987771;6522.641254731036;6608.074869518176;6616.867662646624;6539.346065393613;6575;6631.734730610914;6649.0691303218555;6697.2633010367845;6435.871282574416;6450.290468048417;6492.675366231575;6506.60960342381;6526.379993900572 10:21:44 INFO - PID 23279 | |1;ext.html;801.4189712458472;842.852500812358;843.3084870406267;849.8257857139283;866.3285953386124;39145.80427097864;39650.20699586006;39719;39809.601903980954;39860.60139398605;36579.26841463169;39266.21467570647;39993.200135997264;40247.798761006154;40287.19425611486;7482.738104166356;7605.657745401442;7615.238476152396;7621.733239336624;7649;7450.18048014718;7528.623568821565;7543.132539757943;7560.810979725496;7590.506617069873;7588.696452141935;7597.924020759805;7624.313811756941;7664.50180738253;7682.539047657158;7507.136679281898;7531.133919599207;7581.658825352844;7582.090149182106;7627.580483073429;7511.173770885198;7515.098188217395;7542.69829206831;7623.161452240249;7628.504147230412;36641.63358366409;37023.62976370229;37098.443523347174;37214.8139259302;37344.626553734386;3359.8320083995704;3391.16916355492;3393.8133402662843;3395.2700169463683;3423.400904841668;30920.845395772878;31133.532997005062;31224.063278101694;31242.687573124433;31272.21819454509;4990.750462476862;5178.844634660966;5188.143956247215;5198.2722418861385;5289.0744119779265;182600;182910.0854495719;182938;183249.08375458038;183638;45641.31538026932;45756.77121614437;45770.771146144056;45907.770461147484;45914.540854591025;47421.051578968225;47654.28518572224;47931.5206847934;48178.518214818105;51332.74333628383;15646.608834778994;15944.601384965237;15985.12081835487;16014.519564413085;16020.439284624983;13078.476860925646;13137.34313284332;13213.405396757169;13239.20564766117;13258.933705331605;14041.227732474608;14057;14064.71870562583;14121.152730836182;14271.357788899524;5554.805581804618;5659.462351076641;5695.288088988877;5701.942980570224;5711.485966263056;996.3175224970773;996.9252306077074;998.5257002923553;1003.1874181912674;1022.2384323678758;22596.548069038858;22779.430514236945;22796.544069118525;22860.542789144125;23113;1080.783843231357;1085.6905781852133;1101.8787933327328;1102.9448527573588;1110.8056090184186;12069.879301207051;12091.153619246745;12135.271883687006;12138.716769937966;12174;217886;219917;220502;220831;221155;42946.78526607347;43302;44141.33787993182;49556.50443495591;49977.50022499801;1385.2035079829138;1390.8191935048378;1402.726468338664;1410.8377536583218;1419.4818891104878;26349.736502635496;26531.86734066317;26603;26831.86584067067;27155.86422067877;34212.82893585516;34298.65701342955;34410.31179376348;34456.82771586126;34473.138171545914;177550;178341.1082944629;178357;178443;179163;32979.83510082434;33128.83435582807;33132.33735325328;33337.666623333454;33365.33173341275;40082.1983560333;40263.396049058705;41600.167996640506;41716.374254386814;42424.78787606042;28994;30094;30237.092887213417;30400.5439918397;30835;29784;29936.85031574828;30458.086257412313;30565.694343056286;30717.385652286383;34380.48429273513;34453.82773086119;34463.310733785685;34554;34796;29694;29860.253493662833;30465.695343046285;30479.390412192075;30653.846730766203;22392.77607223907;22830.716928307036;22999.6550051746;23027.963741632;23334.416639583465 10:21:44 INFO - PID 23279 | |2;jquery.html;528.6537318056672;536.6243629459375;542.9701366424845;553.3967974907351;580.3471095018105;22006.559868802633;22857.54284914303;22880.084796608156;22921.885390573065;22962.311130666065;23932.162374316904;24299.51400971984;24326;24335;24382.75617243827;6030.547708921827;6502.252240992276;6557.606543607375;6584.868302633944;6590;6469;6503.154589903306;6536.607803531803;6548.574342667735;6568.835779105537;6319.210098737658;6446.838829029265;6451.80644580661;6451.806445806634;6459.741610335581;6515;6558.967205163991;6566.63883486408;6580.276169621337;6618.801435956929;6074.48366888815;6087.786927457562;6098.786542471036;6129.570930034899;6135.478484328837;26409.73590264092;27494.725052749418;27514.44971100587;27520.44959100827;27644.861775691195;1998.5902889907534;2030.2589554812387;2039.0824129141945;2039.2862498125685;2048.621005114059;19003.144858481264;19198.424047278604;19364.70952935707;19419.126139323766;19433;2396.065534441552;2435.1233555919853;2467.4818288159327;2490.5392502386935;2522.6846644169477;114082;117931.41034294774;138620;139647;142688.28655856758;19397.90301048514;19609.411717648494;20481.51814191591;20775.545711800332;21694.13223471075;39046.02384940343;39158.084191580616;39309.213815723524;39310.410343844866;39371.80314098411;11628.18602697803;11669.941650291694;11685.76628467443;11698.590549330733;11832.230904991147;9624.470654113951;9646.807063858683;9797.412155270707;9815.312928095107;9891.307608467338;10742.94628526868;10819.729506762395;11272.380019098864;11274.830877536844;11367.261128026652;3959.821808018646;4215.78921053946;4226.725262857904;4256.61690447855;4330.848420305274;951.6526467839188;961.4808003678075;964.9758756031156;974.8050389922043;982.9557669904872;19229.90385048066;19354.903225483784;19435;19485;19745.901270493556;1002.7994401119805;1004.4826914139225;1022.5909636145601;1030.3663247102977;1030.4229631406436;10405.32365396262;10644.414557199429;10681.198910081775;10749.946250268855;10962.561497540168;457391;467911;476686;479962;487055;107389;109132;110289.44855275672;111996;114372.42813785878;1129.8870112988636;1132.9830052549053;1154.261272785418;1157.085902137319;1163.906887449002;16710.407262438635;16844.07357595295;17247.36150065742;17545;17595.29618815233;54616.72691636675;55368.44631553794;56965.71517142388;57145.71427143004;57721.4227857716;69509.65245173742;70556.6472167636;70816.29183708096;71026.64486677533;71837.28162718515;19393.8060619392;19625.411237662895;19762.011899404686;19777.70333445028;19819.900900495406;22017.66973495431;22078;22144.2249521266;22575.661365079864;22678.092876284765;17720.468385948443;17775.46673599794;17782.466526004242;17811.910940445214;18216.635667286846;14793;14958.476453324081;15848.207589620704;16144;16712.582185444975;17829.910850445664;17974;17994;18273.634527309645;18330.175142118904;18494.537636559195;18868.811311886704;18869.339573114874;19075.04624768784;19171.137298821865;16617.169141542632;16731.163441828103;16792.412265570645;16877.831221687626;16903.070331131414 10:21:44 INFO - PID 23279 | |3;mootools.html;1316.3089378076509;1348.5954213735877;1371.8971077169213;1384.259421209653;1386.993065034676;12707.745845083093;13174.934125329371;13218.20690758554;15174.165420901845;15759;15495.690086198298;15711;15713.371465141381;15783.605409864758;15792.763108553381;2672.425428532865;2732.7130651281527;2734.5487994480886;2745.6567929008875;2748.862556872158;2637.617545455908;2725.822821516595;2726.209399274218;2728.1269993602054;2736.712645172258;2628.68455785306;2703.7972152088573;2704.323919020245;2709.3903871628922;2712.7829773618164;2577.407196344842;2588.728183540739;2598.233521111277;2602.05025165815;2602.167306461933;2543.046357615894;2551.3366524703524;2572.562664347047;2575.36903458652;2581.4966081614093;14903.180325082116;14922.104673719612;14968.775468367983;15015.399384024735;15048.548543543711;7676.1172465166665;7913.920860791433;8003.319717823992;8007.399445041587;8017.95991020047;5032.6477146599755;5182.792688292501;5262.289590905217;5339.359276886759;5554.055810512182;1882.4540883143873;1891.933782317626;1908.7232351308983;1936.2738972885168;1944.8735832170864;27090.322741931413;27104.96712746552;27171.592426113624;27174.728252717614;27192.32019199516;6870.587764734132;7141.500094993301;7202.819929501699;7349.55902645843;7386.113666360071;19889.900550497154;19918.103685334194;19977.101030453665;19986.800131998785;20035.198592056448;7985.121636619967;7993.160718124514;8033.879491807627;8059.758207253792;8077.434579579373;5839.445252700986;6055;6247.875042499125;6322.399372059647;7223.783286501413;5545.195946587723;5702.54379649627;5704.429557044263;5739.139129130664;5788.102844059177;1759.9208035638428;1763.1008185825322;1779.5640068183377;1798.9460316190534;1816.5731053202487;851.5231470376609;864.2955990867423;867.7613656244457;875.2691502595404;883.3904605821963;8113.553754543439;8185.713500027589;8294.336453083859;8300.543470109202;8303.792405189797;702.9261927497641;721.4372789224414;721.7221369772675;721.72935149319;728.9817754556178;4311.223979683625;4324.135172965357;4364.978175109168;4402.669799765031;4406.801693923781;21258.468538286357;21821.454463638536;21880.562388752453;21979.670304945437;22099.33701988943;20472.18111275562;20635.03967123121;21147.365579032652;21422.143114275255;21490.78509214888;11302.773944521228;11352;11411.25826821254;11427.714307142389;11460.59887903936;8057.798555036171;8145.104038555635;8175.754727358189;8180.304674102768;8207.95896020516;17678.46964591064;17886.28454861791;18062.5484362892;18079.36722214716;18341.81658183401;18375.816241837412;18837.587180961757;19071.618567628848;19161.80838191656;19256.22975081037;11724.120690948042;11956.76086478283;12205.633830985085;12231.633051008484;12244.75510489803;13923.164610123426;13994.090384125;14047;14059.859401405854;14075.929620351833;11357.54569817198;11431.885681143081;11539.942300288445;11574.768504630028;11609;10505.894941050492;10511;10594.735131621463;10643.94678026605;10789.460526973777;10123.190144788547;10148.695539133838;10211.285210035227;10226.795464090825;10241.129503992244;6766.255711871591;6838.350356716104;6840.794776156723;6996.265392133752;7037;6743.12339395895;6913.654317284015;6966.616836073862;6986.685599147949;7075.433965282662 10:21:44 INFO - PID 23279 | |4;prototype.html;489.7500273936057;505.5616770288529;517.2189993110404;523.1942808075564;523.4529916237532;6128.662923539204;6246.84382890428;6274.2470903491585;6289.836380269653;6327.6519791411565;6058.818235452944;6229;6242.438180563749;6264.530160237978;6299.464545513637;5148.433672296044;5172.301739265207;5204.866004937976;5217.5565076968505;5228;5137.845864624049;5195.818146364878;5197.740112994354;5206.167013277876;5221.686698798066;4760.690555113923;4910.459849416561;4918.262260660894;5063.41770696371;5068.8225912093085;4901.828436004723;4916.877078073059;4924.852254432372;4931.630127740415;4967.577755890754;4390.736555806629;4399.702087884082;4408.955910440886;4414.4923333816705;4434.445694288214;5835.387284335126;5965.4929331006915;5968.7612495500125;6048.39516048396;6095.390460953913;5571.66570005801;5583.664980101207;5600.831975040755;5637.915431268534;5673.23411339468;6414.807555773287;6449.226092868839;6496.5127615428555;6520.347965203489;6523.347665233486;4539.9104214988165;4722.992728090548;4810.2063159578975;4837.201861692816;4838.830640927551;6484.448821850101;6518.57629254097;6615.702293396808;6641.335866413368;6772.796816095426;4837.298591704183;4894.902101957941;4914.311996320518;4952.925706114411;4992.975035124874;5006.774695138727;5031.396232452129;5041.193409054534;5054.292399064134;5056.570191533688;5562.582806289544;5605.691686957175;5609.943900561024;5619.381867994517;5664.631798933056;6428.357164283628;6440.742370305135;6479.125318082093;6489.1888513935755;6504.317046710122;1694.4916525042684;1694.7796786417932;1696.380821000326;1716;1722.776828451788;858.6393714639867;1189.1794661683412;1205.6081773423498;1208.4380762945098;1236.7093732972744;5539.778408863681;5566.304211973504;5595.796903665731;5611.6352437091455;5628.97185514078;6387.552871298964;6434;6463.2244130703675;6466.288708242089;6522.249941256816;5525.254090697785;5550.694711790809;5575.637583557056;5599.132134519156;5624.465675760796;3490.5636795400574;3507.649235076472;3508.561429821272;3536.257385948928;3537.7700449470703;6230.408111229426;6237.781677641261;6238.937610623926;6427.935720642734;6438.45273151778;6676.631290585418;6676.699548520328;6715.127033485615;6771.327783829142;6795.830104247433;6391.872162556723;6460.450861676716;6460.967695161494;6469.377148796689;6474.2414325470745;6486.870262594816;6517.989711594711;6617.900731488935;6636.170478690164;6640.90038649411;6490.51321150925;6536.8365790855605;6563.914959968807;6573.96713016451;6597.208334999831;6327.525435592257;6392.68036598159;6428;6462.676866156768;6463.1903067141275;4301.333293339538;4783.4738178801;4791.736454495036;4881.365422495053;4889.975550122369;6240.594361366497;6344.714487847966;6430.967845160744;6543.1821022372205;6546.934530654823;6241.188645476241;6389.581573857964;6432.678366081584;6466;6496.610203387811;6306.873862522815;6382.234131904202;6409.166808314889;6433.163688720437;6499.610023398611;6381;6390.712417941111;6417.48660107181;6431.646259455775;6442.774502892376;6331.6517591531065;6411;6486.513511486752;6508.349165083454;6529.412352888263;6200.286966998853;6262.3404797729545;6293.307736149111;6328.835582208895;6335.683215839282 10:21:44 INFO - PID 23279 | |5;yui.html;895.2390468102112;900.7522931193917;934.3646320502061;934.69155178791;944.914957653811;19179.904100479496;19945.202191912325;20023.098960546773;20262.594748105028;20278.087486063127;18565.721514177298;18707.812921870776;18969.33607323744;19135.182157694995;19404.708929366072;931.6552875436098;933.9533023348805;939.6570251858091;940.0458534587399;941.5998200764648;959.4387283439196;960.9759756006121;962.4610218277752;964.8938616752151;969.1955676788249;980.8234517786796;1018.2668478695327;1024.2778840917172;1024.9385036897772;1025.1132770153838;1005.969820905374;1016.6441745389054;1021.4484178543578;1022.6318525330875;1022.8465730140501;715.957042577447;726.7928640337478;739.2828955912756;740.2745309596571;747.5626758346374;19963.401097967086;20221.090050947743;20263.189472421087;20264.088116034814;20293.289734859358;20928.162873485042;21079.68380474294;22011.11955521777;22064.669029964403;22175.223867164732;16895.662086758195;17107.657846842994;17401.47795566135;17463.47609571715;17608.295668173258;3681.834317455721;3693.279810436966;3711.6288371162937;3726.105734623698;3737.719671024684;144196;144402.27798861044;146419;147583;148035;16193.59516012109;16727.247273872705;16747.748783768253;16823.915880420518;16845.241964111643;29808.40383192324;30359.241018974702;30956.380872382877;31131.68868311333;31192.688073119432;8932.062133476022;8987.41581797181;9016;9031.548422578844;9113.179813816789;4309.8363441870515;4426.313921342197;4427.800748966304;4486.977565112154;4527.59251667345;5229.555487783505;5301.125314323171;5334.333208348957;5349.384820745586;5352;921.3964853021282;923.810618823153;934.5841100710255;942.1285311087217;950.5674917912334;668.3416834418094;681.9420349270268;690.4028015766326;694.1358009278481;695.5166159519085;10844.13246940243;11034.117270618332;11462.598809041643;11638;12050.337231452178;695.2213520856673;698.849747304332;710.2932582080863;710.9751158709524;712.7220384050224;5148.9742551287;5153.484651534816;5208.401033881077;5273.868153296198;5306.867328316745;118904;121716;122814.15778763326;124235.37882310711;125684.37157814152;109621.45189274162;112623.43688281506;112691;114412;116111;95667;96355;98687.50656246673;98718;99126.50436747626;9476.526173691425;9556.23550116003;9610.423374597267;9798.118169364792;9811.656592019244;45059.32411013903;45278;46583;47500.28749568828;48141.5185848151;57999.84000319886;60087.39912600818;60253;60824;60842.391576083675;15150.393984240507;15156.696866062837;15167.16580588034;15238.3904643813;15321.157336346161;15287.235638217822;15344.386224550894;15351.385944562093;15363.692726145191;15427.5371738848;13428.462861485432;13594.184348939096;13604.183748975092;13655.726885462434;13762;13342.26617536006;13567.321633918462;13598.93200533991;13699.794503082263;13859.30703464843;12915.418806153933;12992.740145197233;13056.477740890257;13059.759322864313;13264.403101860247;10297.07326340633;10352.844707329245;10418.479076046318;10576.576936922436;10606.469676516297;10672.62645807393;10707.732306692084;10709.143268538342;10840.620578279722;10962.287451315638 10:21:44 INFO - PID 23279 | __end_tp_report 10:21:44 INFO - PID 23279 | __start_cc_report 10:21:44 INFO - PID 23279 | _x_x_mozilla_cycle_collect,386 10:21:44 INFO - PID 23279 | __end_cc_report 10:21:44 INFO - PID 23279 | __startTimestamp1505409704831__endTimestamp 10:21:44 INFO - PID 23279 | 10:21:44 INFO - PID 23279 | ------- Summary: start ------- 10:21:44 INFO - PID 23279 | Number of tests: 6 10:21:44 INFO - PID 23279 | 10:21:44 INFO - PID 23279 | [#0] dojo.html Cycles:165 Average:6222.67 Median:6522.64 stddev:762.60 (11.7%) stddev-sans-first:725.03 10:21:44 INFO - PID 23279 | Values: 3119.0 3159.6 3195.1 3198.7 3202.0 6113.3 6287.8 6333.3 6381.1 6409.8 6215.6 6240.5 6343.9 6410.9 6415.7 5711.3 5762.1 5806.5 5818.5 5885.9 5804.1 5804.4 5806.3 5893.6 5926.1 5626.9 5667.2 5713.8 5795.7 5827.1 5805.9 5839.6 5843.6 5845.6 5848.0 5679.4 5741.5 5761.4 5821.4 5849.5 6115.3 6183.3 6246.3 6360.9 6410.0 6644.5 6650.3 6779.9 6782.9 6837.1 6774.6 6818.9 6864.6 6906.4 6925.7 6166.8 6296.1 6317.4 6334.2 6415.8 6864.1 6919.3 6921.3 6926.9 6940.5 6519.9 6525.3 6577.2 6582.0 6625.2 6607.0 6689.7 6695.4 6850.7 6856.9 6705.9 6759.8 6806.3 6829.6 6837.3 6688.8 6785.2 6816.4 6860.9 6864.3 5140.4 5148.2 5160.3 5241.3 5292.5 4543.3 4565.7 4567.0 4652.7 4688.7 5829.4 5904.6 5911.9 5937.7 5946.6 6713.9 6806.4 6882.7 6887.6 6905.1 5638.5 5790.7 5816.0 5880.5 5905.2 5730.5 5736.4 5768.8 5775.7 5800.5 6522.8 6536.9 6546.7 6555.7 6582.7 6759.0 6875.4 6918.1 6928.5 6932.6 6563.7 6619.7 6624.9 6699.8 6729.4 6535.9 6615.1 6715.3 6751.8 6813.4 6717.1 6806.1 6837.6 6872.0 6889.1 6585.9 6639.2 6656.1 6670.4 6671.1 6548.7 6607.3 6680.8 6681.3 6695.9 6227.6 6508.2 6522.6 6608.1 6616.9 6539.3 6575.0 6631.7 6649.1 6697.3 6435.9 6450.3 6492.7 6506.6 6526.4 10:21:44 INFO - PID 23279 | 10:21:44 INFO - PID 23279 | [#1] ext.html Cycles:180 Average:35752.79 Median:18804.05 stddev:50302.21 (267.5%) stddev-sans-first:50374.86 10:21:44 INFO - PID 23279 | Values: 801.4 842.9 843.3 849.8 866.3 39145.8 39650.2 39719.0 39809.6 39860.6 36579.3 39266.2 39993.2 40247.8 40287.2 7482.7 7605.7 7615.2 7621.7 7649.0 7450.2 7528.6 7543.1 7560.8 7590.5 7588.7 7597.9 7624.3 7664.5 7682.5 7507.1 7531.1 7581.7 7582.1 7627.6 7511.2 7515.1 7542.7 7623.2 7628.5 36641.6 37023.6 37098.4 37214.8 37344.6 3359.8 3391.2 3393.8 3395.3 3423.4 30920.8 31133.5 31224.1 31242.7 31272.2 4990.8 5178.8 5188.1 5198.3 5289.1 182600.0 182910.1 182938.0 183249.1 183638.0 45641.3 45756.8 45770.8 45907.8 45914.5 47421.1 47654.3 47931.5 48178.5 51332.7 15646.6 15944.6 15985.1 16014.5 16020.4 13078.5 13137.3 13213.4 13239.2 13258.9 14041.2 14057.0 14064.7 14121.2 14271.4 5554.8 5659.5 5695.3 5701.9 5711.5 996.3 996.9 998.5 1003.2 1022.2 22596.5 22779.4 22796.5 22860.5 23113.0 1080.8 1085.7 1101.9 1102.9 1110.8 12069.9 12091.2 12135.3 12138.7 12174.0 217886.0 219917.0 220502.0 220831.0 221155.0 42946.8 43302.0 44141.3 49556.5 49977.5 1385.2 1390.8 1402.7 1410.8 1419.5 26349.7 26531.9 26603.0 26831.9 27155.9 34212.8 34298.7 34410.3 34456.8 34473.1 177550.0 178341.1 178357.0 178443.0 179163.0 32979.8 33128.8 33132.3 33337.7 33365.3 40082.2 40263.4 41600.2 41716.4 42424.8 28994.0 30094.0 30237.1 30400.5 30835.0 29784.0 29936.9 30458.1 30565.7 30717.4 34380.5 34453.8 34463.3 34554.0 34796.0 29694.0 29860.3 30465.7 30479.4 30653.8 22392.8 22830.7 22999.7 23028.0 23334.4 10:21:44 INFO - PID 23279 | 10:21:44 INFO - PID 23279 | [#2] jquery.html Cycles:180 Average:34693.72 Median:22012.11 stddev:79605.79 (361.6%) stddev-sans-first:79787.78 10:21:44 INFO - PID 23279 | Values: 528.7 536.6 543.0 553.4 580.3 22006.6 22857.5 22880.1 22921.9 22962.3 23932.2 24299.5 24326.0 24335.0 24382.8 6030.5 6502.3 6557.6 6584.9 6590.0 6469.0 6503.2 6536.6 6548.6 6568.8 6319.2 6446.8 6451.8 6451.8 6459.7 6515.0 6559.0 6566.6 6580.3 6618.8 6074.5 6087.8 6098.8 6129.6 6135.5 26409.7 27494.7 27514.4 27520.4 27644.9 1998.6 2030.3 2039.1 2039.3 2048.6 19003.1 19198.4 19364.7 19419.1 19433.0 2396.1 2435.1 2467.5 2490.5 2522.7 114082.0 117931.4 138620.0 139647.0 142688.3 19397.9 19609.4 20481.5 20775.5 21694.1 39046.0 39158.1 39309.2 39310.4 39371.8 11628.2 11669.9 11685.8 11698.6 11832.2 9624.5 9646.8 9797.4 9815.3 9891.3 10742.9 10819.7 11272.4 11274.8 11367.3 3959.8 4215.8 4226.7 4256.6 4330.8 951.7 961.5 965.0 974.8 983.0 19229.9 19354.9 19435.0 19485.0 19745.9 1002.8 1004.5 1022.6 1030.4 1030.4 10405.3 10644.4 10681.2 10749.9 10962.6 457391.0 467911.0 476686.0 479962.0 487055.0 107389.0 109132.0 110289.4 111996.0 114372.4 1129.9 1133.0 1154.3 1157.1 1163.9 16710.4 16844.1 17247.4 17545.0 17595.3 54616.7 55368.4 56965.7 57145.7 57721.4 69509.7 70556.6 70816.3 71026.6 71837.3 19393.8 19625.4 19762.0 19777.7 19819.9 22017.7 22078.0 22144.2 22575.7 22678.1 17720.5 17775.5 17782.5 17811.9 18216.6 14793.0 14958.5 15848.2 16144.0 16712.6 17829.9 17974.0 17994.0 18273.6 18330.2 18494.5 18868.8 18869.3 19075.0 19171.1 16617.2 16731.2 16792.4 16877.8 16903.1 10:21:44 INFO - PID 23279 | 10:21:44 INFO - PID 23279 | [#3] mootools.html Cycles:180 Average:9342.67 Median:2585.11 stddev:6805.10 (263.2%) stddev-sans-first:6797.47 10:21:44 INFO - PID 23279 | Values: 1316.3 1348.6 1371.9 1384.3 1387.0 12707.7 13174.9 13218.2 15174.2 15759.0 15495.7 15711.0 15713.4 15783.6 15792.8 2672.4 2732.7 2734.5 2745.7 2748.9 2637.6 2725.8 2726.2 2728.1 2736.7 2628.7 2703.8 2704.3 2709.4 2712.8 2577.4 2588.7 2598.2 2602.1 2602.2 2543.0 2551.3 2572.6 2575.4 2581.5 14903.2 14922.1 14968.8 15015.4 15048.5 7676.1 7913.9 8003.3 8007.4 8018.0 5032.6 5182.8 5262.3 5339.4 5554.1 1882.5 1891.9 1908.7 1936.3 1944.9 27090.3 27105.0 27171.6 27174.7 27192.3 6870.6 7141.5 7202.8 7349.6 7386.1 19889.9 19918.1 19977.1 19986.8 20035.2 7985.1 7993.2 8033.9 8059.8 8077.4 5839.4 6055.0 6247.9 6322.4 7223.8 5545.2 5702.5 5704.4 5739.1 5788.1 1759.9 1763.1 1779.6 1798.9 1816.6 851.5 864.3 867.8 875.3 883.4 8113.6 8185.7 8294.3 8300.5 8303.8 702.9 721.4 721.7 721.7 729.0 4311.2 4324.1 4365.0 4402.7 4406.8 21258.5 21821.5 21880.6 21979.7 22099.3 20472.2 20635.0 21147.4 21422.1 21490.8 11302.8 11352.0 11411.3 11427.7 11460.6 8057.8 8145.1 8175.8 8180.3 8208.0 17678.5 17886.3 18062.5 18079.4 18341.8 18375.8 18837.6 19071.6 19161.8 19256.2 11724.1 11956.8 12205.6 12231.6 12244.8 13923.2 13994.1 14047.0 14059.9 14075.9 11357.5 11431.9 11539.9 11574.8 11609.0 10505.9 10511.0 10594.7 10643.9 10789.5 10123.2 10148.7 10211.3 10226.8 10241.1 6766.3 6838.4 6840.8 6996.3 7037.0 6743.1 6913.7 6966.6 6986.7 7075.4 10:21:44 INFO - PID 23279 | 10:21:44 INFO - PID 23279 | [#4] prototype.html Cycles:180 Average:5423.76 Median:6164.47 stddev:1516.77 (24.6%) stddev-sans-first:1475.12 10:21:44 INFO - PID 23279 | Values: 489.8 505.6 517.2 523.2 523.5 6128.7 6246.8 6274.2 6289.8 6327.7 6058.8 6229.0 6242.4 6264.5 6299.5 5148.4 5172.3 5204.9 5217.6 5228.0 5137.8 5195.8 5197.7 5206.2 5221.7 4760.7 4910.5 4918.3 5063.4 5068.8 4901.8 4916.9 4924.9 4931.6 4967.6 4390.7 4399.7 4409.0 4414.5 4434.4 5835.4 5965.5 5968.8 6048.4 6095.4 5571.7 5583.7 5600.8 5637.9 5673.2 6414.8 6449.2 6496.5 6520.3 6523.3 4539.9 4723.0 4810.2 4837.2 4838.8 6484.4 6518.6 6615.7 6641.3 6772.8 4837.3 4894.9 4914.3 4952.9 4993.0 5006.8 5031.4 5041.2 5054.3 5056.6 5562.6 5605.7 5609.9 5619.4 5664.6 6428.4 6440.7 6479.1 6489.2 6504.3 1694.5 1694.8 1696.4 1716.0 1722.8 858.6 1189.2 1205.6 1208.4 1236.7 5539.8 5566.3 5595.8 5611.6 5629.0 6387.6 6434.0 6463.2 6466.3 6522.2 5525.3 5550.7 5575.6 5599.1 5624.5 3490.6 3507.6 3508.6 3536.3 3537.8 6230.4 6237.8 6238.9 6427.9 6438.5 6676.6 6676.7 6715.1 6771.3 6795.8 6391.9 6460.5 6461.0 6469.4 6474.2 6486.9 6518.0 6617.9 6636.2 6640.9 6490.5 6536.8 6563.9 6574.0 6597.2 6327.5 6392.7 6428.0 6462.7 6463.2 4301.3 4783.5 4791.7 4881.4 4890.0 6240.6 6344.7 6431.0 6543.2 6546.9 6241.2 6389.6 6432.7 6466.0 6496.6 6306.9 6382.2 6409.2 6433.2 6499.6 6381.0 6390.7 6417.5 6431.6 6442.8 6331.7 6411.0 6486.5 6508.3 6529.4 6200.3 6262.3 6293.3 6328.8 6335.7 10:21:44 INFO - PID 23279 | 10:21:44 INFO - PID 23279 | [#5] yui.html Cycles:180 Average:24451.38 Median:21545.40 stddev:36533.99 (169.6%) stddev-sans-first:36593.66 10:21:44 INFO - PID 23279 | Values: 895.2 900.8 934.4 934.7 944.9 19179.9 19945.2 20023.1 20262.6 20278.1 18565.7 18707.8 18969.3 19135.2 19404.7 931.7 934.0 939.7 940.0 941.6 959.4 961.0 962.5 964.9 969.2 980.8 1018.3 1024.3 1024.9 1025.1 1006.0 1016.6 1021.4 1022.6 1022.8 716.0 726.8 739.3 740.3 747.6 19963.4 20221.1 20263.2 20264.1 20293.3 20928.2 21079.7 22011.1 22064.7 22175.2 16895.7 17107.7 17401.5 17463.5 17608.3 3681.8 3693.3 3711.6 3726.1 3737.7 144196.0 144402.3 146419.0 147583.0 148035.0 16193.6 16727.2 16747.7 16823.9 16845.2 29808.4 30359.2 30956.4 31131.7 31192.7 8932.1 8987.4 9016.0 9031.5 9113.2 4309.8 4426.3 4427.8 4487.0 4527.6 5229.6 5301.1 5334.3 5349.4 5352.0 921.4 923.8 934.6 942.1 950.6 668.3 681.9 690.4 694.1 695.5 10844.1 11034.1 11462.6 11638.0 12050.3 695.2 698.8 710.3 711.0 712.7 5149.0 5153.5 5208.4 5273.9 5306.9 118904.0 121716.0 122814.2 124235.4 125684.4 109621.5 112623.4 112691.0 114412.0 116111.0 95667.0 96355.0 98687.5 98718.0 99126.5 9476.5 9556.2 9610.4 9798.1 9811.7 45059.3 45278.0 46583.0 47500.3 48141.5 57999.8 60087.4 60253.0 60824.0 60842.4 15150.4 15156.7 15167.2 15238.4 15321.2 15287.2 15344.4 15351.4 15363.7 15427.5 13428.5 13594.2 13604.2 13655.7 13762.0 13342.3 13567.3 13598.9 13699.8 13859.3 12915.4 12992.7 13056.5 13059.8 13264.4 10297.1 10352.8 10418.5 10576.6 10606.5 10672.6 10707.7 10709.1 10840.6 10962.3 10:21:44 INFO - PID 23279 | -------- Summary: end -------- 10:21:44 INFO - PID 23279 | 10:21:45 INFO - TEST-INFO | 23279: exit 0 10:21:45 INFO - TEST-OK | dromaeo_css | took 1113908ms 10:21:45 INFO - TEST-START | kraken 10:21:45 INFO - Initialising browser for kraken test... 10:21:45 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33464/getInfo.html -profile /tmp/tmpPXZtjM/profile 10:21:45 INFO - TEST-INFO | started process 23671 (/builds/slave/test/build/application/firefox/firefox http://localhost:33464/getInfo.html) 10:21:52 INFO - TEST-INFO | 23671: exit 0 10:21:52 INFO - Browser initialized. 10:21:52 INFO - Running cycle 1/1 for kraken test... 10:21:52 INFO - Using env: {'DISPLAY': ':0', 10:21:52 INFO - 'HOME': '/home/cltbld', 10:21:52 INFO - 'JSGC_DISABLE_POISONING': '1', 10:21:52 INFO - 'LANG': 'en_US.UTF-8', 10:21:52 INFO - 'LANGUAGE': 'en_US:en', 10:21:52 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 10:21:52 INFO - 'LOGNAME': 'cltbld', 10:21:52 INFO - 'MAIL': '/var/mail/cltbld', 10:21:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:21:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:21:52 INFO - 'MOZ_ACCELERATED': '1', 10:21:52 INFO - 'MOZ_CRASHREPORTER': '1', 10:21:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:52 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 10:21:52 INFO - 'MOZ_NO_REMOTE': '1', 10:21:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:21:52 INFO - 'MOZ_WEBRENDER': '1', 10:21:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:52 INFO - 'NO_EM_RESTART': '1', 10:21:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:52 INFO - 'PWD': '/builds/slave/test', 10:21:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:21:52 INFO - 'RUST_BACKTRACE': 'full', 10:21:52 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:21:52 INFO - 'SHELL': '/bin/bash', 10:21:52 INFO - 'SHLVL': '1', 10:21:52 INFO - 'TERM': 'linux', 10:21:52 INFO - 'TMOUT': '86400', 10:21:52 INFO - 'USER': 'cltbld', 10:21:52 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1505405499.895789-329224352', 10:21:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:52 INFO - '_': '/tools/buildbot/bin/python'} 10:21:52 INFO - TEST-INFO | started process 23916 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPXZtjM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:21:53 INFO - PID 23916 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 10:21:53 INFO - PID 23916 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 10:21:54 INFO - PID 23916 | 10:21:54 INFO - PID 23916 | (/builds/slave/test/build/application/firefox/firefox:23975): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 10:21:54 INFO - PID 23916 | 10:22:04 INFO - PID 23916 | RSS: Main: 214528000 10:22:04 INFO - PID 23916 | 10:22:07 INFO - PID 23916 | Cycle 1(1): loaded http://localhost:33464/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33464/tests/kraken/driver.html?testName=audio-beat-detection) 10:22:08 INFO - PID 23916 | RSS: Main: 220692480 10:22:08 INFO - PID 23916 | 10:22:10 INFO - PID 23916 | Cycle 1(1): loaded http://localhost:33464/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33464/tests/kraken/driver.html?testName=audio-dft) 10:22:11 INFO - PID 23916 | RSS: Main: 220876800 10:22:11 INFO - PID 23916 | 10:22:14 INFO - PID 23916 | Cycle 1(1): loaded http://localhost:33464/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33464/tests/kraken/driver.html?testName=audio-fft) 10:22:15 INFO - PID 23916 | RSS: Main: 216150016 10:22:15 INFO - PID 23916 | 10:22:17 INFO - PID 23916 | Cycle 1(1): loaded http://localhost:33464/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33464/tests/kraken/driver.html?testName=audio-oscillator) 10:22:18 INFO - PID 23916 | RSS: Main: 216707072 10:22:18 INFO - PID 23916 | 10:22:20 INFO - PID 23916 | Cycle 1(1): loaded http://localhost:33464/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33464/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:22:20 INFO - PID 23916 | RSS: Main: 216940544 10:22:20 INFO - PID 23916 | 10:22:24 INFO - PID 23916 | Cycle 1(1): loaded http://localhost:33464/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33464/tests/kraken/driver.html?testName=imaging-darkroom) 10:22:24 INFO - PID 23916 | RSS: Main: 219164672 10:22:24 INFO - PID 23916 | 10:22:28 INFO - PID 23916 | Cycle 1(1): loaded http://localhost:33464/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33464/tests/kraken/driver.html?testName=imaging-desaturate) 10:22:29 INFO - PID 23916 | RSS: Main: 219369472 10:22:29 INFO - PID 23916 | 10:22:32 INFO - PID 23916 | Cycle 1(1): loaded http://localhost:33464/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33464/tests/kraken/driver.html?testName=json-parse-financial) 10:22:32 INFO - PID 23916 | RSS: Main: 219922432 10:22:32 INFO - PID 23916 | 10:22:34 INFO - PID 23916 | Cycle 1(1): loaded http://localhost:33464/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33464/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:22:35 INFO - PID 23916 | RSS: Main: 220344320 10:22:35 INFO - PID 23916 | 10:22:36 INFO - PID 23916 | Cycle 1(1): loaded http://localhost:33464/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33464/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:22:37 INFO - PID 23916 | RSS: Main: 220733440 10:22:37 INFO - PID 23916 | 10:22:39 INFO - PID 23916 | Cycle 1(1): loaded http://localhost:33464/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33464/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:22:40 INFO - PID 23916 | RSS: Main: 220807168 10:22:40 INFO - PID 23916 | 10:22:42 INFO - PID 23916 | Cycle 1(1): loaded http://localhost:33464/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33464/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:22:43 INFO - PID 23916 | RSS: Main: 220733440 10:22:43 INFO - PID 23916 | 10:22:46 INFO - PID 23916 | Cycle 1(1): loaded http://localhost:33464/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33464/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:22:47 INFO - PID 23916 | RSS: Main: 220561408 10:22:47 INFO - PID 23916 | 10:22:49 INFO - PID 23916 | Cycle 1(1): loaded http://localhost:33464/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33464/tests/kraken/driver.html?testName=ai-astar) 10:22:49 INFO - PID 23916 | RSS: Main: 222486528 10:22:49 INFO - PID 23916 | 10:22:49 INFO - PID 23916 | __start_tp_report 10:22:49 INFO - PID 23916 | _x_x_mozilla_page_load 10:22:49 INFO - PID 23916 | _x_x_mozilla_page_load_details 10:22:49 INFO - PID 23916 | |i|pagename|runs| 10:22:49 INFO - PID 23916 | |0;ai-astar;120;117;109;108;114;110;108;112;117;116 10:22:49 INFO - PID 23916 | |1;audio-beat-detection;123;128;118;116;116;121;127;145;124;121 10:22:49 INFO - PID 23916 | |2;audio-dft;165;170;170;165;170;170;171;173;168;167 10:22:49 INFO - PID 23916 | |3;audio-fft;78;77;80;76;82;78;82;80;74;82 10:22:49 INFO - PID 23916 | |4;audio-oscillator;84;81;80;84;78;88;83;82;78;79 10:22:49 INFO - PID 23916 | |5;imaging-gaussian-blur;119;119;116;115;115;115;115;114;116;120 10:22:49 INFO - PID 23916 | |6;imaging-darkroom;149;148;149;148;150;149;150;154;149;151 10:22:49 INFO - PID 23916 | |7;imaging-desaturate;96;94;95;95;95;94;94;97;97;102 10:22:49 INFO - PID 23916 | |8;json-parse-financial;53;54;58;54;53;56;55;51;52;51 10:22:49 INFO - PID 23916 | |9;json-stringify-tinderbox;43;39;45;44;41;44;39;39;48;39 10:22:49 INFO - PID 23916 | |10;stanford-crypto-aes;79;78;85;75;77;85;74;81;77;75 10:22:49 INFO - PID 23916 | |11;stanford-crypto-ccm;119;127;115;121;120;117;116;119;118;122 10:22:49 INFO - PID 23916 | |12;stanford-crypto-pbkdf2;176;169;170;180;171;173;168;179;180;180 10:22:49 INFO - PID 23916 | |13;stanford-crypto-sha256-iterative;72;69;67;65;67;68;74;65;67;68 10:22:49 INFO - PID 23916 | __end_tp_report 10:22:49 INFO - PID 23916 | __start_cc_report 10:22:49 INFO - PID 23916 | _x_x_mozilla_cycle_collect,947 10:22:49 INFO - PID 23916 | __end_cc_report 10:22:49 INFO - PID 23916 | __startTimestamp1505409769366__endTimestamp 10:22:49 INFO - PID 23916 | 10:22:49 INFO - PID 23916 | ------- Summary: start ------- 10:22:49 INFO - PID 23916 | Number of tests: 14 10:22:49 INFO - PID 23916 | 10:22:49 INFO - PID 23916 | [#0] ai-astar Cycles:10 Average:113.10 Median:115.00 stddev:4.31 (3.7%) stddev-sans-first:3.77 10:22:49 INFO - PID 23916 | Values: 120.0 117.0 109.0 108.0 114.0 110.0 108.0 112.0 117.0 116.0 10:22:49 INFO - PID 23916 | 10:22:49 INFO - PID 23916 | [#1] audio-beat-detection Cycles:10 Average:123.90 Median:123.50 stddev:8.49 (6.9%) stddev-sans-first:9.00 10:22:49 INFO - PID 23916 | Values: 123.0 128.0 118.0 116.0 116.0 121.0 127.0 145.0 124.0 121.0 10:22:49 INFO - PID 23916 | 10:22:49 INFO - PID 23916 | [#2] audio-dft Cycles:10 Average:168.90 Median:170.00 stddev:2.60 (1.5%) stddev-sans-first:2.35 10:22:49 INFO - PID 23916 | Values: 165.0 170.0 170.0 165.0 170.0 170.0 171.0 173.0 168.0 167.0 10:22:49 INFO - PID 23916 | 10:22:49 INFO - PID 23916 | [#3] audio-fft Cycles:10 Average:78.90 Median:80.00 stddev:2.77 (3.5%) stddev-sans-first:2.92 10:22:49 INFO - PID 23916 | Values: 78.0 77.0 80.0 76.0 82.0 78.0 82.0 80.0 74.0 82.0 10:22:49 INFO - PID 23916 | 10:22:49 INFO - PID 23916 | [#4] audio-oscillator Cycles:10 Average:81.70 Median:82.50 stddev:3.16 (3.8%) stddev-sans-first:3.24 10:22:49 INFO - PID 23916 | Values: 84.0 81.0 80.0 84.0 78.0 88.0 83.0 82.0 78.0 79.0 10:22:49 INFO - PID 23916 | 10:22:49 INFO - PID 23916 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.00 stddev:2.12 (1.8%) stddev-sans-first:2.03 10:22:49 INFO - PID 23916 | Values: 119.0 119.0 116.0 115.0 115.0 115.0 115.0 114.0 116.0 120.0 10:22:49 INFO - PID 23916 | 10:22:49 INFO - PID 23916 | [#6] imaging-darkroom Cycles:10 Average:149.70 Median:149.50 stddev:1.77 (1.2%) stddev-sans-first:1.86 10:22:49 INFO - PID 23916 | Values: 149.0 148.0 149.0 148.0 150.0 149.0 150.0 154.0 149.0 151.0 10:22:49 INFO - PID 23916 | 10:22:49 INFO - PID 23916 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:95.00 stddev:2.42 (2.6%) stddev-sans-first:2.57 10:22:49 INFO - PID 23916 | Values: 96.0 94.0 95.0 95.0 95.0 94.0 94.0 97.0 97.0 102.0 10:22:49 INFO - PID 23916 | 10:22:49 INFO - PID 23916 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:2.21 (4.1%) stddev-sans-first:2.33 10:22:49 INFO - PID 23916 | Values: 53.0 54.0 58.0 54.0 53.0 56.0 55.0 51.0 52.0 51.0 10:22:49 INFO - PID 23916 | 10:22:49 INFO - PID 23916 | [#9] json-stringify-tinderbox Cycles:10 Average:42.10 Median:43.50 stddev:3.18 (7.3%) stddev-sans-first:3.35 10:22:49 INFO - PID 23916 | Values: 43.0 39.0 45.0 44.0 41.0 44.0 39.0 39.0 48.0 39.0 10:22:49 INFO - PID 23916 | 10:22:49 INFO - PID 23916 | [#10] stanford-crypto-aes Cycles:10 Average:78.60 Median:78.50 stddev:3.95 (5.0%) stddev-sans-first:4.19 10:22:49 INFO - PID 23916 | Values: 79.0 78.0 85.0 75.0 77.0 85.0 74.0 81.0 77.0 75.0 10:22:49 INFO - PID 23916 | 10:22:49 INFO - PID 23916 | [#11] stanford-crypto-ccm Cycles:10 Average:119.40 Median:119.50 stddev:3.44 (2.9%) stddev-sans-first:3.64 10:22:49 INFO - PID 23916 | Values: 119.0 127.0 115.0 121.0 120.0 117.0 116.0 119.0 118.0 122.0 10:22:49 INFO - PID 23916 | 10:22:49 INFO - PID 23916 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.60 Median:177.50 stddev:4.95 (2.8%) stddev-sans-first:5.22 10:22:49 INFO - PID 23916 | Values: 176.0 169.0 170.0 180.0 171.0 173.0 168.0 179.0 180.0 180.0 10:22:49 INFO - PID 23916 | 10:22:49 INFO - PID 23916 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:2.86 (4.2%) stddev-sans-first:2.68 10:22:49 INFO - PID 23916 | Values: 72.0 69.0 67.0 65.0 67.0 68.0 74.0 65.0 67.0 68.0 10:22:49 INFO - PID 23916 | -------- Summary: end -------- 10:22:49 INFO - PID 23916 | 10:22:50 INFO - PID 23916 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 10:22:50 INFO - TEST-INFO | 23916: exit 0 10:22:50 INFO - TEST-OK | kraken | took 64992ms 10:22:50 INFO - SUITE-END | took 1178s 10:22:51 INFO - Completed test suite (00:19:39) 10:22:51 INFO - javascript benchmark 10:22:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8456.944561234668, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3118.9532157017643, 3159.573457583227, 3195.105370496262, 3198.6801319868, 3202.023382868226, 6113.296970848353, 6287.811365659032, 6333.271673757519, 6381.1066450696935, 6409.807705768822, 6215.56491045627, 6240.4695600873865, 6343.873122537547, 6410.871782564346, 6415.743370265195, 5711.343195532525, 5762.135679648044, 5806.535477161817, 5818.505427038707, 5885.911711324334, 5804.071348584227, 5804.390538993408, 5806.332271788756, 5893.64638121712, 5926.081457374093, 5626.915596266059, 5667.206591077232, 5713.771449142029, 5795.710214489259, 5827.096799996008, 5805.912911306334, 5839.591228613998, 5843.649381037151, 5845.5908086433965, 5847.970760146214, 5679.432056794329, 5741.45456181662, 5761.423857614247, 5821.446962538552, 5849.532037436995, 6115.327313995457, 6183.258009038944, 6246.344133865924, 6360.9045864312075, 6410.038494225903, 6644.501662375341, 6650.334966503311, 6779.898301525481, 6782.864342713118, 6837.1111755471475, 6774.593524388503, 6818.931810681879, 6864.5881247125335, 6906.447484201251, 6925.653717314164, 6166.7533298667995, 6296.118543403927, 6317.368263173692, 6334.1765570476, 6415.775447859349, 6864.073350097673, 6919.308069193141, 6921.307869213038, 6926.896096558556, 6940.514164008572, 6519.8696026079215, 6525.314841941623, 6577.2436169841085, 6581.967090164614, 6625.17185351831, 6606.966965165239, 6689.665516724144, 6695.363940425652, 6850.691718872663, 6856.931430685729, 6705.865882682417, 6759.763408280686, 6806.319368063253, 6829.624370659562, 6837.3162683731225, 6688.765893193812, 6785.185777706608, 6816.386525212754, 6860.931390686129, 6864.279250678706, 5140.357455318085, 5148.150555158357, 5160.303359046556, 5241.318628578337, 5292.52367286946, 4543.34121552373, 4565.680402371869, 4566.954330456653, 4652.6975746577045, 4688.718676879398, 5829.387914269026, 5904.645721256652, 5911.940880591225, 5937.70311484424, 5946.554008449383, 6713.925771876477, 6806.387425131663, 6882.724691012403, 6887.621180835002, 6905.067815844897, 5638.520725738358, 5790.739416726257, 5815.9709201453725, 5880.470757631833, 5905.173275741399, 5730.5129064030025, 5736.426357364314, 5768.769249229984, 5775.740091695884, 5800.53595712342, 6522.804315870437, 6536.901946470807, 6546.738130474823, 6555.704993275314, 6582.670866456658, 6758.986152077227, 6875.381215690411, 6918.135233095863, 6928.515003949675, 6932.584044957319, 6563.737450501926, 6619.735210591522, 6624.867502650017, 6699.799006029827, 6729.427998620172, 6535.901961470487, 6615.106960560455, 6715.26132125456, 6751.797446076625, 6813.3527314905, 6717.05961165447, 6806.149231346082, 6837.62393068386, 6872.037914692047, 6889.138857642794, 6585.934140658724, 6639.203295604365, 6656.068150459037, 6670.366315200048, 6671.099401580725, 6548.738050477928, 6607.273199948098, 6680.766173183915, 6681.33186681328, 6695.933040669531, 6227.564070515202, 6508.153939987771, 6522.641254731036, 6608.074869518176, 6616.867662646624, 6539.346065393613, 6575.0, 6631.734730610914, 6649.0691303218555, 6697.2633010367845, 6435.871282574416, 6450.290468048417, 6492.675366231575, 6506.60960342381, 6526.379993900572], "value": 6163.715369313481, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [801.4189712458472, 842.852500812358, 843.3084870406267, 849.8257857139283, 866.3285953386124, 39145.80427097864, 39650.20699586006, 39719.0, 39809.601903980954, 39860.60139398605, 36579.26841463169, 39266.21467570647, 39993.200135997264, 40247.798761006154, 40287.19425611486, 7482.738104166356, 7605.657745401442, 7615.238476152396, 7621.733239336624, 7649.0, 7450.18048014718, 7528.623568821565, 7543.132539757943, 7560.810979725496, 7590.506617069873, 7588.696452141935, 7597.924020759805, 7624.313811756941, 7664.50180738253, 7682.539047657158, 7507.136679281898, 7531.133919599207, 7581.658825352844, 7582.090149182106, 7627.580483073429, 7511.173770885198, 7515.098188217395, 7542.69829206831, 7623.161452240249, 7628.504147230412, 36641.63358366409, 37023.62976370229, 37098.443523347174, 37214.8139259302, 37344.626553734386, 3359.8320083995704, 3391.16916355492, 3393.8133402662843, 3395.2700169463683, 3423.400904841668, 30920.845395772878, 31133.532997005062, 31224.063278101694, 31242.687573124433, 31272.21819454509, 4990.750462476862, 5178.844634660966, 5188.143956247215, 5198.2722418861385, 5289.0744119779265, 182600.0, 182910.0854495719, 182938.0, 183249.08375458038, 183638.0, 45641.31538026932, 45756.77121614437, 45770.771146144056, 45907.770461147484, 45914.540854591025, 47421.051578968225, 47654.28518572224, 47931.5206847934, 48178.518214818105, 51332.74333628383, 15646.608834778994, 15944.601384965237, 15985.12081835487, 16014.519564413085, 16020.439284624983, 13078.476860925646, 13137.34313284332, 13213.405396757169, 13239.20564766117, 13258.933705331605, 14041.227732474608, 14057.0, 14064.71870562583, 14121.152730836182, 14271.357788899524, 5554.805581804618, 5659.462351076641, 5695.288088988877, 5701.942980570224, 5711.485966263056, 996.3175224970773, 996.9252306077074, 998.5257002923553, 1003.1874181912674, 1022.2384323678758, 22596.548069038858, 22779.430514236945, 22796.544069118525, 22860.542789144125, 23113.0, 1080.783843231357, 1085.6905781852133, 1101.8787933327328, 1102.9448527573588, 1110.8056090184186, 12069.879301207051, 12091.153619246745, 12135.271883687006, 12138.716769937966, 12174.0, 217886.0, 219917.0, 220502.0, 220831.0, 221155.0, 42946.78526607347, 43302.0, 44141.33787993182, 49556.50443495591, 49977.50022499801, 1385.2035079829138, 1390.8191935048378, 1402.726468338664, 1410.8377536583218, 1419.4818891104878, 26349.736502635496, 26531.86734066317, 26603.0, 26831.86584067067, 27155.86422067877, 34212.82893585516, 34298.65701342955, 34410.31179376348, 34456.82771586126, 34473.138171545914, 177550.0, 178341.1082944629, 178357.0, 178443.0, 179163.0, 32979.83510082434, 33128.83435582807, 33132.33735325328, 33337.666623333454, 33365.33173341275, 40082.1983560333, 40263.396049058705, 41600.167996640506, 41716.374254386814, 42424.78787606042, 28994.0, 30094.0, 30237.092887213417, 30400.5439918397, 30835.0, 29784.0, 29936.85031574828, 30458.086257412313, 30565.694343056286, 30717.385652286383, 34380.48429273513, 34453.82773086119, 34463.310733785685, 34554.0, 34796.0, 29694.0, 29860.253493662833, 30465.695343046285, 30479.390412192075, 30653.846730766203, 22392.77607223907, 22830.716928307036, 22999.6550051746, 23027.963741632, 23334.416639583465], "value": 16660.898749800413, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [528.6537318056672, 536.6243629459375, 542.9701366424845, 553.3967974907351, 580.3471095018105, 22006.559868802633, 22857.54284914303, 22880.084796608156, 22921.885390573065, 22962.311130666065, 23932.162374316904, 24299.51400971984, 24326.0, 24335.0, 24382.75617243827, 6030.547708921827, 6502.252240992276, 6557.606543607375, 6584.868302633944, 6590.0, 6469.0, 6503.154589903306, 6536.607803531803, 6548.574342667735, 6568.835779105537, 6319.210098737658, 6446.838829029265, 6451.80644580661, 6451.806445806634, 6459.741610335581, 6515.0, 6558.967205163991, 6566.63883486408, 6580.276169621337, 6618.801435956929, 6074.48366888815, 6087.786927457562, 6098.786542471036, 6129.570930034899, 6135.478484328837, 26409.73590264092, 27494.725052749418, 27514.44971100587, 27520.44959100827, 27644.861775691195, 1998.5902889907534, 2030.2589554812387, 2039.0824129141945, 2039.2862498125685, 2048.621005114059, 19003.144858481264, 19198.424047278604, 19364.70952935707, 19419.126139323766, 19433.0, 2396.065534441552, 2435.1233555919853, 2467.4818288159327, 2490.5392502386935, 2522.6846644169477, 114082.0, 117931.41034294774, 138620.0, 139647.0, 142688.28655856758, 19397.90301048514, 19609.411717648494, 20481.51814191591, 20775.545711800332, 21694.13223471075, 39046.02384940343, 39158.084191580616, 39309.213815723524, 39310.410343844866, 39371.80314098411, 11628.18602697803, 11669.941650291694, 11685.76628467443, 11698.590549330733, 11832.230904991147, 9624.470654113951, 9646.807063858683, 9797.412155270707, 9815.312928095107, 9891.307608467338, 10742.94628526868, 10819.729506762395, 11272.380019098864, 11274.830877536844, 11367.261128026652, 3959.821808018646, 4215.78921053946, 4226.725262857904, 4256.61690447855, 4330.848420305274, 951.6526467839188, 961.4808003678075, 964.9758756031156, 974.8050389922043, 982.9557669904872, 19229.90385048066, 19354.903225483784, 19435.0, 19485.0, 19745.901270493556, 1002.7994401119805, 1004.4826914139225, 1022.5909636145601, 1030.3663247102977, 1030.4229631406436, 10405.32365396262, 10644.414557199429, 10681.198910081775, 10749.946250268855, 10962.561497540168, 457391.0, 467911.0, 476686.0, 479962.0, 487055.0, 107389.0, 109132.0, 110289.44855275672, 111996.0, 114372.42813785878, 1129.8870112988636, 1132.9830052549053, 1154.261272785418, 1157.085902137319, 1163.906887449002, 16710.407262438635, 16844.07357595295, 17247.36150065742, 17545.0, 17595.29618815233, 54616.72691636675, 55368.44631553794, 56965.71517142388, 57145.71427143004, 57721.4227857716, 69509.65245173742, 70556.6472167636, 70816.29183708096, 71026.64486677533, 71837.28162718515, 19393.8060619392, 19625.411237662895, 19762.011899404686, 19777.70333445028, 19819.900900495406, 22017.66973495431, 22078.0, 22144.2249521266, 22575.661365079864, 22678.092876284765, 17720.468385948443, 17775.46673599794, 17782.466526004242, 17811.910940445214, 18216.635667286846, 14793.0, 14958.476453324081, 15848.207589620704, 16144.0, 16712.582185444975, 17829.910850445664, 17974.0, 17994.0, 18273.634527309645, 18330.175142118904, 18494.537636559195, 18868.811311886704, 18869.339573114874, 19075.04624768784, 19171.137298821865, 16617.169141542632, 16731.163441828103, 16792.412265570645, 16877.831221687626, 16903.070331131414], "value": 12475.55673771886, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1316.3089378076509, 1348.5954213735877, 1371.8971077169213, 1384.259421209653, 1386.993065034676, 12707.745845083093, 13174.934125329371, 13218.20690758554, 15174.165420901845, 15759.0, 15495.690086198298, 15711.0, 15713.371465141381, 15783.605409864758, 15792.763108553381, 2672.425428532865, 2732.7130651281527, 2734.5487994480886, 2745.6567929008875, 2748.862556872158, 2637.617545455908, 2725.822821516595, 2726.209399274218, 2728.1269993602054, 2736.712645172258, 2628.68455785306, 2703.7972152088573, 2704.323919020245, 2709.3903871628922, 2712.7829773618164, 2577.407196344842, 2588.728183540739, 2598.233521111277, 2602.05025165815, 2602.167306461933, 2543.046357615894, 2551.3366524703524, 2572.562664347047, 2575.36903458652, 2581.4966081614093, 14903.180325082116, 14922.104673719612, 14968.775468367983, 15015.399384024735, 15048.548543543711, 7676.1172465166665, 7913.920860791433, 8003.319717823992, 8007.399445041587, 8017.95991020047, 5032.6477146599755, 5182.792688292501, 5262.289590905217, 5339.359276886759, 5554.055810512182, 1882.4540883143873, 1891.933782317626, 1908.7232351308983, 1936.2738972885168, 1944.8735832170864, 27090.322741931413, 27104.96712746552, 27171.592426113624, 27174.728252717614, 27192.32019199516, 6870.587764734132, 7141.500094993301, 7202.819929501699, 7349.55902645843, 7386.113666360071, 19889.900550497154, 19918.103685334194, 19977.101030453665, 19986.800131998785, 20035.198592056448, 7985.121636619967, 7993.160718124514, 8033.879491807627, 8059.758207253792, 8077.434579579373, 5839.445252700986, 6055.0, 6247.875042499125, 6322.399372059647, 7223.783286501413, 5545.195946587723, 5702.54379649627, 5704.429557044263, 5739.139129130664, 5788.102844059177, 1759.9208035638428, 1763.1008185825322, 1779.5640068183377, 1798.9460316190534, 1816.5731053202487, 851.5231470376609, 864.2955990867423, 867.7613656244457, 875.2691502595404, 883.3904605821963, 8113.553754543439, 8185.713500027589, 8294.336453083859, 8300.543470109202, 8303.792405189797, 702.9261927497641, 721.4372789224414, 721.7221369772675, 721.72935149319, 728.9817754556178, 4311.223979683625, 4324.135172965357, 4364.978175109168, 4402.669799765031, 4406.801693923781, 21258.468538286357, 21821.454463638536, 21880.562388752453, 21979.670304945437, 22099.33701988943, 20472.18111275562, 20635.03967123121, 21147.365579032652, 21422.143114275255, 21490.78509214888, 11302.773944521228, 11352.0, 11411.25826821254, 11427.714307142389, 11460.59887903936, 8057.798555036171, 8145.104038555635, 8175.754727358189, 8180.304674102768, 8207.95896020516, 17678.46964591064, 17886.28454861791, 18062.5484362892, 18079.36722214716, 18341.81658183401, 18375.816241837412, 18837.587180961757, 19071.618567628848, 19161.80838191656, 19256.22975081037, 11724.120690948042, 11956.76086478283, 12205.633830985085, 12231.633051008484, 12244.75510489803, 13923.164610123426, 13994.090384125, 14047.0, 14059.859401405854, 14075.929620351833, 11357.54569817198, 11431.885681143081, 11539.942300288445, 11574.768504630028, 11609.0, 10505.894941050492, 10511.0, 10594.735131621463, 10643.94678026605, 10789.460526973777, 10123.190144788547, 10148.695539133838, 10211.285210035227, 10226.795464090825, 10241.129503992244, 6766.255711871591, 6838.350356716104, 6840.794776156723, 6996.265392133752, 7037.0, 6743.12339395895, 6913.654317284015, 6966.616836073862, 6986.685599147949, 7075.433965282662], "value": 6597.776154809606, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [489.7500273936057, 505.5616770288529, 517.2189993110404, 523.1942808075564, 523.4529916237532, 6128.662923539204, 6246.84382890428, 6274.2470903491585, 6289.836380269653, 6327.6519791411565, 6058.818235452944, 6229.0, 6242.438180563749, 6264.530160237978, 6299.464545513637, 5148.433672296044, 5172.301739265207, 5204.866004937976, 5217.5565076968505, 5228.0, 5137.845864624049, 5195.818146364878, 5197.740112994354, 5206.167013277876, 5221.686698798066, 4760.690555113923, 4910.459849416561, 4918.262260660894, 5063.41770696371, 5068.8225912093085, 4901.828436004723, 4916.877078073059, 4924.852254432372, 4931.630127740415, 4967.577755890754, 4390.736555806629, 4399.702087884082, 4408.955910440886, 4414.4923333816705, 4434.445694288214, 5835.387284335126, 5965.4929331006915, 5968.7612495500125, 6048.39516048396, 6095.390460953913, 5571.66570005801, 5583.664980101207, 5600.831975040755, 5637.915431268534, 5673.23411339468, 6414.807555773287, 6449.226092868839, 6496.5127615428555, 6520.347965203489, 6523.347665233486, 4539.9104214988165, 4722.992728090548, 4810.2063159578975, 4837.201861692816, 4838.830640927551, 6484.448821850101, 6518.57629254097, 6615.702293396808, 6641.335866413368, 6772.796816095426, 4837.298591704183, 4894.902101957941, 4914.311996320518, 4952.925706114411, 4992.975035124874, 5006.774695138727, 5031.396232452129, 5041.193409054534, 5054.292399064134, 5056.570191533688, 5562.582806289544, 5605.691686957175, 5609.943900561024, 5619.381867994517, 5664.631798933056, 6428.357164283628, 6440.742370305135, 6479.125318082093, 6489.1888513935755, 6504.317046710122, 1694.4916525042684, 1694.7796786417932, 1696.380821000326, 1716.0, 1722.776828451788, 858.6393714639867, 1189.1794661683412, 1205.6081773423498, 1208.4380762945098, 1236.7093732972744, 5539.778408863681, 5566.304211973504, 5595.796903665731, 5611.6352437091455, 5628.97185514078, 6387.552871298964, 6434.0, 6463.2244130703675, 6466.288708242089, 6522.249941256816, 5525.254090697785, 5550.694711790809, 5575.637583557056, 5599.132134519156, 5624.465675760796, 3490.5636795400574, 3507.649235076472, 3508.561429821272, 3536.257385948928, 3537.7700449470703, 6230.408111229426, 6237.781677641261, 6238.937610623926, 6427.935720642734, 6438.45273151778, 6676.631290585418, 6676.699548520328, 6715.127033485615, 6771.327783829142, 6795.830104247433, 6391.872162556723, 6460.450861676716, 6460.967695161494, 6469.377148796689, 6474.2414325470745, 6486.870262594816, 6517.989711594711, 6617.900731488935, 6636.170478690164, 6640.90038649411, 6490.51321150925, 6536.8365790855605, 6563.914959968807, 6573.96713016451, 6597.208334999831, 6327.525435592257, 6392.68036598159, 6428.0, 6462.676866156768, 6463.1903067141275, 4301.333293339538, 4783.4738178801, 4791.736454495036, 4881.365422495053, 4889.975550122369, 6240.594361366497, 6344.714487847966, 6430.967845160744, 6543.1821022372205, 6546.934530654823, 6241.188645476241, 6389.581573857964, 6432.678366081584, 6466.0, 6496.610203387811, 6306.873862522815, 6382.234131904202, 6409.166808314889, 6433.163688720437, 6499.610023398611, 6381.0, 6390.712417941111, 6417.48660107181, 6431.646259455775, 6442.774502892376, 6331.6517591531065, 6411.0, 6486.513511486752, 6508.349165083454, 6529.412352888263, 6200.286966998853, 6262.3404797729545, 6293.307736149111, 6328.835582208895, 6335.683215839282], "value": 4973.114535560455, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [895.2390468102112, 900.7522931193917, 934.3646320502061, 934.69155178791, 944.914957653811, 19179.904100479496, 19945.202191912325, 20023.098960546773, 20262.594748105028, 20278.087486063127, 18565.721514177298, 18707.812921870776, 18969.33607323744, 19135.182157694995, 19404.708929366072, 931.6552875436098, 933.9533023348805, 939.6570251858091, 940.0458534587399, 941.5998200764648, 959.4387283439196, 960.9759756006121, 962.4610218277752, 964.8938616752151, 969.1955676788249, 980.8234517786796, 1018.2668478695327, 1024.2778840917172, 1024.9385036897772, 1025.1132770153838, 1005.969820905374, 1016.6441745389054, 1021.4484178543578, 1022.6318525330875, 1022.8465730140501, 715.957042577447, 726.7928640337478, 739.2828955912756, 740.2745309596571, 747.5626758346374, 19963.401097967086, 20221.090050947743, 20263.189472421087, 20264.088116034814, 20293.289734859358, 20928.162873485042, 21079.68380474294, 22011.11955521777, 22064.669029964403, 22175.223867164732, 16895.662086758195, 17107.657846842994, 17401.47795566135, 17463.47609571715, 17608.295668173258, 3681.834317455721, 3693.279810436966, 3711.6288371162937, 3726.105734623698, 3737.719671024684, 144196.0, 144402.27798861044, 146419.0, 147583.0, 148035.0, 16193.59516012109, 16727.247273872705, 16747.748783768253, 16823.915880420518, 16845.241964111643, 29808.40383192324, 30359.241018974702, 30956.380872382877, 31131.68868311333, 31192.688073119432, 8932.062133476022, 8987.41581797181, 9016.0, 9031.548422578844, 9113.179813816789, 4309.8363441870515, 4426.313921342197, 4427.800748966304, 4486.977565112154, 4527.59251667345, 5229.555487783505, 5301.125314323171, 5334.333208348957, 5349.384820745586, 5352.0, 921.3964853021282, 923.810618823153, 934.5841100710255, 942.1285311087217, 950.5674917912334, 668.3416834418094, 681.9420349270268, 690.4028015766326, 694.1358009278481, 695.5166159519085, 10844.13246940243, 11034.117270618332, 11462.598809041643, 11638.0, 12050.337231452178, 695.2213520856673, 698.849747304332, 710.2932582080863, 710.9751158709524, 712.7220384050224, 5148.9742551287, 5153.484651534816, 5208.401033881077, 5273.868153296198, 5306.867328316745, 118904.0, 121716.0, 122814.15778763326, 124235.37882310711, 125684.37157814152, 109621.45189274162, 112623.43688281506, 112691.0, 114412.0, 116111.0, 95667.0, 96355.0, 98687.50656246673, 98718.0, 99126.50436747626, 9476.526173691425, 9556.23550116003, 9610.423374597267, 9798.118169364792, 9811.656592019244, 45059.32411013903, 45278.0, 46583.0, 47500.28749568828, 48141.5185848151, 57999.84000319886, 60087.39912600818, 60253.0, 60824.0, 60842.391576083675, 15150.393984240507, 15156.696866062837, 15167.16580588034, 15238.3904643813, 15321.157336346161, 15287.235638217822, 15344.386224550894, 15351.385944562093, 15363.692726145191, 15427.5371738848, 13428.462861485432, 13594.184348939096, 13604.183748975092, 13655.726885462434, 13762.0, 13342.26617536006, 13567.321633918462, 13598.93200533991, 13699.794503082263, 13859.30703464843, 12915.418806153933, 12992.740145197233, 13056.477740890257, 13059.759322864313, 13264.403101860247, 10297.07326340633, 10352.844707329245, 10418.479076046318, 10576.576936922436, 10606.469676516297, 10672.62645807393, 10707.732306692084, 10709.143268538342, 10840.620578279722, 10962.287451315638], "value": 8702.171886522852, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1465.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 117.0, 109.0, 108.0, 114.0, 110.0, 108.0, 112.0, 117.0, 116.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 128.0, 118.0, 116.0, 116.0, 121.0, 127.0, 145.0, 124.0, 121.0], "value": 123.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 170.0, 170.0, 165.0, 170.0, 170.0, 171.0, 173.0, 168.0, 167.0], "value": 168.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 80.0, 76.0, 82.0, 78.0, 82.0, 80.0, 74.0, 82.0], "value": 78.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 80.0, 84.0, 78.0, 88.0, 83.0, 82.0, 78.0, 79.0], "value": 81.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 116.0, 115.0, 115.0, 115.0, 115.0, 114.0, 116.0, 120.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 149.0, 148.0, 150.0, 149.0, 150.0, 154.0, 149.0, 151.0], "value": 149.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 97.0, 97.0, 102.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 58.0, 54.0, 53.0, 56.0, 55.0, 51.0, 52.0, 51.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 39.0, 45.0, 44.0, 41.0, 44.0, 39.0, 39.0, 48.0, 39.0], "value": 42.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 85.0, 75.0, 77.0, 85.0, 74.0, 81.0, 77.0, 75.0], "value": 78.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 127.0, 115.0, 121.0, 120.0, 117.0, 116.0, 119.0, 118.0, 122.0], "value": 119.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 169.0, 170.0, 180.0, 171.0, 173.0, 168.0, 179.0, 180.0, 180.0], "value": 174.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 69.0, 67.0, 65.0, 67.0, 68.0, 74.0, 65.0, 67.0, 68.0], "value": 68.2, "unit": "score"}]}]} 10:22:51 INFO - Return code: 0 10:22:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:22:51 INFO - # TBPL SUCCESS # 10:22:51 INFO - Running post-action listener: _package_coverage_data 10:22:51 INFO - Running post-action listener: _resource_record_post_action 10:22:51 INFO - [mozharness: 2017-09-14 17:22:51.144883Z] Finished run-tests step (success) 10:22:51 INFO - Running post-run listener: _resource_record_post_run 10:22:51 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 8192; Write bytes: 348217344; Read time: 360; Write time: 374104 10:22:51 INFO - TinderboxPrint: CPU usage
13.3% 10:22:51 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 360 10:22:51 INFO - TinderboxPrint: I/O write bytes / time
348,217,344 / 374,104 10:22:51 INFO - TinderboxPrint: CPU idle
8,269.8 (86.7%) 10:22:51 INFO - TinderboxPrint: CPU user
1,203.3 (12.6%) 10:22:51 INFO - TinderboxPrint: Swap in / out
0 / 0 10:22:51 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 12980224; Read time: 0; Write time: 2640 10:22:51 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:51 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 334823424; Read time: 348; Write time: 371444 10:22:51 INFO - Running post-run listener: _upload_blobber_files 10:22:51 INFO - Blob upload gear active. 10:22:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:22:51 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:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:22:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:22:52 INFO - (blobuploader) - INFO - Open directory for files ... 10:22:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:22:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:23:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:23:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:23:00 INFO - (blobuploader) - INFO - Done attempting. 10:23:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:23:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:23:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:23:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:23:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:23:01 INFO - (blobuploader) - INFO - Done attempting. 10:23:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:23:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:23:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:23:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:23:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:23:02 INFO - (blobuploader) - INFO - Done attempting. 10:23:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:23:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:23:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:23:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:23:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:23:03 INFO - (blobuploader) - INFO - Done attempting. 10:23:03 INFO - (blobuploader) - INFO - Iteration through files over. 10:23:03 INFO - Return code: 0 10:23:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:23:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:23:03 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca32404b9bfff844000ce47baccf904b2aa1ad1afcd40d6f2a1361d19d1ed4a34959eb6ca1c386deb15a655527c83fb1383b12051c8ab9f2b29546ecdb9e11cf", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1810d952b59fb0fda640c3c0648492e8d030d2325f2c49054078dccde192e0f03f00f5ad79cf49188c1f1469cf69a2adafb17085d9c40ffe30d49088ae4ee166", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cb76ca850f66589a4c95d8649d6590dd3a743bf53b3a2df83f5189503e007bea4fe73ff372cfd7d15a999c0ba12ab2fdd917b7b1171caeeb7d31fb1f68865d5", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f1f368e7eb40e3d7c3cec28cc06a2f070bedd59ac9b42bfb523d3ce8bbd5432bf5dd4f9344973cef3c92b8cfc14c2a379156b56468940c10e827a30a29f6bd7"} 10:23:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:23:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:23:03 INFO - Contents: 10:23:03 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca32404b9bfff844000ce47baccf904b2aa1ad1afcd40d6f2a1361d19d1ed4a34959eb6ca1c386deb15a655527c83fb1383b12051c8ab9f2b29546ecdb9e11cf", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1810d952b59fb0fda640c3c0648492e8d030d2325f2c49054078dccde192e0f03f00f5ad79cf49188c1f1469cf69a2adafb17085d9c40ffe30d49088ae4ee166", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cb76ca850f66589a4c95d8649d6590dd3a743bf53b3a2df83f5189503e007bea4fe73ff372cfd7d15a999c0ba12ab2fdd917b7b1171caeeb7d31fb1f68865d5", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f1f368e7eb40e3d7c3cec28cc06a2f070bedd59ac9b42bfb523d3ce8bbd5432bf5dd4f9344973cef3c92b8cfc14c2a379156b56468940c10e827a30a29f6bd7"} 10:23:03 INFO - Running post-run listener: copy_logs_to_upload_dir 10:23:03 INFO - Copying logs to upload dir... 10:23:03 INFO - mkdir: /builds/slave/test/build/upload/logs 10:23:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.825696 ========= master_lag: -0.80 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-09-14 10:23:03.205222) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 10:23:03.209218) ========= 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=af724c981e2a0f424dbabf99000001e7-1505405499.895789-329224352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca32404b9bfff844000ce47baccf904b2aa1ad1afcd40d6f2a1361d19d1ed4a34959eb6ca1c386deb15a655527c83fb1383b12051c8ab9f2b29546ecdb9e11cf", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1810d952b59fb0fda640c3c0648492e8d030d2325f2c49054078dccde192e0f03f00f5ad79cf49188c1f1469cf69a2adafb17085d9c40ffe30d49088ae4ee166", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cb76ca850f66589a4c95d8649d6590dd3a743bf53b3a2df83f5189503e007bea4fe73ff372cfd7d15a999c0ba12ab2fdd917b7b1171caeeb7d31fb1f68865d5", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f1f368e7eb40e3d7c3cec28cc06a2f070bedd59ac9b42bfb523d3ce8bbd5432bf5dd4f9344973cef3c92b8cfc14c2a379156b56468940c10e827a30a29f6bd7"} build_url:https://queue.taskcluster.net/v1/task/BNjUtbdcSLq2BeuKb0u3jA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011384 build_url: 'https://queue.taskcluster.net/v1/task/BNjUtbdcSLq2BeuKb0u3jA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca32404b9bfff844000ce47baccf904b2aa1ad1afcd40d6f2a1361d19d1ed4a34959eb6ca1c386deb15a655527c83fb1383b12051c8ab9f2b29546ecdb9e11cf", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1810d952b59fb0fda640c3c0648492e8d030d2325f2c49054078dccde192e0f03f00f5ad79cf49188c1f1469cf69a2adafb17085d9c40ffe30d49088ae4ee166", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cb76ca850f66589a4c95d8649d6590dd3a743bf53b3a2df83f5189503e007bea4fe73ff372cfd7d15a999c0ba12ab2fdd917b7b1171caeeb7d31fb1f68865d5", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f1f368e7eb40e3d7c3cec28cc06a2f070bedd59ac9b42bfb523d3ce8bbd5432bf5dd4f9344973cef3c92b8cfc14c2a379156b56468940c10e827a30a29f6bd7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 10:23:03.236756) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 10:23:03.237074) ========= 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=af724c981e2a0f424dbabf99000001e7-1505405499.895789-329224352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004860 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 10:23:03.290688) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 10:23:03.293019) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 10:23:03.293337) ========= ========= Total master_lag: -0.63 =========