builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-069 starttime: 1505499867.26 results: success (0) revision: 9071a20f3eaa804a439990b7596dbc16d52d1e20 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-15 11:24:27.258226) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-15 11:24:27.263456) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-15 11:24:27.263776) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-15 11:24:27.440594) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 11:24:27.440864) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1505496840.176425-926818285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-15 11:24:27-- 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% 39.0M=0s 2017-09-15 11:24:27 (39.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.381367 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 11:24:27.932441) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 11:24:27.932777) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1505496840.176425-926818285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019104 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 11:24:28.036922) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-09-15 11:24:28.037235) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9071a20f3eaa804a439990b7596dbc16d52d1e20 --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 9071a20f3eaa804a439990b7596dbc16d52d1e20 --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=05b19d94dfa9f3ce7b6e62cc000001f7-1505496840.176425-926818285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-15 11:24:28,140 truncating revision to first 12 chars 2017-09-15 11:24:28,140 Setting DEBUG logging. 2017-09-15 11:24:28,140 attempt 1/10 2017-09-15 11:24:28,140 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9071a20f3eaa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-15 11:24:28,509 attempt 1/10 2017-09-15 11:24:29,198 current task status: no status available at this point. state: STARTED 2017-09-15 11:24:29,199 sleeping for 10.00s (attempt 1/10) 2017-09-15 11:24:39,209 attempt 2/10 2017-09-15 11:24:39,517 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-09-15 11:24:39,731 unpacking tar archive at: mozilla-central-9071a20f3eaa/testing/mozharness/ program finished with exit code 0 elapsedTime=11.948384 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-09-15 11:24:40.025634) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-15 11:24:40.030309) ========= script_repo_revision: 9071a20f3eaa804a439990b7596dbc16d52d1e20 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-15 11:24:40.031009) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-15 11:24:40.031443) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-15 11:24:40.077708) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-09-15 11:24:40.078319) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=05b19d94dfa9f3ce7b6e62cc000001f7-1505496840.176425-926818285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:24:40 INFO - MultiFileLogger online at 20170915 11:24:40 in /builds/slave/test 11:24:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 11:24:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:24:40 INFO - {'append_to_log': False, 11:24:40 INFO - 'base_work_dir': '/builds/slave/test', 11:24:40 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 11:24:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:24:40 INFO - 'branch': 'Firefox-Non-PGO', 11:24:40 INFO - 'buildbot_json_path': 'buildprops.json', 11:24:40 INFO - 'code_coverage': False, 11:24:40 INFO - 'config_files': ('talos/linux_config.py',), 11:24:40 INFO - 'default_actions': ('clobber', 11:24:40 INFO - 'read-buildbot-config', 11:24:40 INFO - 'download-and-extract', 11:24:40 INFO - 'populate-webroot', 11:24:40 INFO - 'create-virtualenv', 11:24:40 INFO - 'install', 11:24:40 INFO - 'setup-mitmproxy', 11:24:40 INFO - 'run-tests'), 11:24:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:24:40 INFO - 'disable_ccov_upload': False, 11:24:40 INFO - 'disable_stylo': False, 11:24:40 INFO - 'download_minidump_stackwalk': True, 11:24:40 INFO - 'download_symbols': 'ondemand', 11:24:40 INFO - 'enable_stylo': False, 11:24:40 INFO - 'enable_webrender': False, 11:24:40 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:24:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:24:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:24:40 INFO - 'gecko_profile': False, 11:24:40 INFO - 'gecko_profile_interval': 0, 11:24:40 INFO - 'installer_path': 'installer.exe', 11:24:40 INFO - 'log_level': 'info', 11:24:40 INFO - 'log_name': 'talos', 11:24:40 INFO - 'log_to_console': True, 11:24:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:24:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:24:40 INFO - 'opt_config_files': (), 11:24:40 INFO - 'pip_index': False, 11:24:40 INFO - 'suite': 'dromaeojs-e10s', 11:24:40 INFO - 'system_bits': '32', 11:24:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:24:40 INFO - 'title': 'talos-linux64-ix-069', 11:24:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:24:40 INFO - 'use_talos_json': True, 11:24:40 INFO - 'verify': 'False', 11:24:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:24:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:24:40 INFO - 'work_dir': 'build'} 11:24:40 INFO - [mozharness: 2017-09-15 18:24:40.313975Z] Running clobber step. 11:24:40 INFO - Running pre-action listener: _resource_record_pre_action 11:24:40 INFO - Running main action method: clobber 11:24:40 INFO - rmtree: /builds/slave/test/build 11:24:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:24:41 INFO - Running post-action listener: _resource_record_post_action 11:24:41 INFO - [mozharness: 2017-09-15 18:24:41.305628Z] Finished clobber step (success) 11:24:41 INFO - [mozharness: 2017-09-15 18:24:41.305724Z] Running read-buildbot-config step. 11:24:41 INFO - Running pre-action listener: _resource_record_pre_action 11:24:41 INFO - Running main action method: read_buildbot_config 11:24:41 INFO - Using buildbot properties: 11:24:41 INFO - { 11:24:41 INFO - "project": "", 11:24:41 INFO - "product": "firefox", 11:24:41 INFO - "who": "ffxbld@noreply.mozilla.org", 11:24:41 INFO - "installer_path": "public/build/target.tar.bz2", 11:24:41 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:24:41 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:24:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 11:24:41 INFO - "stage_platform": "linux64", 11:24:41 INFO - "basedir": "/builds/slave/test", 11:24:41 INFO - "buildnumber": 828, 11:24:41 INFO - "platform": "ubuntu64_hw", 11:24:41 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:24:41 INFO - "slavebuilddir": "test", 11:24:41 INFO - "taskId": "VVmTPSgxSTqsdxqOOR2P7A", 11:24:41 INFO - "branch": "mozilla-central", 11:24:41 INFO - "script_repo_revision": "production", 11:24:41 INFO - "revision": "9071a20f3eaa804a439990b7596dbc16d52d1e20", 11:24:41 INFO - "slavename": "talos-linux64-ix-069", 11:24:41 INFO - "repo_path": "mozilla-central" 11:24:41 INFO - } 11:24:41 INFO - Finding installer, test and symbols from parent task. 11:24:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VVmTPSgxSTqsdxqOOR2P7A'}, attempt #1 11:24:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VVmTPSgxSTqsdxqOOR2P7A'}, attempt #1 11:24:42 INFO - Task dependencies: dGTWU5R0RMmqQFwWXFslJA 11:24:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA'}, attempt #1 11:24:42 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.tar.bz2 11:24:42 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.test_packages.json 11:24:42 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.crashreporter-symbols.zip 11:24:42 INFO - Running post-action listener: _resource_record_post_action 11:24:42 INFO - [mozharness: 2017-09-15 18:24:42.646180Z] Finished read-buildbot-config step (success) 11:24:42 INFO - [mozharness: 2017-09-15 18:24:42.646393Z] Running download-and-extract step. 11:24:42 INFO - Running pre-action listener: _resource_record_pre_action 11:24:42 INFO - Running main action method: download_and_extract 11:24:42 INFO - mkdir: /builds/slave/test/build/tests 11:24: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')]} 11:24:42 INFO - trying https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.test_packages.json 11:24:42 INFO - Downloading https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:24:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:24:43 INFO - Downloaded 989 bytes. 11:24:43 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:24:43 INFO - Using the following test package requirements: 11:24:43 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:24:43 INFO - u'common': [u'target.common.tests.zip'], 11:24:43 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:24:43 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:24:43 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:24:43 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:24:43 INFO - u'mozbase': [u'target.common.tests.zip'], 11:24:43 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:24:43 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:24:43 INFO - u'web-platform': [u'target.common.tests.zip', 11:24:43 INFO - u'target.web-platform.tests.tar.gz'], 11:24:43 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:24:43 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:24:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.common.tests.zip 11:24:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:24:43 INFO - Fetch https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.common.tests.zip into memory 11:24:45 INFO - Content-Length response header: 54736823 11:24:45 INFO - Bytes received: 54736823 11:24:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.talos.tests.zip 11:24:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:24:56 INFO - Fetch https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.talos.tests.zip into memory 11:24:56 INFO - Content-Length response header: 14502661 11:24:56 INFO - Bytes received: 14502661 11:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:57 INFO - trying https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.tar.bz2 11:24:57 INFO - Downloading https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:24:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:24:58 INFO - Downloaded 61395675 bytes. 11:24:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.tar.bz2 11:24:58 INFO - mkdir: /builds/slave/test/properties 11:24:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:24:58 INFO - Writing to file /builds/slave/test/properties/build_url 11:24:58 INFO - Contents: 11:24:58 INFO - build_url:https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.tar.bz2 11:24:58 INFO - Running post-action listener: _resource_record_post_action 11:24:58 INFO - Running post-action listener: find_tests_for_verification 11:24:58 INFO - Running post-action listener: set_extra_try_arguments 11:24:58 INFO - [mozharness: 2017-09-15 18:24:58.448236Z] Finished download-and-extract step (success) 11:24:58 INFO - [mozharness: 2017-09-15 18:24:58.448334Z] Running populate-webroot step. 11:24:58 INFO - Running pre-action listener: _resource_record_pre_action 11:24:58 INFO - Running main action method: populate_webroot 11:24:58 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:24:58 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:58 INFO - 'tests': ['tresize', 11:24:58 INFO - 'tcanvasmark']}, 11:24:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:24:58 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:58 INFO - 'tests': ['dromaeo_css', 11:24:58 INFO - 'kraken']}, 11:24:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:24:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:24:58 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:24:58 INFO - 'talos_options': ['--disable-stylo'], 11:24:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:24:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:24:58 INFO - 'tests': ['damp', 'tps']}, 11:24:58 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:24:58 INFO - 'talos_options': ['--disable-stylo'], 11:24:58 INFO - 'tests': ['damp', 'tps']}, 11:24:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:24:58 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:58 INFO - 'tests': ['dromaeo_dom']}, 11:24:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:24:58 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:58 INFO - 'tests': ['basic_compositor_video', 11:24:58 INFO - 'glvideo']}, 11:24:58 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:24:58 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:24:58 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:24:58 INFO - 'talos_options': ['--disable-stylo'], 11:24:58 INFO - 'tests': ['ts_paint_webext', 11:24:58 INFO - 'tp5o_webext']}, 11:24:58 INFO - 'other-e10s': {'tests': ['a11yr', 11:24:58 INFO - 'ts_paint', 11:24:58 INFO - 'tpaint', 11:24:58 INFO - 'sessionrestore', 11:24:58 INFO - 'sessionrestore_many_windows', 11:24:58 INFO - 'sessionrestore_no_auto_restore', 11:24:58 INFO - 'tabpaint']}, 11:24:58 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:58 INFO - 'tests': ['a11yr', 11:24:58 INFO - 'ts_paint', 11:24:58 INFO - 'tpaint', 11:24:58 INFO - 'sessionrestore', 11:24:58 INFO - 'sessionrestore_many_windows', 11:24:58 INFO - 'sessionrestore_no_auto_restore', 11:24:58 INFO - 'tabpaint']}, 11:24:58 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:24:58 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:24:58 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:58 INFO - 'tests': ['bloom_basic_singleton']}, 11:24:58 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:58 INFO - 'tests': ['bloom_basic']}, 11:24:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:24:58 INFO - 'tsvgr_opacity', 11:24:58 INFO - 'tart', 11:24:58 INFO - 'tscrollx', 11:24:58 INFO - 'tsvg_static']}, 11:24:58 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:24:58 INFO - 'tests': ['tsvgx', 11:24:58 INFO - 'tsvgr_opacity', 11:24:58 INFO - 'tart', 11:24:58 INFO - 'tscrollx', 11:24:58 INFO - 'tsvg_static']}, 11:24:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:24:58 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:24:58 INFO - 'talos_options': ['--disable-stylo'], 11:24:58 INFO - 'tests': ['tp5o']}, 11:24:58 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:24:58 INFO - 'talos_options': ['--mitmproxy', 11:24:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:24:58 INFO - '--firstNonBlankPaint'], 11:24:58 INFO - 'tests': ['tp6_google', 11:24:58 INFO - 'tp6_youtube', 11:24:58 INFO - 'tp6_amazon', 11:24:58 INFO - 'tp6_facebook']}, 11:24:58 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:24:58 INFO - 'talos_options': ['--disable-stylo', 11:24:58 INFO - '--mitmproxy', 11:24:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:24:58 INFO - '--firstNonBlankPaint'], 11:24:58 INFO - 'tests': ['tp6_google', 11:24:58 INFO - 'tp6_youtube', 11:24:58 INFO - 'tp6_amazon', 11:24:58 INFO - 'tp6_facebook']}, 11:24:58 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:24:58 INFO - 'talos_options': ['--stylo-threads=1', 11:24:58 INFO - '--mitmproxy', 11:24:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:24:58 INFO - '--firstNonBlankPaint'], 11:24:58 INFO - 'tests': ['tp6_google', 11:24:58 INFO - 'tp6_youtube', 11:24:58 INFO - 'tp6_amazon', 11:24:58 INFO - 'tp6_facebook']}, 11:24:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:24:58 INFO - 'talos_options': ['--xperf_path', 11:24:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:24:58 INFO - 'tests': ['tp5n']}, 11:24:58 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:24:58 INFO - 'talos_options': ['--disable-stylo', 11:24:58 INFO - '--xperf_path', 11:24:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:24:58 INFO - 'tests': ['tp5n']}}} 11:24:58 INFO - Running post-action listener: _resource_record_post_action 11:24:58 INFO - [mozharness: 2017-09-15 18:24:58.463308Z] Finished populate-webroot step (success) 11:24:58 INFO - [mozharness: 2017-09-15 18:24:58.463397Z] Running create-virtualenv step. 11:24:58 INFO - Running pre-action listener: _resource_record_pre_action 11:24:58 INFO - Running main action method: create_virtualenv 11:24:58 INFO - Creating virtualenv /builds/slave/test/build/venv 11:24:58 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:24:58 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:24:58 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:24:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:24:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:24:59 INFO - Installing distribute.............................................................................................................................................................................................done. 11:24:59 INFO - Installing pip...............done. 11:24:59 INFO - Return code: 0 11:24:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:24:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:24:59 INFO - Reading from file tmpfile_stdout 11:24:59 INFO - Output received: 11:24:59 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:24:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:59 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 0x1ce91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2055a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2059090>, '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 0x2059d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2053f90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505496840.176425-926818285', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:24:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:24:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:24:59 INFO - Using env: {'DISPLAY': ':0', 11:24:59 INFO - 'HOME': '/home/cltbld', 11:24:59 INFO - 'LANG': 'en_US.UTF-8', 11:24:59 INFO - 'LANGUAGE': 'en_US:en', 11:24:59 INFO - 'LOGNAME': 'cltbld', 11:24:59 INFO - 'MAIL': '/var/mail/cltbld', 11:24:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:59 INFO - 'MOZ_NO_REMOTE': '1', 11:24:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:59 INFO - 'NO_EM_RESTART': '1', 11:24:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:59 INFO - 'PWD': '/builds/slave/test', 11:24:59 INFO - 'SHELL': '/bin/bash', 11:24:59 INFO - 'SHLVL': '1', 11:24:59 INFO - 'TERM': 'linux', 11:24:59 INFO - 'TMOUT': '86400', 11:24:59 INFO - 'USER': 'cltbld', 11:24:59 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505496840.176425-926818285', 11:24:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:59 INFO - '_': '/tools/buildbot/bin/python'} 11:25:00 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:25:00 INFO - Downloading/unpacking pip>=1.5 11:25:00 INFO - Running setup.py egg_info for package pip 11:25:00 INFO - warning: no files found matching 'pip/cacert.pem' 11:25:00 INFO - warning: no files found matching '*.html' under directory 'docs' 11:25:00 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:25:00 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:25:00 INFO - Installing collected packages: pip 11:25:00 INFO - Found existing installation: pip 1.1 11:25:00 INFO - Uninstalling pip: 11:25:00 INFO - Successfully uninstalled pip 11:25:00 INFO - Running setup.py install for pip 11:25:00 INFO - warning: no files found matching 'pip/cacert.pem' 11:25:00 INFO - warning: no files found matching '*.html' under directory 'docs' 11:25:00 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:25:00 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:25:00 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:25:00 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:25:00 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:25:00 INFO - Successfully installed pip 11:25:00 INFO - Cleaning up... 11:25:00 INFO - Return code: 0 11:25:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:25:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1ce91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2055a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2059090>, '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 0x2059d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2053f90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505496840.176425-926818285', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:25:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:25:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:25:00 INFO - Using env: {'DISPLAY': ':0', 11:25:00 INFO - 'HOME': '/home/cltbld', 11:25:00 INFO - 'LANG': 'en_US.UTF-8', 11:25:00 INFO - 'LANGUAGE': 'en_US:en', 11:25:00 INFO - 'LOGNAME': 'cltbld', 11:25:00 INFO - 'MAIL': '/var/mail/cltbld', 11:25:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:00 INFO - 'MOZ_NO_REMOTE': '1', 11:25:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:00 INFO - 'NO_EM_RESTART': '1', 11:25:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:00 INFO - 'PWD': '/builds/slave/test', 11:25:00 INFO - 'SHELL': '/bin/bash', 11:25:00 INFO - 'SHLVL': '1', 11:25:00 INFO - 'TERM': 'linux', 11:25:00 INFO - 'TMOUT': '86400', 11:25:00 INFO - 'USER': 'cltbld', 11:25:00 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505496840.176425-926818285', 11:25:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:00 INFO - '_': '/tools/buildbot/bin/python'} 11:25:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:01 INFO - Downloading/unpacking psutil>=3.1.1 11:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:25:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:25:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:25:02 INFO - Installing collected packages: psutil 11:25:02 INFO - Running setup.py install for psutil 11:25:02 INFO - building 'psutil._psutil_linux' extension 11:25:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:25:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:25:02 INFO - building 'psutil._psutil_posix' extension 11:25:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:25:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:25:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:25:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:25:02 INFO - Successfully installed psutil 11:25:02 INFO - Cleaning up... 11:25:02 INFO - Return code: 0 11:25:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:25:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2055a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2059090>, '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 0x2059d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2053f90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505496840.176425-926818285', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:25:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:25:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:25:02 INFO - Using env: {'DISPLAY': ':0', 11:25:02 INFO - 'HOME': '/home/cltbld', 11:25:02 INFO - 'LANG': 'en_US.UTF-8', 11:25:02 INFO - 'LANGUAGE': 'en_US:en', 11:25:02 INFO - 'LOGNAME': 'cltbld', 11:25:02 INFO - 'MAIL': '/var/mail/cltbld', 11:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:02 INFO - 'MOZ_NO_REMOTE': '1', 11:25:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:02 INFO - 'NO_EM_RESTART': '1', 11:25:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:02 INFO - 'PWD': '/builds/slave/test', 11:25:02 INFO - 'SHELL': '/bin/bash', 11:25:02 INFO - 'SHLVL': '1', 11:25:02 INFO - 'TERM': 'linux', 11:25:02 INFO - 'TMOUT': '86400', 11:25:02 INFO - 'USER': 'cltbld', 11:25:02 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505496840.176425-926818285', 11:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:02 INFO - '_': '/tools/buildbot/bin/python'} 11:25:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:25:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:25:04 INFO - Installing collected packages: mozsystemmonitor 11:25:04 INFO - Running setup.py install for mozsystemmonitor 11:25:04 INFO - Successfully installed mozsystemmonitor 11:25:04 INFO - Cleaning up... 11:25:05 INFO - Return code: 0 11:25:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:05 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 0x1ce91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2055a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2059090>, '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 0x2059d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2053f90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505496840.176425-926818285', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:25:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:25:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:25:05 INFO - Using env: {'DISPLAY': ':0', 11:25:05 INFO - 'HOME': '/home/cltbld', 11:25:05 INFO - 'LANG': 'en_US.UTF-8', 11:25:05 INFO - 'LANGUAGE': 'en_US:en', 11:25:05 INFO - 'LOGNAME': 'cltbld', 11:25:05 INFO - 'MAIL': '/var/mail/cltbld', 11:25:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:05 INFO - 'MOZ_NO_REMOTE': '1', 11:25:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:05 INFO - 'NO_EM_RESTART': '1', 11:25:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:05 INFO - 'PWD': '/builds/slave/test', 11:25:05 INFO - 'SHELL': '/bin/bash', 11:25:05 INFO - 'SHLVL': '1', 11:25:05 INFO - 'TERM': 'linux', 11:25:05 INFO - 'TMOUT': '86400', 11:25:05 INFO - 'USER': 'cltbld', 11:25:05 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505496840.176425-926818285', 11:25:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:05 INFO - '_': '/tools/buildbot/bin/python'} 11:25:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:05 INFO - Downloading/unpacking jsonschema==2.5.1 11:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:25:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:06 INFO - Downloading functools32-3.2.3-2.tar.gz 11:25:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:25:07 INFO - warning: no files found matching '*.txt' 11:25:07 INFO - no previously-included directories found matching 'build' 11:25:07 INFO - no previously-included directories found matching 'dist' 11:25:07 INFO - no previously-included directories found matching '.git*' 11:25:07 INFO - Installing collected packages: jsonschema, functools32 11:25:08 INFO - Running setup.py install for functools32 11:25:08 INFO - warning: no files found matching '*.txt' 11:25:08 INFO - no previously-included directories found matching 'build' 11:25:08 INFO - no previously-included directories found matching 'dist' 11:25:08 INFO - no previously-included directories found matching '.git*' 11:25:08 INFO - Successfully installed jsonschema functools32 11:25:08 INFO - Cleaning up... 11:25:08 INFO - Return code: 0 11:25:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:25:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1ce91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2055a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2059090>, '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 0x2059d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2053f90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505496840.176425-926818285', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:25:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:25:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:25:08 INFO - Using env: {'DISPLAY': ':0', 11:25:08 INFO - 'HOME': '/home/cltbld', 11:25:08 INFO - 'LANG': 'en_US.UTF-8', 11:25:08 INFO - 'LANGUAGE': 'en_US:en', 11:25:08 INFO - 'LOGNAME': 'cltbld', 11:25:08 INFO - 'MAIL': '/var/mail/cltbld', 11:25:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:08 INFO - 'MOZ_NO_REMOTE': '1', 11:25:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:08 INFO - 'NO_EM_RESTART': '1', 11:25:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:08 INFO - 'PWD': '/builds/slave/test', 11:25:08 INFO - 'SHELL': '/bin/bash', 11:25:08 INFO - 'SHLVL': '1', 11:25:08 INFO - 'TERM': 'linux', 11:25:08 INFO - 'TMOUT': '86400', 11:25:08 INFO - 'USER': 'cltbld', 11:25:08 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505496840.176425-926818285', 11:25:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:08 INFO - '_': '/tools/buildbot/bin/python'} 11:25:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:25:08 INFO - Cleaning up... 11:25:08 INFO - Return code: 0 11:25:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:25:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1ce91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2055a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2059090>, '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 0x2059d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2053f90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505496840.176425-926818285', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:25:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:25:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:25:08 INFO - Using env: {'DISPLAY': ':0', 11:25:08 INFO - 'HOME': '/home/cltbld', 11:25:08 INFO - 'LANG': 'en_US.UTF-8', 11:25:08 INFO - 'LANGUAGE': 'en_US:en', 11:25:08 INFO - 'LOGNAME': 'cltbld', 11:25:08 INFO - 'MAIL': '/var/mail/cltbld', 11:25:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:08 INFO - 'MOZ_NO_REMOTE': '1', 11:25:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:08 INFO - 'NO_EM_RESTART': '1', 11:25:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:08 INFO - 'PWD': '/builds/slave/test', 11:25:08 INFO - 'SHELL': '/bin/bash', 11:25:08 INFO - 'SHLVL': '1', 11:25:08 INFO - 'TERM': 'linux', 11:25:08 INFO - 'TMOUT': '86400', 11:25:08 INFO - 'USER': 'cltbld', 11:25:08 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505496840.176425-926818285', 11:25:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:08 INFO - '_': '/tools/buildbot/bin/python'} 11:25:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:09 INFO - Downloading/unpacking blobuploader==1.2.4 11:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:10 INFO - Downloading blobuploader-1.2.4.tar.gz 11:25:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:25:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:25:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:11 INFO - Downloading docopt-0.6.1.tar.gz 11:25:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:25:11 INFO - Installing collected packages: blobuploader, requests, docopt 11:25:11 INFO - Running setup.py install for blobuploader 11:25:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:25:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:25:11 INFO - Running setup.py install for requests 11:25:11 INFO - Running setup.py install for docopt 11:25:11 INFO - Successfully installed blobuploader requests docopt 11:25:11 INFO - Cleaning up... 11:25:11 INFO - Return code: 0 11:25:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25: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')]} 11:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25: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')]} 11:25:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:11 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 0x1ce91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2055a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2059090>, '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 0x2059d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2053f90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505496840.176425-926818285', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:25:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:25:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:25:11 INFO - Using env: {'DISPLAY': ':0', 11:25:11 INFO - 'HOME': '/home/cltbld', 11:25:11 INFO - 'LANG': 'en_US.UTF-8', 11:25:11 INFO - 'LANGUAGE': 'en_US:en', 11:25:11 INFO - 'LOGNAME': 'cltbld', 11:25:11 INFO - 'MAIL': '/var/mail/cltbld', 11:25:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:11 INFO - 'MOZ_NO_REMOTE': '1', 11:25:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:11 INFO - 'NO_EM_RESTART': '1', 11:25:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:11 INFO - 'PWD': '/builds/slave/test', 11:25:11 INFO - 'SHELL': '/bin/bash', 11:25:11 INFO - 'SHLVL': '1', 11:25:11 INFO - 'TERM': 'linux', 11:25:11 INFO - 'TMOUT': '86400', 11:25:11 INFO - 'USER': 'cltbld', 11:25:11 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505496840.176425-926818285', 11:25:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:11 INFO - '_': '/tools/buildbot/bin/python'} 11:25:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:25:11 INFO - Running setup.py (path:/tmp/pip-hV2KJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:25:12 INFO - Running setup.py (path:/tmp/pip-t9m4e6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:25:12 INFO - Running setup.py (path:/tmp/pip-tjzcgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:25:12 INFO - Running setup.py (path:/tmp/pip-AxUAfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:25:12 INFO - Running setup.py (path:/tmp/pip-qc0H7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:25:12 INFO - Running setup.py (path:/tmp/pip-15RHjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:25:12 INFO - Running setup.py (path:/tmp/pip-MP6a9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:25:12 INFO - Running setup.py (path:/tmp/pip-mzLIyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:25:12 INFO - Running setup.py (path:/tmp/pip-ldppNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:25:12 INFO - Running setup.py (path:/tmp/pip-ya8lx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:25:12 INFO - Running setup.py (path:/tmp/pip-cF2FS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:25:12 INFO - Running setup.py (path:/tmp/pip-Ifmxld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:25:12 INFO - Running setup.py (path:/tmp/pip-7GHbLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:25:12 INFO - Running setup.py (path:/tmp/pip-cNH6vX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:12 INFO - Running setup.py (path:/tmp/pip-Np3RYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:25:13 INFO - Running setup.py (path:/tmp/pip-QWWxMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:25:13 INFO - Running setup.py (path:/tmp/pip-eJ_MDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:25:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:25:13 INFO - Running setup.py install for manifestparser 11:25:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:25:13 INFO - Running setup.py install for mozcrash 11:25:13 INFO - Running setup.py install for mozdebug 11:25:13 INFO - Running setup.py install for mozdevice 11:25:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:25:13 INFO - Running setup.py install for mozfile 11:25:13 INFO - Running setup.py install for mozhttpd 11:25:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:25:13 INFO - Running setup.py install for mozinfo 11:25:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:25:13 INFO - Running setup.py install for mozInstall 11:25:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:25:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:25:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:25:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:25:13 INFO - Running setup.py install for mozleak 11:25:14 INFO - Running setup.py install for mozlog 11:25:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:25:14 INFO - Running setup.py install for moznetwork 11:25:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:25:14 INFO - Running setup.py install for mozprocess 11:25:14 INFO - Running setup.py install for mozprofile 11:25:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:25:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:25:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:25:14 INFO - Running setup.py install for mozrunner 11:25:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:25:14 INFO - Running setup.py install for mozscreenshot 11:25:14 INFO - Running setup.py install for moztest 11:25:14 INFO - Running setup.py install for mozversion 11:25:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:25:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:25:14 INFO - Cleaning up... 11:25:14 INFO - Return code: 0 11:25:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:14 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 0x1ce91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2055a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2059090>, '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 0x2059d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2053f90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505496840.176425-926818285', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:25:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:25:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:25:14 INFO - Using env: {'DISPLAY': ':0', 11:25:14 INFO - 'HOME': '/home/cltbld', 11:25:14 INFO - 'LANG': 'en_US.UTF-8', 11:25:14 INFO - 'LANGUAGE': 'en_US:en', 11:25:14 INFO - 'LOGNAME': 'cltbld', 11:25:14 INFO - 'MAIL': '/var/mail/cltbld', 11:25:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:14 INFO - 'MOZ_NO_REMOTE': '1', 11:25:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:14 INFO - 'NO_EM_RESTART': '1', 11:25:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:14 INFO - 'PWD': '/builds/slave/test', 11:25:14 INFO - 'SHELL': '/bin/bash', 11:25:14 INFO - 'SHLVL': '1', 11:25:14 INFO - 'TERM': 'linux', 11:25:14 INFO - 'TMOUT': '86400', 11:25:14 INFO - 'USER': 'cltbld', 11:25:14 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505496840.176425-926818285', 11:25:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:14 INFO - '_': '/tools/buildbot/bin/python'} 11:25:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:25:15 INFO - Running setup.py (path:/tmp/pip-a6kyum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:25:15 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:25:15 INFO - Running setup.py (path:/tmp/pip-wbsS4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:25:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:25:15 INFO - Running setup.py (path:/tmp/pip-0oXgPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:25:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:25:15 INFO - Running setup.py (path:/tmp/pip-0uVUZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:25:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:25:15 INFO - Running setup.py (path:/tmp/pip-xo_4cL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:25:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:25:15 INFO - Running setup.py (path:/tmp/pip-FViHBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:25:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:25:15 INFO - Running setup.py (path:/tmp/pip-zIvhgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:25:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:25:15 INFO - Running setup.py (path:/tmp/pip-seUSbY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:25:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:25:15 INFO - Running setup.py (path:/tmp/pip-qDcQhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:25:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:25:15 INFO - Running setup.py (path:/tmp/pip-BFekPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:25:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:25:15 INFO - Running setup.py (path:/tmp/pip-B6SDqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:25:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:25:15 INFO - Running setup.py (path:/tmp/pip-TY65Df-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:25:16 INFO - Running setup.py (path:/tmp/pip-JhRxba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:25:16 INFO - Running setup.py (path:/tmp/pip-P7Y3Mb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:16 INFO - Running setup.py (path:/tmp/pip-Ai4nFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:25:16 INFO - Running setup.py (path:/tmp/pip-YcWT0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:25:16 INFO - Running setup.py (path:/tmp/pip-e42B2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:25:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:17 INFO - Downloading blessings-1.6.tar.gz 11:25:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:25:17 INFO - Installing collected packages: blessings 11:25:17 INFO - Running setup.py install for blessings 11:25:17 INFO - Successfully installed blessings 11:25:17 INFO - Cleaning up... 11:25:17 INFO - Return code: 0 11:25:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:25:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:25:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:25:17 INFO - Reading from file tmpfile_stdout 11:25:17 INFO - Current package versions: 11:25:17 INFO - argparse == 1.2.1 11:25:17 INFO - blessings == 1.6 11:25:17 INFO - blobuploader == 1.2.4 11:25:17 INFO - docopt == 0.6.1 11:25:17 INFO - functools32 == 3.2.3-2 11:25:17 INFO - jsonschema == 2.5.1 11:25:17 INFO - manifestparser == 1.1 11:25:17 INFO - mozInstall == 1.13 11:25:17 INFO - mozcrash == 1.0 11:25:17 INFO - mozdebug == 0.1 11:25:17 INFO - mozdevice == 0.51 11:25:17 INFO - mozfile == 1.2 11:25:17 INFO - mozhttpd == 0.7 11:25:17 INFO - mozinfo == 0.10 11:25:17 INFO - mozleak == 0.1 11:25:17 INFO - mozlog == 3.5 11:25:17 INFO - moznetwork == 0.27 11:25:17 INFO - mozprocess == 0.25 11:25:17 INFO - mozprofile == 0.28 11:25:17 INFO - mozrunner == 6.13 11:25:17 INFO - mozscreenshot == 0.1 11:25:17 INFO - mozsystemmonitor == 0.3 11:25:17 INFO - moztest == 0.8 11:25:17 INFO - mozversion == 1.4 11:25:17 INFO - psutil == 3.1.1 11:25:17 INFO - requests == 1.2.3 11:25:17 INFO - wsgiref == 0.1.2 11:25:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:17 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 0x1ce91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2055a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2059090>, '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 0x2059d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2053f90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505496840.176425-926818285', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:25:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:25:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:25:17 INFO - Using env: {'DISPLAY': ':0', 11:25:17 INFO - 'HOME': '/home/cltbld', 11:25:17 INFO - 'LANG': 'en_US.UTF-8', 11:25:17 INFO - 'LANGUAGE': 'en_US:en', 11:25:17 INFO - 'LOGNAME': 'cltbld', 11:25:17 INFO - 'MAIL': '/var/mail/cltbld', 11:25:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:17 INFO - 'MOZ_NO_REMOTE': '1', 11:25:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:17 INFO - 'NO_EM_RESTART': '1', 11:25:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:17 INFO - 'PWD': '/builds/slave/test', 11:25:17 INFO - 'SHELL': '/bin/bash', 11:25:17 INFO - 'SHLVL': '1', 11:25:17 INFO - 'TERM': 'linux', 11:25:17 INFO - 'TMOUT': '86400', 11:25:17 INFO - 'USER': 'cltbld', 11:25:17 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505496840.176425-926818285', 11:25:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:17 INFO - '_': '/tools/buildbot/bin/python'} 11:25:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:25:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:25:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:25:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:25:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:25:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:25:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:25:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:25:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:25:18 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:25:19 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:25:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:25:19 INFO - Installing collected packages: simplejson 11:25:19 INFO - Running setup.py install for simplejson 11:25:19 INFO - building 'simplejson._speedups' extension 11:25:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 11:25:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 11:25:20 INFO - Successfully installed simplejson 11:25:20 INFO - Cleaning up... 11:25:20 INFO - Return code: 0 11:25:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:25:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:20 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 0x1ce91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2055a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2059090>, '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 0x2059d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2053f90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505496840.176425-926818285', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:25:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:25:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:25:20 INFO - Using env: {'DISPLAY': ':0', 11:25:20 INFO - 'HOME': '/home/cltbld', 11:25:20 INFO - 'LANG': 'en_US.UTF-8', 11:25:20 INFO - 'LANGUAGE': 'en_US:en', 11:25:20 INFO - 'LOGNAME': 'cltbld', 11:25:20 INFO - 'MAIL': '/var/mail/cltbld', 11:25:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:20 INFO - 'MOZ_NO_REMOTE': '1', 11:25:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:20 INFO - 'NO_EM_RESTART': '1', 11:25:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:20 INFO - 'PWD': '/builds/slave/test', 11:25:20 INFO - 'SHELL': '/bin/bash', 11:25:20 INFO - 'SHLVL': '1', 11:25:20 INFO - 'TERM': 'linux', 11:25:20 INFO - 'TMOUT': '86400', 11:25:20 INFO - 'USER': 'cltbld', 11:25:20 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505496840.176425-926818285', 11:25:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:20 INFO - '_': '/tools/buildbot/bin/python'} 11:25:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:25:20 INFO - Cleaning up... 11:25:20 INFO - Return code: 0 11:25:20 INFO - Running post-action listener: _resource_record_post_action 11:25:20 INFO - Running post-action listener: _start_resource_monitoring 11:25:20 INFO - Starting resource monitoring. 11:25:20 INFO - [mozharness: 2017-09-15 18:25:20.655645Z] Finished create-virtualenv step (success) 11:25:20 INFO - [mozharness: 2017-09-15 18:25:20.656098Z] Running install step. 11:25:20 INFO - Running pre-action listener: _resource_record_pre_action 11:25:20 INFO - Running main action method: install 11:25:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:25:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:25:20 INFO - Reading from file tmpfile_stdout 11:25:20 INFO - Detecting whether we're running mozinstall >=1.0... 11:25:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:25:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:25:21 INFO - Reading from file tmpfile_stdout 11:25:21 INFO - Output received: 11:25:21 INFO - Usage: mozinstall [options] installer 11:25:21 INFO - Options: 11:25:21 INFO - -h, --help show this help message and exit 11:25:21 INFO - -d DEST, --destination=DEST 11:25:21 INFO - Directory to install application into. [default: 11:25:21 INFO - "/builds/slave/test"] 11:25:21 INFO - --app=APP Application being installed. [default: firefox] 11:25:21 INFO - mkdir: /builds/slave/test/build/application 11:25:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:25:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:25:38 INFO - Reading from file tmpfile_stdout 11:25:38 INFO - Output received: 11:25:38 INFO - /builds/slave/test/build/application/firefox/firefox 11:25:38 INFO - Running post-action listener: _resource_record_post_action 11:25:38 INFO - [mozharness: 2017-09-15 18:25:38.749028Z] Finished install step (success) 11:25:38 INFO - [mozharness: 2017-09-15 18:25:38.749175Z] Running setup-mitmproxy step. 11:25:38 INFO - Running pre-action listener: _resource_record_pre_action 11:25:38 INFO - Running main action method: setup_mitmproxy 11:25:38 INFO - Skipping: mitmproxy is not required 11:25:38 INFO - Running post-action listener: _resource_record_post_action 11:25:38 INFO - [mozharness: 2017-09-15 18:25:38.750067Z] Finished setup-mitmproxy step (success) 11:25:38 INFO - [mozharness: 2017-09-15 18:25:38.750289Z] Running run-tests step. 11:25:38 INFO - Running pre-action listener: _resource_record_pre_action 11:25:38 INFO - Running pre-action listener: _set_gcov_prefix 11:25:38 INFO - Running main action method: run_tests 11:25:38 WARNING - Try message not found. 11:25:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:25:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:25:38 INFO - Python 2.7.3 11:25:38 INFO - Return code: 0 11:25:38 INFO - grabbing minidump binary from tooltool 11:25:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:38 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 0x2059090>, '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 0x2059d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2053f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:25:38 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:25:38 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:25:38 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:25:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:25:38 INFO - Return code: 0 11:25:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:25:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:25:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:25:38 INFO - ENV: RUST_BACKTRACE is now full 11:25:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:25:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:25:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:25:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-069 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:25:38 INFO - Using env: {'DISPLAY': ':0', 11:25:38 INFO - 'HOME': '/home/cltbld', 11:25:38 INFO - 'LANG': 'en_US.UTF-8', 11:25:38 INFO - 'LANGUAGE': 'en_US:en', 11:25:38 INFO - 'LOGNAME': 'cltbld', 11:25:38 INFO - 'MAIL': '/var/mail/cltbld', 11:25:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:25:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:25:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:38 INFO - 'MOZ_NO_REMOTE': '1', 11:25:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:25:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:38 INFO - 'NO_EM_RESTART': '1', 11:25:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:38 INFO - 'PWD': '/builds/slave/test', 11:25:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:25:38 INFO - 'RUST_BACKTRACE': 'full', 11:25:38 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:25:38 INFO - 'SHELL': '/bin/bash', 11:25:38 INFO - 'SHLVL': '1', 11:25:38 INFO - 'TERM': 'linux', 11:25:38 INFO - 'TMOUT': '86400', 11:25:38 INFO - 'USER': 'cltbld', 11:25:38 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505496840.176425-926818285', 11:25:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:38 INFO - '_': '/tools/buildbot/bin/python'} 11:25:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:25:39 INFO - mozversion application_buildid: 20170915173306 11:25:39 INFO - mozversion application_changeset: 9071a20f3eaa804a439990b7596dbc16d52d1e20 11:25:39 INFO - mozversion application_display_name: Nightly 11:25:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:25:39 INFO - mozversion application_name: Firefox 11:25:39 INFO - mozversion application_remotingname: firefox 11:25:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:25:39 INFO - mozversion application_vendor: Mozilla 11:25:39 INFO - mozversion application_version: 57.0a1 11:25:39 INFO - mozversion platform_buildid: 20170915173306 11:25:39 INFO - mozversion platform_changeset: 9071a20f3eaa804a439990b7596dbc16d52d1e20 11:25:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:25:39 INFO - mozversion platform_version: 57.0a1 11:25:39 INFO - using testdate: 1505499939 11:25:39 INFO - actual date: 1505499939 11:25:39 INFO - starting webserver on 'localhost:49331' 11:25:39 INFO - SUITE-START | Running 2 tests 11:25:39 INFO - TEST-START | dromaeo_css 11:25:39 INFO - Initialising browser for dromaeo_css test... 11:25:39 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49331/getInfo.html -profile /tmp/tmpz_LIdF/profile 11:25:39 INFO - TEST-INFO | started process 19184 (/builds/slave/test/build/application/firefox/firefox http://localhost:49331/getInfo.html) 11:25:44 INFO - TEST-INFO | 19184: exit 0 11:25:44 INFO - Browser initialized. 11:25:44 INFO - Running cycle 1/1 for dromaeo_css test... 11:25:44 INFO - Using env: {'DISPLAY': ':0', 11:25:44 INFO - 'HOME': '/home/cltbld', 11:25:44 INFO - 'JSGC_DISABLE_POISONING': '1', 11:25:44 INFO - 'LANG': 'en_US.UTF-8', 11:25:44 INFO - 'LANGUAGE': 'en_US:en', 11:25:44 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:25:44 INFO - 'LOGNAME': 'cltbld', 11:25:44 INFO - 'MAIL': '/var/mail/cltbld', 11:25:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:25:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:25:44 INFO - 'MOZ_CRASHREPORTER': '1', 11:25:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:44 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:25:44 INFO - 'MOZ_NO_REMOTE': '1', 11:25:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:25:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:44 INFO - 'NO_EM_RESTART': '1', 11:25:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:44 INFO - 'PWD': '/builds/slave/test', 11:25:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:25:44 INFO - 'RUST_BACKTRACE': 'full', 11:25:44 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:25:44 INFO - 'SHELL': '/bin/bash', 11:25:44 INFO - 'SHLVL': '1', 11:25:44 INFO - 'TERM': 'linux', 11:25:44 INFO - 'TMOUT': '86400', 11:25:44 INFO - 'USER': 'cltbld', 11:25:44 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505496840.176425-926818285', 11:25:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:44 INFO - '_': '/tools/buildbot/bin/python'} 11:25:44 INFO - TEST-INFO | started process 19415 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz_LIdF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:25:45 INFO - PID 19415 | 11:25:45 INFO - PID 19415 | (/builds/slave/test/build/application/firefox/firefox:19464): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:25:45 INFO - PID 19415 | 11:25:56 INFO - PID 19415 | RSS: Main: 173432832 11:25:56 INFO - PID 19415 | 11:28:53 INFO - PID 19415 | Cycle 1(1): loaded http://localhost:49331/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49331/tests/dromaeo/cssquery-ext.html) 11:28:55 INFO - PID 19415 | RSS: Main: 176345088 11:28:55 INFO - PID 19415 | 11:31:56 INFO - PID 19415 | Cycle 1(1): loaded http://localhost:49331/tests/dromaeo/cssquery-ext.html (next: http://localhost:49331/tests/dromaeo/cssquery-jquery.html) 11:31:57 INFO - PID 19415 | RSS: Main: 169758720 11:31:57 INFO - PID 19415 | 11:34:59 INFO - PID 19415 | Cycle 1(1): loaded http://localhost:49331/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49331/tests/dromaeo/cssquery-mootools.html) 11:34:59 INFO - PID 19415 | RSS: Main: 174166016 11:34:59 INFO - PID 19415 | 11:38:01 INFO - PID 19415 | Cycle 1(1): loaded http://localhost:49331/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49331/tests/dromaeo/cssquery-prototype.html) 11:38:02 INFO - PID 19415 | RSS: Main: 171212800 11:38:02 INFO - PID 19415 | 11:41:05 INFO - PID 19415 | Cycle 1(1): loaded http://localhost:49331/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49331/tests/dromaeo/cssquery-yui.html) 11:41:06 INFO - PID 19415 | RSS: Main: 175390720 11:41:06 INFO - PID 19415 | 11:44:07 INFO - PID 19415 | Cycle 1(1): loaded http://localhost:49331/tests/dromaeo/cssquery-yui.html (next: http://localhost:49331/tests/dromaeo/cssquery-dojo.html) 11:44:08 INFO - PID 19415 | RSS: Main: 177426432 11:44:08 INFO - PID 19415 | 11:44:08 INFO - PID 19415 | __start_tp_report 11:44:08 INFO - PID 19415 | _x_x_mozilla_page_load 11:44:08 INFO - PID 19415 | _x_x_mozilla_page_load_details 11:44:08 INFO - PID 19415 | |i|pagename|runs| 11:44:08 INFO - PID 19415 | |0;dojo.html;3114.844257787113;3156.6685498022707;3161.762867784915;3179.8728050877967;3195.80825150491;6044.697765111749;6193;6203.9689801550985;6204.193454850869;6322.589031712935;6190.75236990521;6190.761847630481;6260.311365749764;6408.7756928507515;6421.550491465599;1330.1785656516292;5827.883442331151;5851.531877449794;5873.207117039209;5931.436513531207;5708.857278568048;5785.074388097905;5816.476517113459;5838.708064596774;5857.85355366115;5653.660780353151;5723.971380143073;5767.192593036978;5809.041508151171;5836.212111364954;5735.1684005818925;5737.913931290992;5757.453041961007;5801.0428279333855;5836.978528757493;5725.456081672234;5737.139429085629;5771.134329850514;5797.710114494301;5808.6224395414165;6170.413810687977;6203.503719702413;6319.8104056878365;6339.714712837934;6341.302456729756;6521.771737989147;6627.502937279675;6728.529002969794;6777.898331525031;6791.117154769898;6167.414095660905;6707.329267073303;6750;6780.864382712318;6791.185057793096;6254.124422580842;6257.092721555395;6263.24841019076;6263.71813268404;6298.622082675054;6872.896906546406;7018.929810701828;7029.3673569379;7047.119110111236;7055.6472176392;6529.2817790043055;6550.443212327005;6557.114789503451;6661.3005634408655;6683.6324002180345;6550.377714117151;6633.336666333328;6672.866542669217;6683.966580167068;6716.1604799400075;6631.403173714389;6633.104530888365;6638.734450622018;6662.533622646368;6683.164604424447;6665.366790154928;6675.265720770712;6728.764493242811;6747.291534388916;6771.559848609824;5263.105272103751;5275.314209152785;5299.3905700844125;5320.600954928396;5349;4591.494935557086;4627.051454451829;4637.884052898705;4653.069386122789;4657.347971284023;5642.85892852682;5751.683657398883;5753.597248192586;5778.913316300259;5837.562182836305;6737.393634572912;6773.729050837911;6796.76211332601;6821.249662537117;6830.897536536956;5760.654360738369;5813.79651712188;5835.941640583625;5836.737346819404;5849.268841394825;5765.4522820332;5767.88464230713;5838.737256823453;5846.210761547221;5855.765769369177;6337.7781777637565;6456.677166141674;6466.579672321284;6485.70814313357;6593.703283352261;6659.60042397448;6682.3317668232785;6687.230968438497;6700.731970721312;6700.966495167493;6455.419012288917;6457.709403076967;6470.255920569007;6557.639329836905;6613.867722645617;6705.497087718538;6749.122614060141;6777.8983315249325;6785.423239024541;6790.898136527857;6832.965835170792;6835.7949261522235;6913.827154321182;6927.480438966997;6943.583384996917;6337.588056776295;6366.172397588284;6471.158749362553;6524.804255872332;6577.736890524326;6621.536492445675;6642.83392915181;6653.500987425866;6664.266930637723;6683.465322774264;6497.285298617054;6575.638339891352;6576.736930522917;6578.046183303299;6594.802155935329;6618.139641846529;6618.470522358103;6629.701663425061;6675.499337549801;6726.529142959946;6241.282252541016;6342.651154186564;6345.619262844244;6450.741970321134;6469.547131700736 11:44:08 INFO - PID 19415 | |1;ext.html;863.5768473448012;878.5519385113594;879.1779685993597;880.1946219209424;890.1410139215658;37775.43336849946;40885.79557102214;41259;41322.58677413225;41411.58588414115;39338.21323573527;39380.21239575207;39419.211615767665;39601.207975840465;39695.404568931415;7038.964805175967;7156.713731450762;7164.713411463561;7172.748953786619;7196.748113816017;7039.788806335818;7047.295270472938;7049.224585295613;7065.470089743264;7085.7165713371405;7024.438044956391;7057.647117644123;7064.964675176642;7097.148342198943;7299.233580474053;7821.256980586835;7871.9212807872045;7879.921200787976;7880.290773830326;7890.250426209501;7813.257740514642;7859.096203936563;7862.764117076496;7865.764027079197;7917.524948503108;38305.425418618746;38992.41511377331;39150.41274380887;39183;39211.60788392108;3528.858845646171;3577.463380492921;3580.427131658948;3580.480830279621;3581.230035542371;31723.682763172303;31750.523742143887;31834.204144896332;31849.363012739614;31877.521837172462;5028;5049.4950504949575;5060.493950604947;5064.18972964324;5070.670406423571;164117;179863;180163.9999999987;180558;180648;42302.57697423048;42304.365434518506;46892;47174;47527.52472475231;51179.744101279255;51391;51444.48555514472;51479.22781158286;51499.48500515022;16127.919360403122;16132;16153.676926461405;16171.110588917487;16284.592885177964;13141.474341026444;13144.277064761338;13277.402516886763;13283.933580332037;13302.534411295559;13901.721965560631;13925.094868833696;13948.511802086878;14015.85984140166;14027;5658.321001479849;5710.5146062585145;5719.256496655491;5742;5788.623739457006;1000.7097941596855;1014.5840205515703;1014.8629934958834;1021.22897212604;1046.858674079005;22678.092876284765;22751;22866;22910.770892290864;23166.1891833785;1109.6948339206783;1111.2776695148057;1120.434180738738;1121.2151493954264;1126.887311268883;12110.152289339661;12239.93880030612;12309.507619695112;12325.383730813603;12344.938275308745;209578;210815;210839;211133;211211;52362.95274094573;52404.47595524072;52408;52444.21333679998;52730.73634631802;1397.7204559088223;1459.7664973097715;1460.3866376122055;1463.6633574277762;1474.4470823441209;22600.66099008549;22681.546369072195;22686.546269074195;23279.883600582565;23450.64824027675;37478.43782343213;37506.437403438424;37532.24935501329;37534;37564.43653345147;133010;133406;133562;133590.33204833913;133848;34017.65982340244;34893.8255308732;35944.460833087;36122.458163128096;36363.45454818233;45322.09355812931;46538.76730616325;46590;46647.30029049635;46895;33355.332893342485;33564.32871342511;33639.83180084084;33754.63717539847;33960.83019584886;32950.83524582458;33057.83471082629;33103.33793324168;33378;33483.66516334806;36779.08052298714;37027;37413.438798417505;37581;37913.4312985311;32473;32490.187745306557;32635.510467343483;32951.50572741363;33165.17087072843;23564.882175589697;23715.288541343787;23889.402764931016;24348.756512434647;24392.390190245387 11:44:08 INFO - PID 19415 | |2;jquery.html;541.6026651239802;568.2016766443144;568.3918207517958;582.3477704970434;585.6720236667467;22487.437814054658;23294.65058024127;23320.65019024716;23380.64929026066;23386.64920026201;23526.647100293467;24469.87765061172;24822.627660585105;24828;25272.87363563184;6572.211334639838;6715.496337774662;6715.664216789165;6717.63053032083;6722.663866806664;6365.204349456318;6554;6648.833779155511;6650.3682150195655;6654.268030516663;6564;6629.4696424286185;6631.303713110126;6631.933680663204;6634.734610615569;6538.313477084909;6574.967125164391;6584.078229047937;6602.768903088393;6890.862182756367;7017.684204210823;7027;7033.964830175868;7041.084658994349;7043.084399028145;29460.852695736383;30171.547426788617;30173.849130754425;30198.24504387386;30205.697943020507;2108.5572029873747;2130.222468798893;2130.478032881954;2136.957260854774;2138.893055347242;18649.160787764584;18674.439766807016;18698.34555790541;18727.62544749111;19187.232510699556;2250.8199344052437;2252.234240358286;2306.953860922789;2307.619242824932;2309.711286089239;120540.39729801382;126278;131539;136076;140805.2959735205;20209.292674756605;20808.27171049006;20962.161513539286;21495.67756483654;21630;42147.57852421437;42166;42252.78873605612;42278.36582451266;42419.57580424218;11440;11564.306141631361;11603.825942610867;11604.361760103275;11713.121515886343;9503;9718.805623887483;9775.755606109904;9777.804443911082;9900.900990990142;10747.656542932133;10826.729331766612;10890.61882834097;10959.0684791792;11017.173711971634;3956.9802150989635;4042.919141617151;4043.939340909889;4253.7480978870835;4274.140748774231;923.9168474837297;949.9952500237455;957.8170958865795;960.6157536985262;978.4471773448122;18405.53986150357;18946.62106757857;18960.14679339433;18989.05054747285;19418;996.1781530237583;1002.9297949143636;1015.7816069544936;1017.8524114003576;1024.7335692719946;10287.382757034602;10494.370337779757;10529.78643686774;10557.9472102639;10870.510827012804;461703;471073;477183;479064;481143;106784;108300;108866;109241;109342.45328773305;1125.6848082536903;1132.7904337697553;1151.8099513580332;1153.8557680289964;1154.1055681846635;16669;16889;17005.91497042507;17013.829861701226;17089.401870934456;53073;54164.45835541752;54829.45170548243;54954.45045549493;55931;63801.36198637954;64240;64316;64589.35410646021;65466;19036.33372831944;19297.807021929602;19407.417777466697;19605.901970490628;19680.90159549193;21837.890810545847;21946;22020.11919523201;22128.225512106997;22468.775312246667;16664.66670666604;16892.831071689125;17076.573085672957;17136.228869701143;17142.314307428063;14867.92566037163;15394.461193858162;15465.768013479581;15739.370425182864;16112.516624501284;17615.911920440314;17632.647347053244;17781.577473801804;18030.729539057185;18032;18827.811721882605;18848.811511884705;18913.243470261037;18989;19073.71389429132;17215.913920430317;17400.82599174043;17548.298068077132;17650.91174544119;17845.286188552313 11:44:08 INFO - PID 19415 | |3;mootools.html;1314.8422189337277;1388.7569675306818;1389.2012093046494;1394.2471065624563;1404;14873.479428220015;15552.144632045247;15573.377064917418;15582.610434739123;15589.532314030597;15186.772198417033;15302.081875087502;15342.156181410019;15348.6930261395;15375.38498460063;2711.2815103997455;2722.1697382298344;2768.418632087264;2770.141256210581;2776.4585905748286;2669.4454693218145;2691.8115731898774;2701.8649067546644;2708.580170073632;2715.551933930909;2701.3246688327918;2713.8507382093976;2714.4028313770937;2749.477599256145;2825.6044153818484;2708.1063249127837;2747.5466548019554;2748.7663548598393;2752.683441404244;2753.022676949674;2502.099244272061;2512.8366656167473;2536.467341858212;2537.7716005559405;2539.517491676594;14841.332140053724;15023.323950422257;15046.473373431878;15048.473303434328;15057.02129361599;7952.801179970489;8218.465799723059;8225.670973161066;8262.710805121791;8267.173282671745;5473.151661492475;5665.1502274658715;5685.59051640726;5750.971245143789;5764.5676574257095;1892.706630472279;1923.740295060163;1950.7073938909136;1975.4073777866727;1998.590288990768;26334.708161479815;26627.201183964513;26814.195574132806;26827;26967.05615303455;7253.746118885813;7322.524035937647;7359.632018399058;7500.287472690085;7523.8119047023165;19960.60078798416;19993.900030500045;20042.498937526678;20077.899610501852;20091.196352146042;8010.3191228745045;8223.095459499451;8248.587570621445;8274.172582741798;8304.70933517324;7246.6376681166785;7253.56478611285;7258.346748792528;7355.080614923135;7404.851902961911;5438.864028399322;5520.3651580068;5591.077472217039;5686.857828554236;5689.175069614883;1752.0801579171036;1781.7950935642307;1803.2877013579562;1832.44110546282;1832.7250912362986;844.4890841041205;856.3876828067837;866.3415803989013;866.5104216117874;885.526243459746;6989.650517474106;7000.229974702778;7012.228654848064;7037.542559733601;7056.964715176391;691.4675699711195;701.0780823217452;718.5760401363116;723.6562632749402;728.3226599262737;4299.07569872479;4671.789769460383;5249.186376111708;5314.5748340132695;5374.704391258519;18671.71992420115;20183;20696.896515517325;20800.27199048026;20921.26775562848;19981.700274495895;20048.799512004985;20789.688154677693;20825.479363016046;21165.365039048855;11298.491567879466;11348.943255283672;11390.088792896548;11413.086953043736;11450.37022963745;7866.803329916569;7886.093099293655;7908.644111015134;7985.081715602548;7987.800304992422;17998.640027199646;18065.277388904822;18527.53681157928;18574.44276671702;18681.159347829653;18534.258629655204;18573.44279671612;18670.906645466686;18676.81323186751;18709.719354209425;12066.758664826479;12074.094442916992;12150.57472988441;12208.145429820182;12210;12908.483660653468;13677.726445471233;13692.726145477234;13693.794593081311;13719.657008574866;10885.346879187275;11014.944925275642;11058.778824423305;11244.493997770283;11458.140639452242;10256.692299231036;10351.482425878827;10456.424896630759;10467.110295624652;10545.420001899969;9485.146336829719;9573.664921727706;9597.760055998657;9606.567704453457;9642.276829237695;6755.527113102035;6857.691403886737;6898.827529311808;6903.827404314932;6926.168859736864;6889.689963951734;6944.548604340702;6954.826129346807;6960.095187625576;7041.612711300928 11:44:08 INFO - PID 19415 | |4;prototype.html;496.6721963504088;506.28117540948483;526.2369564132005;526.8603819987704;528.7197785173856;6057.212562366892;6219.378062193784;6344.143540622014;6384.170057892479;6424.903626445595;6226.9377306226925;6290.433860952513;6305.684715764216;6355.428011478966;6360.236771587404;5229.555487783534;5234.37187537496;5252.6323157379;5266.605004624649;5275.49882761139;5148.227765835118;5204.219367094947;5269.6311258211945;5271.472852714717;5328.46715328466;5228.973855130719;5256.290400795901;5268.4994925482015;5295.708736019517;5296.947030529684;5242.501962313574;5249.42256351801;5290.470952904717;5291.021161085211;5301.363836339626;4875.658703890729;4882.389701287339;4903.65674402792;4908.460069392364;4951;6346.524010699216;6356.523260755462;6370.936290637127;6394.13679153313;6420.486361091102;5990.251218597676;6057.939420605826;6060.787872424488;6063.454289114001;6130.662813545253;6636.170478690164;6651.339464214305;6712.83217919551;6746.62893540855;6747.595144291358;5282.867928301785;5312.362516498045;5313.734313284321;5321.015612111772;5335.839924802262;6901.585904845675;6979.30206979298;7012.544184627983;7029.891032690223;7109.36015758579;5380.740089162561;5430.51125398716;5481.314835645544;5506.063969125258;5549.306336707911;5633.295838020247;5648.604597678205;5652.519535839418;5654.5193658538665;5655.236543066716;6076.453119219292;6102.450779429784;6114.602550834182;6138.877222455526;6171.444569988723;6328.968355158195;6764.966175169093;6772.458203343721;6785.558938668971;6807.897881531781;1829.6369204942403;1848.1775609853755;1886.1512319456026;1905.8856468611928;1906.2375049979842;1403.333416627094;1415.4621243927243;1437.6621493948915;1443;1449.7752848308528;5674.943250567441;5686;5692.743826527816;5712.542996560265;5735.627184233095;6562.770303039466;6754.493412993947;6806;6814.931850681529;6817.5909445433435;5702.54379649627;5732.3121225453215;5751.4536119068625;5801.767929282866;5806.361300256968;3594.8202589870402;3600.351936651428;3617.113807117273;3621.1852333224815;3631.8365673544754;6430.421262086435;6588.637624930579;6593.703283352261;6600.207975042929;6620.205575330991;6815.761448349284;6866.107406037283;6881.41507971828;6902.93097069033;6979.755708550278;6573.967130164414;6574.441172500296;6647.268800431949;6653.068570400051;6653.367930046637;6803;6815.556988795713;6819.863602728017;6840.692168852314;6903.965480172567;6747.460203183831;6761.93238067613;6776.15298087739;6797.388235058671;6801.18385793708;6572.638504882278;6640.335966403321;6642.83392915181;6653.73385064592;6663;4999.400071991239;5023.773930173078;5037.219231019198;5049.899002020013;5077.299104799933;6433.420992110545;6891.655417229219;6899.965500172668;6905.689243984133;6912.792616221522;6278.811635650938;6562.671866406565;6573.825620730966;6576.506761992774;6612.173478315211;6427.453666438405;6600.491813111179;6604.603723776589;6626.304238054935;6642.634655094016;6382.234131904202;6447.774327898501;6472.190976127984;6536.673166341759;6541;6385.521085918482;6500.772472963424;6593.670316484061;6613.635000899383;6662.535481549664;6412.39082287182;6414.166158399378;6427.453666438218;6453.322401147811;6510.674466276762 11:44:08 INFO - PID 19415 | |5;yui.html;873.8645509945952;906.809569990302;906.8639704044397;916.7662246127237;929.1962452478606;16707.41524046657;17459.476215713534;17462.388816391427;17474.912625436857;17476.388326408578;15756.921215393906;16056.27746751396;16133.596660083504;16140.435084772036;16779.580510487245;931.7903471718843;934.0379409208526;935.1910597333292;937.2876613773548;938.4181807279463;947.0860619502179;948.4309414351369;949.539473355422;949.8242825077348;952.6379975609259;989.262999065697;1020.8979102089805;1032.5508403844315;1032.7831155457325;1033.7570670892335;1024.923130765188;1025.5795123999198;1025.8102251083574;1025.9948700256489;1028.819956507612;744.5309455043342;745.139364034541;745.608555508357;746.6192241956587;746.6416120262251;17762;17916.820831791774;18006.279748810033;18016.279348826032;18076.276948922157;19146.521336966547;19599.80400195994;19767.11048002829;19813.207471701116;19824.70262946057;17000.14999250045;17445.47663570095;17568.64862702739;17768.200430980636;17782.55543611407;3656.140806910374;3658.9085272868124;3685;3685.9262814743556;3691.7231207659265;137867;138334;140566;141645.99999999898;143153.2842335792;17019.82980170207;17157.656846863243;17305.65388692219;17307.480775576754;17364;30061.849690751842;31703.207419814687;31770.523442148387;31782.523262151088;31973.84013079966;8615.095414981462;8688.6524539019;8718.651253949898;8732.956335218283;8735.606897689619;4068.3083875741195;4208.326667733209;4218.451601291812;4222.408862759216;4235.512916014698;5124.69251844883;5160.7614172598305;5181.145111056709;5184.766685499161;5191.221316802435;1005.4821766790109;1040.1626690514058;1050.8896565860475;1058.2697938422618;1061.3366645846345;685.7359916432209;691.0567075941304;700.1178515071047;712.1311999360771;717.9353858152791;11175.105991520659;11236.550537978554;11845.644630661094;12588.622341329774;13026.80459793104;696.1611258433576;702.8734827730955;703.7255470366562;709.8438343564511;725.677073702208;5580.553555715533;5633.0705433603;5705.828825135252;5754.769809207585;5757.510611597977;123789.38105309416;124228;124314.37842810729;126628;130339;103323.4833825826;107457.54417852254;107888.46055769672;109055;113354.43322783333;90632;91923;93990;95089;95920.52039739757;10338.638147665097;10508.316959397614;10632.734181645212;10664.573417063231;10702.304350217522;43538.693839184874;44040.339394909744;44349;45903.77048114871;45911;55533.72233138808;55625.721871392;56400.15399769089;56414.15378769404;56811.431885682265;14915.776263356276;14982;15239.923800380928;15362.769558456408;15392.69214615679;15877.206139692738;15971.680566388839;16080.67838643244;16211.675766484368;16250.431234906722;14410.279486025447;14441.06133101345;14677.48628797987;14710.63223419423;14794.482193123189;14544;14688.55934321972;14774.77837832412;14790;14910.701785964004;14349;14644.780328294872;14725.852741472449;14748.262586870827;14803.407863685763;11718;11955.64133076009;11959.880401196224;12122.636320910387;12172;11590.246633968765;11689.941550292195;11760;11808.232464889754;11840.644780656594 11:44:08 INFO - PID 19415 | __end_tp_report 11:44:08 INFO - PID 19415 | __start_cc_report 11:44:08 INFO - PID 19415 | _x_x_mozilla_cycle_collect,366 11:44:08 INFO - PID 19415 | __end_cc_report 11:44:08 INFO - PID 19415 | __startTimestamp1505501048139__endTimestamp 11:44:08 INFO - PID 19415 | 11:44:08 INFO - PID 19415 | ------- Summary: start ------- 11:44:08 INFO - PID 19415 | Number of tests: 6 11:44:08 INFO - PID 19415 | 11:44:08 INFO - PID 19415 | [#0] dojo.html Cycles:165 Average:6161.61 Median:6450.74 stddev:833.08 (12.9%) stddev-sans-first:800.61 11:44:08 INFO - PID 19415 | Values: 3114.8 3156.7 3161.8 3179.9 3195.8 6044.7 6193.0 6204.0 6204.2 6322.6 6190.8 6190.8 6260.3 6408.8 6421.6 1330.2 5827.9 5851.5 5873.2 5931.4 5708.9 5785.1 5816.5 5838.7 5857.9 5653.7 5724.0 5767.2 5809.0 5836.2 5735.2 5737.9 5757.5 5801.0 5837.0 5725.5 5737.1 5771.1 5797.7 5808.6 6170.4 6203.5 6319.8 6339.7 6341.3 6521.8 6627.5 6728.5 6777.9 6791.1 6167.4 6707.3 6750.0 6780.9 6791.2 6254.1 6257.1 6263.2 6263.7 6298.6 6872.9 7018.9 7029.4 7047.1 7055.6 6529.3 6550.4 6557.1 6661.3 6683.6 6550.4 6633.3 6672.9 6684.0 6716.2 6631.4 6633.1 6638.7 6662.5 6683.2 6665.4 6675.3 6728.8 6747.3 6771.6 5263.1 5275.3 5299.4 5320.6 5349.0 4591.5 4627.1 4637.9 4653.1 4657.3 5642.9 5751.7 5753.6 5778.9 5837.6 6737.4 6773.7 6796.8 6821.2 6830.9 5760.7 5813.8 5835.9 5836.7 5849.3 5765.5 5767.9 5838.7 5846.2 5855.8 6337.8 6456.7 6466.6 6485.7 6593.7 6659.6 6682.3 6687.2 6700.7 6701.0 6455.4 6457.7 6470.3 6557.6 6613.9 6705.5 6749.1 6777.9 6785.4 6790.9 6833.0 6835.8 6913.8 6927.5 6943.6 6337.6 6366.2 6471.2 6524.8 6577.7 6621.5 6642.8 6653.5 6664.3 6683.5 6497.3 6575.6 6576.7 6578.0 6594.8 6618.1 6618.5 6629.7 6675.5 6726.5 6241.3 6342.7 6345.6 6450.7 6469.5 11:44:08 INFO - PID 19415 | 11:44:08 INFO - PID 19415 | [#1] ext.html Cycles:180 Average:34966.28 Median:3580.86 stddev:45789.56 (1278.7%) stddev-sans-first:45846.40 11:44:08 INFO - PID 19415 | Values: 863.6 878.6 879.2 880.2 890.1 37775.4 40885.8 41259.0 41322.6 41411.6 39338.2 39380.2 39419.2 39601.2 39695.4 7039.0 7156.7 7164.7 7172.7 7196.7 7039.8 7047.3 7049.2 7065.5 7085.7 7024.4 7057.6 7065.0 7097.1 7299.2 7821.3 7871.9 7879.9 7880.3 7890.3 7813.3 7859.1 7862.8 7865.8 7917.5 38305.4 38992.4 39150.4 39183.0 39211.6 3528.9 3577.5 3580.4 3580.5 3581.2 31723.7 31750.5 31834.2 31849.4 31877.5 5028.0 5049.5 5060.5 5064.2 5070.7 164117.0 179863.0 180164.0 180558.0 180648.0 42302.6 42304.4 46892.0 47174.0 47527.5 51179.7 51391.0 51444.5 51479.2 51499.5 16127.9 16132.0 16153.7 16171.1 16284.6 13141.5 13144.3 13277.4 13283.9 13302.5 13901.7 13925.1 13948.5 14015.9 14027.0 5658.3 5710.5 5719.3 5742.0 5788.6 1000.7 1014.6 1014.9 1021.2 1046.9 22678.1 22751.0 22866.0 22910.8 23166.2 1109.7 1111.3 1120.4 1121.2 1126.9 12110.2 12239.9 12309.5 12325.4 12344.9 209578.0 210815.0 210839.0 211133.0 211211.0 52363.0 52404.5 52408.0 52444.2 52730.7 1397.7 1459.8 1460.4 1463.7 1474.4 22600.7 22681.5 22686.5 23279.9 23450.6 37478.4 37506.4 37532.2 37534.0 37564.4 133010.0 133406.0 133562.0 133590.3 133848.0 34017.7 34893.8 35944.5 36122.5 36363.5 45322.1 46538.8 46590.0 46647.3 46895.0 33355.3 33564.3 33639.8 33754.6 33960.8 32950.8 33057.8 33103.3 33378.0 33483.7 36779.1 37027.0 37413.4 37581.0 37913.4 32473.0 32490.2 32635.5 32951.5 33165.2 23564.9 23715.3 23889.4 24348.8 24392.4 11:44:08 INFO - PID 19415 | 11:44:08 INFO - PID 19415 | [#2] jquery.html Cycles:180 Average:34588.37 Median:21983.06 stddev:79486.52 (361.6%) stddev-sans-first:79668.40 11:44:08 INFO - PID 19415 | Values: 541.6 568.2 568.4 582.3 585.7 22487.4 23294.7 23320.7 23380.6 23386.6 23526.6 24469.9 24822.6 24828.0 25272.9 6572.2 6715.5 6715.7 6717.6 6722.7 6365.2 6554.0 6648.8 6650.4 6654.3 6564.0 6629.5 6631.3 6631.9 6634.7 6538.3 6575.0 6584.1 6602.8 6890.9 7017.7 7027.0 7034.0 7041.1 7043.1 29460.9 30171.5 30173.8 30198.2 30205.7 2108.6 2130.2 2130.5 2137.0 2138.9 18649.2 18674.4 18698.3 18727.6 19187.2 2250.8 2252.2 2307.0 2307.6 2309.7 120540.4 126278.0 131539.0 136076.0 140805.3 20209.3 20808.3 20962.2 21495.7 21630.0 42147.6 42166.0 42252.8 42278.4 42419.6 11440.0 11564.3 11603.8 11604.4 11713.1 9503.0 9718.8 9775.8 9777.8 9900.9 10747.7 10826.7 10890.6 10959.1 11017.2 3957.0 4042.9 4043.9 4253.7 4274.1 923.9 950.0 957.8 960.6 978.4 18405.5 18946.6 18960.1 18989.1 19418.0 996.2 1002.9 1015.8 1017.9 1024.7 10287.4 10494.4 10529.8 10557.9 10870.5 461703.0 471073.0 477183.0 479064.0 481143.0 106784.0 108300.0 108866.0 109241.0 109342.5 1125.7 1132.8 1151.8 1153.9 1154.1 16669.0 16889.0 17005.9 17013.8 17089.4 53073.0 54164.5 54829.5 54954.5 55931.0 63801.4 64240.0 64316.0 64589.4 65466.0 19036.3 19297.8 19407.4 19605.9 19680.9 21837.9 21946.0 22020.1 22128.2 22468.8 16664.7 16892.8 17076.6 17136.2 17142.3 14867.9 15394.5 15465.8 15739.4 16112.5 17615.9 17632.6 17781.6 18030.7 18032.0 18827.8 18848.8 18913.2 18989.0 19073.7 17215.9 17400.8 17548.3 17650.9 17845.3 11:44:08 INFO - PID 19415 | 11:44:08 INFO - PID 19415 | [#3] mootools.html Cycles:180 Average:9299.02 Median:14829.43 stddev:6660.32 (44.9%) stddev-sans-first:6651.99 11:44:08 INFO - PID 19415 | Values: 1314.8 1388.8 1389.2 1394.2 1404.0 14873.5 15552.1 15573.4 15582.6 15589.5 15186.8 15302.1 15342.2 15348.7 15375.4 2711.3 2722.2 2768.4 2770.1 2776.5 2669.4 2691.8 2701.9 2708.6 2715.6 2701.3 2713.9 2714.4 2749.5 2825.6 2708.1 2747.5 2748.8 2752.7 2753.0 2502.1 2512.8 2536.5 2537.8 2539.5 14841.3 15023.3 15046.5 15048.5 15057.0 7952.8 8218.5 8225.7 8262.7 8267.2 5473.2 5665.2 5685.6 5751.0 5764.6 1892.7 1923.7 1950.7 1975.4 1998.6 26334.7 26627.2 26814.2 26827.0 26967.1 7253.7 7322.5 7359.6 7500.3 7523.8 19960.6 19993.9 20042.5 20077.9 20091.2 8010.3 8223.1 8248.6 8274.2 8304.7 7246.6 7253.6 7258.3 7355.1 7404.9 5438.9 5520.4 5591.1 5686.9 5689.2 1752.1 1781.8 1803.3 1832.4 1832.7 844.5 856.4 866.3 866.5 885.5 6989.7 7000.2 7012.2 7037.5 7057.0 691.5 701.1 718.6 723.7 728.3 4299.1 4671.8 5249.2 5314.6 5374.7 18671.7 20183.0 20696.9 20800.3 20921.3 19981.7 20048.8 20789.7 20825.5 21165.4 11298.5 11348.9 11390.1 11413.1 11450.4 7866.8 7886.1 7908.6 7985.1 7987.8 17998.6 18065.3 18527.5 18574.4 18681.2 18534.3 18573.4 18670.9 18676.8 18709.7 12066.8 12074.1 12150.6 12208.1 12210.0 12908.5 13677.7 13692.7 13693.8 13719.7 10885.3 11014.9 11058.8 11244.5 11458.1 10256.7 10351.5 10456.4 10467.1 10545.4 9485.1 9573.7 9597.8 9606.6 9642.3 6755.5 6857.7 6898.8 6903.8 6926.2 6889.7 6944.5 6954.8 6960.1 7041.6 11:44:08 INFO - PID 19415 | 11:44:08 INFO - PID 19415 | [#4] prototype.html Cycles:180 Average:5675.40 Median:6317.33 stddev:1526.80 (24.2%) stddev-sans-first:1480.78 11:44:08 INFO - PID 19415 | Values: 496.7 506.3 526.2 526.9 528.7 6057.2 6219.4 6344.1 6384.2 6424.9 6226.9 6290.4 6305.7 6355.4 6360.2 5229.6 5234.4 5252.6 5266.6 5275.5 5148.2 5204.2 5269.6 5271.5 5328.5 5229.0 5256.3 5268.5 5295.7 5296.9 5242.5 5249.4 5290.5 5291.0 5301.4 4875.7 4882.4 4903.7 4908.5 4951.0 6346.5 6356.5 6370.9 6394.1 6420.5 5990.3 6057.9 6060.8 6063.5 6130.7 6636.2 6651.3 6712.8 6746.6 6747.6 5282.9 5312.4 5313.7 5321.0 5335.8 6901.6 6979.3 7012.5 7029.9 7109.4 5380.7 5430.5 5481.3 5506.1 5549.3 5633.3 5648.6 5652.5 5654.5 5655.2 6076.5 6102.5 6114.6 6138.9 6171.4 6329.0 6765.0 6772.5 6785.6 6807.9 1829.6 1848.2 1886.2 1905.9 1906.2 1403.3 1415.5 1437.7 1443.0 1449.8 5674.9 5686.0 5692.7 5712.5 5735.6 6562.8 6754.5 6806.0 6814.9 6817.6 5702.5 5732.3 5751.5 5801.8 5806.4 3594.8 3600.4 3617.1 3621.2 3631.8 6430.4 6588.6 6593.7 6600.2 6620.2 6815.8 6866.1 6881.4 6902.9 6979.8 6574.0 6574.4 6647.3 6653.1 6653.4 6803.0 6815.6 6819.9 6840.7 6904.0 6747.5 6761.9 6776.2 6797.4 6801.2 6572.6 6640.3 6642.8 6653.7 6663.0 4999.4 5023.8 5037.2 5049.9 5077.3 6433.4 6891.7 6900.0 6905.7 6912.8 6278.8 6562.7 6573.8 6576.5 6612.2 6427.5 6600.5 6604.6 6626.3 6642.6 6382.2 6447.8 6472.2 6536.7 6541.0 6385.5 6500.8 6593.7 6613.6 6662.5 6412.4 6414.2 6427.5 6453.3 6510.7 11:44:08 INFO - PID 19415 | 11:44:08 INFO - PID 19415 | [#5] yui.html Cycles:180 Average:23974.07 Median:17522.52 stddev:35525.43 (202.7%) stddev-sans-first:35582.75 11:44:08 INFO - PID 19415 | Values: 873.9 906.8 906.9 916.8 929.2 16707.4 17459.5 17462.4 17474.9 17476.4 15756.9 16056.3 16133.6 16140.4 16779.6 931.8 934.0 935.2 937.3 938.4 947.1 948.4 949.5 949.8 952.6 989.3 1020.9 1032.6 1032.8 1033.8 1024.9 1025.6 1025.8 1026.0 1028.8 744.5 745.1 745.6 746.6 746.6 17762.0 17916.8 18006.3 18016.3 18076.3 19146.5 19599.8 19767.1 19813.2 19824.7 17000.1 17445.5 17568.6 17768.2 17782.6 3656.1 3658.9 3685.0 3685.9 3691.7 137867.0 138334.0 140566.0 141646.0 143153.3 17019.8 17157.7 17305.7 17307.5 17364.0 30061.8 31703.2 31770.5 31782.5 31973.8 8615.1 8688.7 8718.7 8733.0 8735.6 4068.3 4208.3 4218.5 4222.4 4235.5 5124.7 5160.8 5181.1 5184.8 5191.2 1005.5 1040.2 1050.9 1058.3 1061.3 685.7 691.1 700.1 712.1 717.9 11175.1 11236.6 11845.6 12588.6 13026.8 696.2 702.9 703.7 709.8 725.7 5580.6 5633.1 5705.8 5754.8 5757.5 123789.4 124228.0 124314.4 126628.0 130339.0 103323.5 107457.5 107888.5 109055.0 113354.4 90632.0 91923.0 93990.0 95089.0 95920.5 10338.6 10508.3 10632.7 10664.6 10702.3 43538.7 44040.3 44349.0 45903.8 45911.0 55533.7 55625.7 56400.2 56414.2 56811.4 14915.8 14982.0 15239.9 15362.8 15392.7 15877.2 15971.7 16080.7 16211.7 16250.4 14410.3 14441.1 14677.5 14710.6 14794.5 14544.0 14688.6 14774.8 14790.0 14910.7 14349.0 14644.8 14725.9 14748.3 14803.4 11718.0 11955.6 11959.9 12122.6 12172.0 11590.2 11689.9 11760.0 11808.2 11840.6 11:44:08 INFO - PID 19415 | -------- Summary: end -------- 11:44:08 INFO - PID 19415 | 11:44:08 INFO - TEST-INFO | 19415: exit 0 11:44:08 INFO - TEST-OK | dromaeo_css | took 1109707ms 11:44:08 INFO - TEST-START | kraken 11:44:08 INFO - Initialising browser for kraken test... 11:44:08 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49331/getInfo.html -profile /tmp/tmpY3kkay/profile 11:44:08 INFO - TEST-INFO | started process 19786 (/builds/slave/test/build/application/firefox/firefox http://localhost:49331/getInfo.html) 11:44:13 INFO - TEST-INFO | 19786: exit 0 11:44:13 INFO - Browser initialized. 11:44:13 INFO - Running cycle 1/1 for kraken test... 11:44:13 INFO - Using env: {'DISPLAY': ':0', 11:44:13 INFO - 'HOME': '/home/cltbld', 11:44:13 INFO - 'JSGC_DISABLE_POISONING': '1', 11:44:13 INFO - 'LANG': 'en_US.UTF-8', 11:44:13 INFO - 'LANGUAGE': 'en_US:en', 11:44:13 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:44:13 INFO - 'LOGNAME': 'cltbld', 11:44:13 INFO - 'MAIL': '/var/mail/cltbld', 11:44:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:44:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:44:13 INFO - 'MOZ_CRASHREPORTER': '1', 11:44:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:13 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:44:13 INFO - 'MOZ_NO_REMOTE': '1', 11:44:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:44:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:44:13 INFO - 'NO_EM_RESTART': '1', 11:44:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:44:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:13 INFO - 'PWD': '/builds/slave/test', 11:44:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:44:13 INFO - 'RUST_BACKTRACE': 'full', 11:44:13 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:44:13 INFO - 'SHELL': '/bin/bash', 11:44:13 INFO - 'SHLVL': '1', 11:44:13 INFO - 'TERM': 'linux', 11:44:13 INFO - 'TMOUT': '86400', 11:44:13 INFO - 'USER': 'cltbld', 11:44:13 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505496840.176425-926818285', 11:44:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:13 INFO - '_': '/tools/buildbot/bin/python'} 11:44:13 INFO - TEST-INFO | started process 20019 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY3kkay/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:44:14 INFO - PID 20019 | 11:44:14 INFO - PID 20019 | (/builds/slave/test/build/application/firefox/firefox:20068): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:44:14 INFO - PID 20019 | 11:44:25 INFO - PID 20019 | RSS: Main: 173694976 11:44:25 INFO - PID 20019 | 11:44:27 INFO - PID 20019 | Cycle 1(1): loaded http://localhost:49331/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49331/tests/kraken/driver.html?testName=audio-beat-detection) 11:44:28 INFO - PID 20019 | RSS: Main: 178278400 11:44:28 INFO - PID 20019 | 11:44:31 INFO - PID 20019 | Cycle 1(1): loaded http://localhost:49331/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49331/tests/kraken/driver.html?testName=audio-dft) 11:44:32 INFO - PID 20019 | RSS: Main: 178962432 11:44:32 INFO - PID 20019 | 11:44:35 INFO - PID 20019 | Cycle 1(1): loaded http://localhost:49331/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49331/tests/kraken/driver.html?testName=audio-fft) 11:44:35 INFO - PID 20019 | RSS: Main: 174444544 11:44:35 INFO - PID 20019 | 11:44:37 INFO - PID 20019 | Cycle 1(1): loaded http://localhost:49331/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49331/tests/kraken/driver.html?testName=audio-oscillator) 11:44:38 INFO - PID 20019 | RSS: Main: 175218688 11:44:38 INFO - PID 20019 | 11:44:40 INFO - PID 20019 | Cycle 1(1): loaded http://localhost:49331/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49331/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:44:41 INFO - PID 20019 | RSS: Main: 175181824 11:44:41 INFO - PID 20019 | 11:44:44 INFO - PID 20019 | Cycle 1(1): loaded http://localhost:49331/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49331/tests/kraken/driver.html?testName=imaging-darkroom) 11:44:44 INFO - PID 20019 | RSS: Main: 177938432 11:44:44 INFO - PID 20019 | 11:44:48 INFO - PID 20019 | Cycle 1(1): loaded http://localhost:49331/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49331/tests/kraken/driver.html?testName=imaging-desaturate) 11:44:49 INFO - PID 20019 | RSS: Main: 177713152 11:44:49 INFO - PID 20019 | 11:44:52 INFO - PID 20019 | Cycle 1(1): loaded http://localhost:49331/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49331/tests/kraken/driver.html?testName=json-parse-financial) 11:44:52 INFO - PID 20019 | RSS: Main: 178094080 11:44:52 INFO - PID 20019 | 11:44:54 INFO - PID 20019 | Cycle 1(1): loaded http://localhost:49331/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49331/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:44:55 INFO - PID 20019 | RSS: Main: 177991680 11:44:55 INFO - PID 20019 | 11:44:56 INFO - PID 20019 | Cycle 1(1): loaded http://localhost:49331/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49331/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:44:57 INFO - PID 20019 | RSS: Main: 178249728 11:44:57 INFO - PID 20019 | 11:44:59 INFO - PID 20019 | Cycle 1(1): loaded http://localhost:49331/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49331/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:45:00 INFO - PID 20019 | RSS: Main: 175136768 11:45:00 INFO - PID 20019 | 11:45:02 INFO - PID 20019 | Cycle 1(1): loaded http://localhost:49331/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49331/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:45:03 INFO - PID 20019 | RSS: Main: 175529984 11:45:03 INFO - PID 20019 | 11:45:06 INFO - PID 20019 | Cycle 1(1): loaded http://localhost:49331/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49331/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:45:07 INFO - PID 20019 | RSS: Main: 175333376 11:45:07 INFO - PID 20019 | 11:45:08 INFO - PID 20019 | Cycle 1(1): loaded http://localhost:49331/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49331/tests/kraken/driver.html?testName=ai-astar) 11:45:09 INFO - PID 20019 | RSS: Main: 176828416 11:45:09 INFO - PID 20019 | 11:45:09 INFO - PID 20019 | __start_tp_report 11:45:09 INFO - PID 20019 | _x_x_mozilla_page_load 11:45:09 INFO - PID 20019 | _x_x_mozilla_page_load_details 11:45:09 INFO - PID 20019 | |i|pagename|runs| 11:45:09 INFO - PID 20019 | |0;ai-astar;107;106;107;109;108;109;111;110;108;109 11:45:09 INFO - PID 20019 | |1;audio-beat-detection;117;117;117;120;116;118;119;117;115;116 11:45:09 INFO - PID 20019 | |2;audio-dft;163;163;163;163;162;163;168;172;170;165 11:45:09 INFO - PID 20019 | |3;audio-fft;74;77;74;76;78;74;75;73;74;81 11:45:09 INFO - PID 20019 | |4;audio-oscillator;80;80;81;82;79;79;78;78;79;78 11:45:09 INFO - PID 20019 | |5;imaging-gaussian-blur;113;110;114;115;113;117;114;114;115;113 11:45:09 INFO - PID 20019 | |6;imaging-darkroom;148;148;147;148;150;149;148;149;147;149 11:45:09 INFO - PID 20019 | |7;imaging-desaturate;98;95;94;94;95;95;94;94;94;98 11:45:09 INFO - PID 20019 | |8;json-parse-financial;55;55;52;53;54;53;55;54;56;54 11:45:09 INFO - PID 20019 | |9;json-stringify-tinderbox;39;38;38;38;39;37;38;38;38;39 11:45:09 INFO - PID 20019 | |10;stanford-crypto-aes;79;75;76;75;75;78;75;75;74;75 11:45:09 INFO - PID 20019 | |11;stanford-crypto-ccm;112;114;111;112;113;120;119;112;115;114 11:45:09 INFO - PID 20019 | |12;stanford-crypto-pbkdf2;172;170;172;173;179;180;176;175;176;175 11:45:09 INFO - PID 20019 | |13;stanford-crypto-sha256-iterative;66;68;64;65;67;63;66;71;66;64 11:45:09 INFO - PID 20019 | __end_tp_report 11:45:09 INFO - PID 20019 | __start_cc_report 11:45:09 INFO - PID 20019 | _x_x_mozilla_cycle_collect,948 11:45:09 INFO - PID 20019 | __end_cc_report 11:45:09 INFO - PID 20019 | __startTimestamp1505501109149__endTimestamp 11:45:09 INFO - PID 20019 | 11:45:09 INFO - PID 20019 | ------- Summary: start ------- 11:45:09 INFO - PID 20019 | Number of tests: 14 11:45:09 INFO - PID 20019 | 11:45:09 INFO - PID 20019 | [#0] ai-astar Cycles:10 Average:108.40 Median:109.00 stddev:1.51 (1.4%) stddev-sans-first:1.51 11:45:09 INFO - PID 20019 | Values: 107.0 106.0 107.0 109.0 108.0 109.0 111.0 110.0 108.0 109.0 11:45:09 INFO - PID 20019 | 11:45:09 INFO - PID 20019 | [#1] audio-beat-detection Cycles:10 Average:117.20 Median:117.00 stddev:1.48 (1.3%) stddev-sans-first:1.56 11:45:09 INFO - PID 20019 | Values: 117.0 117.0 117.0 120.0 116.0 118.0 119.0 117.0 115.0 116.0 11:45:09 INFO - PID 20019 | 11:45:09 INFO - PID 20019 | [#2] audio-dft Cycles:10 Average:165.20 Median:164.00 stddev:3.52 (2.1%) stddev-sans-first:3.64 11:45:09 INFO - PID 20019 | Values: 163.0 163.0 163.0 163.0 162.0 163.0 168.0 172.0 170.0 165.0 11:45:09 INFO - PID 20019 | 11:45:09 INFO - PID 20019 | [#3] audio-fft Cycles:10 Average:75.60 Median:75.50 stddev:2.46 (3.3%) stddev-sans-first:2.54 11:45:09 INFO - PID 20019 | Values: 74.0 77.0 74.0 76.0 78.0 74.0 75.0 73.0 74.0 81.0 11:45:09 INFO - PID 20019 | 11:45:09 INFO - PID 20019 | [#4] audio-oscillator Cycles:10 Average:79.40 Median:79.50 stddev:1.35 (1.7%) stddev-sans-first:1.41 11:45:09 INFO - PID 20019 | Values: 80.0 80.0 81.0 82.0 79.0 79.0 78.0 78.0 79.0 78.0 11:45:09 INFO - PID 20019 | 11:45:09 INFO - PID 20019 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:1.81 (1.6%) stddev-sans-first:1.90 11:45:09 INFO - PID 20019 | Values: 113.0 110.0 114.0 115.0 113.0 117.0 114.0 114.0 115.0 113.0 11:45:09 INFO - PID 20019 | 11:45:09 INFO - PID 20019 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 11:45:09 INFO - PID 20019 | Values: 148.0 148.0 147.0 148.0 150.0 149.0 148.0 149.0 147.0 149.0 11:45:09 INFO - PID 20019 | 11:45:09 INFO - PID 20019 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:1.60 (1.7%) stddev-sans-first:1.30 11:45:09 INFO - PID 20019 | Values: 98.0 95.0 94.0 94.0 95.0 95.0 94.0 94.0 94.0 98.0 11:45:09 INFO - PID 20019 | 11:45:09 INFO - PID 20019 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.50 stddev:1.20 (2.2%) stddev-sans-first:1.22 11:45:09 INFO - PID 20019 | Values: 55.0 55.0 52.0 53.0 54.0 53.0 55.0 54.0 56.0 54.0 11:45:09 INFO - PID 20019 | 11:45:09 INFO - PID 20019 | [#9] json-stringify-tinderbox Cycles:10 Average:38.20 Median:38.00 stddev:0.63 (1.7%) stddev-sans-first:0.60 11:45:09 INFO - PID 20019 | Values: 39.0 38.0 38.0 38.0 39.0 37.0 38.0 38.0 38.0 39.0 11:45:09 INFO - PID 20019 | 11:45:09 INFO - PID 20019 | [#10] stanford-crypto-aes Cycles:10 Average:75.70 Median:75.00 stddev:1.57 (2.1%) stddev-sans-first:1.12 11:45:09 INFO - PID 20019 | Values: 79.0 75.0 76.0 75.0 75.0 78.0 75.0 75.0 74.0 75.0 11:45:09 INFO - PID 20019 | 11:45:09 INFO - PID 20019 | [#11] stanford-crypto-ccm Cycles:10 Average:114.20 Median:114.00 stddev:3.05 (2.7%) stddev-sans-first:3.13 11:45:09 INFO - PID 20019 | Values: 112.0 114.0 111.0 112.0 113.0 120.0 119.0 112.0 115.0 114.0 11:45:09 INFO - PID 20019 | 11:45:09 INFO - PID 20019 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.80 Median:175.50 stddev:3.16 (1.8%) stddev-sans-first:3.18 11:45:09 INFO - PID 20019 | Values: 172.0 170.0 172.0 173.0 179.0 180.0 176.0 175.0 176.0 175.0 11:45:09 INFO - PID 20019 | 11:45:09 INFO - PID 20019 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:2.31 (3.5%) stddev-sans-first:2.45 11:45:09 INFO - PID 20019 | Values: 66.0 68.0 64.0 65.0 67.0 63.0 66.0 71.0 66.0 64.0 11:45:09 INFO - PID 20019 | -------- Summary: end -------- 11:45:09 INFO - PID 20019 | 11:45:09 INFO - PID 20019 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:45:09 INFO - TEST-INFO | 20019: exit 0 11:45:09 INFO - TEST-OK | kraken | took 60994ms 11:45:09 INFO - SUITE-END | took 1170s 11:45:10 INFO - Completed test suite (00:19:31) 11:45:10 INFO - javascript benchmark 11:45:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8548.113499945084, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3114.844257787113, 3156.6685498022707, 3161.762867784915, 3179.8728050877967, 3195.80825150491, 6044.697765111749, 6193.0, 6203.9689801550985, 6204.193454850869, 6322.589031712935, 6190.75236990521, 6190.761847630481, 6260.311365749764, 6408.7756928507515, 6421.550491465599, 1330.1785656516292, 5827.883442331151, 5851.531877449794, 5873.207117039209, 5931.436513531207, 5708.857278568048, 5785.074388097905, 5816.476517113459, 5838.708064596774, 5857.85355366115, 5653.660780353151, 5723.971380143073, 5767.192593036978, 5809.041508151171, 5836.212111364954, 5735.1684005818925, 5737.913931290992, 5757.453041961007, 5801.0428279333855, 5836.978528757493, 5725.456081672234, 5737.139429085629, 5771.134329850514, 5797.710114494301, 5808.6224395414165, 6170.413810687977, 6203.503719702413, 6319.8104056878365, 6339.714712837934, 6341.302456729756, 6521.771737989147, 6627.502937279675, 6728.529002969794, 6777.898331525031, 6791.117154769898, 6167.414095660905, 6707.329267073303, 6750.0, 6780.864382712318, 6791.185057793096, 6254.124422580842, 6257.092721555395, 6263.24841019076, 6263.71813268404, 6298.622082675054, 6872.896906546406, 7018.929810701828, 7029.3673569379, 7047.119110111236, 7055.6472176392, 6529.2817790043055, 6550.443212327005, 6557.114789503451, 6661.3005634408655, 6683.6324002180345, 6550.377714117151, 6633.336666333328, 6672.866542669217, 6683.966580167068, 6716.1604799400075, 6631.403173714389, 6633.104530888365, 6638.734450622018, 6662.533622646368, 6683.164604424447, 6665.366790154928, 6675.265720770712, 6728.764493242811, 6747.291534388916, 6771.559848609824, 5263.105272103751, 5275.314209152785, 5299.3905700844125, 5320.600954928396, 5349.0, 4591.494935557086, 4627.051454451829, 4637.884052898705, 4653.069386122789, 4657.347971284023, 5642.85892852682, 5751.683657398883, 5753.597248192586, 5778.913316300259, 5837.562182836305, 6737.393634572912, 6773.729050837911, 6796.76211332601, 6821.249662537117, 6830.897536536956, 5760.654360738369, 5813.79651712188, 5835.941640583625, 5836.737346819404, 5849.268841394825, 5765.4522820332, 5767.88464230713, 5838.737256823453, 5846.210761547221, 5855.765769369177, 6337.7781777637565, 6456.677166141674, 6466.579672321284, 6485.70814313357, 6593.703283352261, 6659.60042397448, 6682.3317668232785, 6687.230968438497, 6700.731970721312, 6700.966495167493, 6455.419012288917, 6457.709403076967, 6470.255920569007, 6557.639329836905, 6613.867722645617, 6705.497087718538, 6749.122614060141, 6777.8983315249325, 6785.423239024541, 6790.898136527857, 6832.965835170792, 6835.7949261522235, 6913.827154321182, 6927.480438966997, 6943.583384996917, 6337.588056776295, 6366.172397588284, 6471.158749362553, 6524.804255872332, 6577.736890524326, 6621.536492445675, 6642.83392915181, 6653.500987425866, 6664.266930637723, 6683.465322774264, 6497.285298617054, 6575.638339891352, 6576.736930522917, 6578.046183303299, 6594.802155935329, 6618.139641846529, 6618.470522358103, 6629.701663425061, 6675.499337549801, 6726.529142959946, 6241.282252541016, 6342.651154186564, 6345.619262844244, 6450.741970321134, 6469.547131700736], "value": 6101.578371594749, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [863.5768473448012, 878.5519385113594, 879.1779685993597, 880.1946219209424, 890.1410139215658, 37775.43336849946, 40885.79557102214, 41259.0, 41322.58677413225, 41411.58588414115, 39338.21323573527, 39380.21239575207, 39419.211615767665, 39601.207975840465, 39695.404568931415, 7038.964805175967, 7156.713731450762, 7164.713411463561, 7172.748953786619, 7196.748113816017, 7039.788806335818, 7047.295270472938, 7049.224585295613, 7065.470089743264, 7085.7165713371405, 7024.438044956391, 7057.647117644123, 7064.964675176642, 7097.148342198943, 7299.233580474053, 7821.256980586835, 7871.9212807872045, 7879.921200787976, 7880.290773830326, 7890.250426209501, 7813.257740514642, 7859.096203936563, 7862.764117076496, 7865.764027079197, 7917.524948503108, 38305.425418618746, 38992.41511377331, 39150.41274380887, 39183.0, 39211.60788392108, 3528.858845646171, 3577.463380492921, 3580.427131658948, 3580.480830279621, 3581.230035542371, 31723.682763172303, 31750.523742143887, 31834.204144896332, 31849.363012739614, 31877.521837172462, 5028.0, 5049.4950504949575, 5060.493950604947, 5064.18972964324, 5070.670406423571, 164117.0, 179863.0, 180163.9999999987, 180558.0, 180648.0, 42302.57697423048, 42304.365434518506, 46892.0, 47174.0, 47527.52472475231, 51179.744101279255, 51391.0, 51444.48555514472, 51479.22781158286, 51499.48500515022, 16127.919360403122, 16132.0, 16153.676926461405, 16171.110588917487, 16284.592885177964, 13141.474341026444, 13144.277064761338, 13277.402516886763, 13283.933580332037, 13302.534411295559, 13901.721965560631, 13925.094868833696, 13948.511802086878, 14015.85984140166, 14027.0, 5658.321001479849, 5710.5146062585145, 5719.256496655491, 5742.0, 5788.623739457006, 1000.7097941596855, 1014.5840205515703, 1014.8629934958834, 1021.22897212604, 1046.858674079005, 22678.092876284765, 22751.0, 22866.0, 22910.770892290864, 23166.1891833785, 1109.6948339206783, 1111.2776695148057, 1120.434180738738, 1121.2151493954264, 1126.887311268883, 12110.152289339661, 12239.93880030612, 12309.507619695112, 12325.383730813603, 12344.938275308745, 209578.0, 210815.0, 210839.0, 211133.0, 211211.0, 52362.95274094573, 52404.47595524072, 52408.0, 52444.21333679998, 52730.73634631802, 1397.7204559088223, 1459.7664973097715, 1460.3866376122055, 1463.6633574277762, 1474.4470823441209, 22600.66099008549, 22681.546369072195, 22686.546269074195, 23279.883600582565, 23450.64824027675, 37478.43782343213, 37506.437403438424, 37532.24935501329, 37534.0, 37564.43653345147, 133010.0, 133406.0, 133562.0, 133590.33204833913, 133848.0, 34017.65982340244, 34893.8255308732, 35944.460833087, 36122.458163128096, 36363.45454818233, 45322.09355812931, 46538.76730616325, 46590.0, 46647.30029049635, 46895.0, 33355.332893342485, 33564.32871342511, 33639.83180084084, 33754.63717539847, 33960.83019584886, 32950.83524582458, 33057.83471082629, 33103.33793324168, 33378.0, 33483.66516334806, 36779.08052298714, 37027.0, 37413.438798417505, 37581.0, 37913.4312985311, 32473.0, 32490.187745306557, 32635.510467343483, 32951.50572741363, 33165.17087072843, 23564.882175589697, 23715.288541343787, 23889.402764931016, 24348.756512434647, 24392.390190245387], "value": 16890.352793720765, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.6026651239802, 568.2016766443144, 568.3918207517958, 582.3477704970434, 585.6720236667467, 22487.437814054658, 23294.65058024127, 23320.65019024716, 23380.64929026066, 23386.64920026201, 23526.647100293467, 24469.87765061172, 24822.627660585105, 24828.0, 25272.87363563184, 6572.211334639838, 6715.496337774662, 6715.664216789165, 6717.63053032083, 6722.663866806664, 6365.204349456318, 6554.0, 6648.833779155511, 6650.3682150195655, 6654.268030516663, 6564.0, 6629.4696424286185, 6631.303713110126, 6631.933680663204, 6634.734610615569, 6538.313477084909, 6574.967125164391, 6584.078229047937, 6602.768903088393, 6890.862182756367, 7017.684204210823, 7027.0, 7033.964830175868, 7041.084658994349, 7043.084399028145, 29460.852695736383, 30171.547426788617, 30173.849130754425, 30198.24504387386, 30205.697943020507, 2108.5572029873747, 2130.222468798893, 2130.478032881954, 2136.957260854774, 2138.893055347242, 18649.160787764584, 18674.439766807016, 18698.34555790541, 18727.62544749111, 19187.232510699556, 2250.8199344052437, 2252.234240358286, 2306.953860922789, 2307.619242824932, 2309.711286089239, 120540.39729801382, 126278.0, 131539.0, 136076.0, 140805.2959735205, 20209.292674756605, 20808.27171049006, 20962.161513539286, 21495.67756483654, 21630.0, 42147.57852421437, 42166.0, 42252.78873605612, 42278.36582451266, 42419.57580424218, 11440.0, 11564.306141631361, 11603.825942610867, 11604.361760103275, 11713.121515886343, 9503.0, 9718.805623887483, 9775.755606109904, 9777.804443911082, 9900.900990990142, 10747.656542932133, 10826.729331766612, 10890.61882834097, 10959.0684791792, 11017.173711971634, 3956.9802150989635, 4042.919141617151, 4043.939340909889, 4253.7480978870835, 4274.140748774231, 923.9168474837297, 949.9952500237455, 957.8170958865795, 960.6157536985262, 978.4471773448122, 18405.53986150357, 18946.62106757857, 18960.14679339433, 18989.05054747285, 19418.0, 996.1781530237583, 1002.9297949143636, 1015.7816069544936, 1017.8524114003576, 1024.7335692719946, 10287.382757034602, 10494.370337779757, 10529.78643686774, 10557.9472102639, 10870.510827012804, 461703.0, 471073.0, 477183.0, 479064.0, 481143.0, 106784.0, 108300.0, 108866.0, 109241.0, 109342.45328773305, 1125.6848082536903, 1132.7904337697553, 1151.8099513580332, 1153.8557680289964, 1154.1055681846635, 16669.0, 16889.0, 17005.91497042507, 17013.829861701226, 17089.401870934456, 53073.0, 54164.45835541752, 54829.45170548243, 54954.45045549493, 55931.0, 63801.36198637954, 64240.0, 64316.0, 64589.35410646021, 65466.0, 19036.33372831944, 19297.807021929602, 19407.417777466697, 19605.901970490628, 19680.90159549193, 21837.890810545847, 21946.0, 22020.11919523201, 22128.225512106997, 22468.775312246667, 16664.66670666604, 16892.831071689125, 17076.573085672957, 17136.228869701143, 17142.314307428063, 14867.92566037163, 15394.461193858162, 15465.768013479581, 15739.370425182864, 16112.516624501284, 17615.911920440314, 17632.647347053244, 17781.577473801804, 18030.729539057185, 18032.0, 18827.811721882605, 18848.811511884705, 18913.243470261037, 18989.0, 19073.71389429132, 17215.913920430317, 17400.82599174043, 17548.298068077132, 17650.91174544119, 17845.286188552313], "value": 12516.22999318484, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1314.8422189337277, 1388.7569675306818, 1389.2012093046494, 1394.2471065624563, 1404.0, 14873.479428220015, 15552.144632045247, 15573.377064917418, 15582.610434739123, 15589.532314030597, 15186.772198417033, 15302.081875087502, 15342.156181410019, 15348.6930261395, 15375.38498460063, 2711.2815103997455, 2722.1697382298344, 2768.418632087264, 2770.141256210581, 2776.4585905748286, 2669.4454693218145, 2691.8115731898774, 2701.8649067546644, 2708.580170073632, 2715.551933930909, 2701.3246688327918, 2713.8507382093976, 2714.4028313770937, 2749.477599256145, 2825.6044153818484, 2708.1063249127837, 2747.5466548019554, 2748.7663548598393, 2752.683441404244, 2753.022676949674, 2502.099244272061, 2512.8366656167473, 2536.467341858212, 2537.7716005559405, 2539.517491676594, 14841.332140053724, 15023.323950422257, 15046.473373431878, 15048.473303434328, 15057.02129361599, 7952.801179970489, 8218.465799723059, 8225.670973161066, 8262.710805121791, 8267.173282671745, 5473.151661492475, 5665.1502274658715, 5685.59051640726, 5750.971245143789, 5764.5676574257095, 1892.706630472279, 1923.740295060163, 1950.7073938909136, 1975.4073777866727, 1998.590288990768, 26334.708161479815, 26627.201183964513, 26814.195574132806, 26827.0, 26967.05615303455, 7253.746118885813, 7322.524035937647, 7359.632018399058, 7500.287472690085, 7523.8119047023165, 19960.60078798416, 19993.900030500045, 20042.498937526678, 20077.899610501852, 20091.196352146042, 8010.3191228745045, 8223.095459499451, 8248.587570621445, 8274.172582741798, 8304.70933517324, 7246.6376681166785, 7253.56478611285, 7258.346748792528, 7355.080614923135, 7404.851902961911, 5438.864028399322, 5520.3651580068, 5591.077472217039, 5686.857828554236, 5689.175069614883, 1752.0801579171036, 1781.7950935642307, 1803.2877013579562, 1832.44110546282, 1832.7250912362986, 844.4890841041205, 856.3876828067837, 866.3415803989013, 866.5104216117874, 885.526243459746, 6989.650517474106, 7000.229974702778, 7012.228654848064, 7037.542559733601, 7056.964715176391, 691.4675699711195, 701.0780823217452, 718.5760401363116, 723.6562632749402, 728.3226599262737, 4299.07569872479, 4671.789769460383, 5249.186376111708, 5314.5748340132695, 5374.704391258519, 18671.71992420115, 20183.0, 20696.896515517325, 20800.27199048026, 20921.26775562848, 19981.700274495895, 20048.799512004985, 20789.688154677693, 20825.479363016046, 21165.365039048855, 11298.491567879466, 11348.943255283672, 11390.088792896548, 11413.086953043736, 11450.37022963745, 7866.803329916569, 7886.093099293655, 7908.644111015134, 7985.081715602548, 7987.800304992422, 17998.640027199646, 18065.277388904822, 18527.53681157928, 18574.44276671702, 18681.159347829653, 18534.258629655204, 18573.44279671612, 18670.906645466686, 18676.81323186751, 18709.719354209425, 12066.758664826479, 12074.094442916992, 12150.57472988441, 12208.145429820182, 12210.0, 12908.483660653468, 13677.726445471233, 13692.726145477234, 13693.794593081311, 13719.657008574866, 10885.346879187275, 11014.944925275642, 11058.778824423305, 11244.493997770283, 11458.140639452242, 10256.692299231036, 10351.482425878827, 10456.424896630759, 10467.110295624652, 10545.420001899969, 9485.146336829719, 9573.664921727706, 9597.760055998657, 9606.567704453457, 9642.276829237695, 6755.527113102035, 6857.691403886737, 6898.827529311808, 6903.827404314932, 6926.168859736864, 6889.689963951734, 6944.548604340702, 6954.826129346807, 6960.095187625576, 7041.612711300928], "value": 6622.1455340746825, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.6721963504088, 506.28117540948483, 526.2369564132005, 526.8603819987704, 528.7197785173856, 6057.212562366892, 6219.378062193784, 6344.143540622014, 6384.170057892479, 6424.903626445595, 6226.9377306226925, 6290.433860952513, 6305.684715764216, 6355.428011478966, 6360.236771587404, 5229.555487783534, 5234.37187537496, 5252.6323157379, 5266.605004624649, 5275.49882761139, 5148.227765835118, 5204.219367094947, 5269.6311258211945, 5271.472852714717, 5328.46715328466, 5228.973855130719, 5256.290400795901, 5268.4994925482015, 5295.708736019517, 5296.947030529684, 5242.501962313574, 5249.42256351801, 5290.470952904717, 5291.021161085211, 5301.363836339626, 4875.658703890729, 4882.389701287339, 4903.65674402792, 4908.460069392364, 4951.0, 6346.524010699216, 6356.523260755462, 6370.936290637127, 6394.13679153313, 6420.486361091102, 5990.251218597676, 6057.939420605826, 6060.787872424488, 6063.454289114001, 6130.662813545253, 6636.170478690164, 6651.339464214305, 6712.83217919551, 6746.62893540855, 6747.595144291358, 5282.867928301785, 5312.362516498045, 5313.734313284321, 5321.015612111772, 5335.839924802262, 6901.585904845675, 6979.30206979298, 7012.544184627983, 7029.891032690223, 7109.36015758579, 5380.740089162561, 5430.51125398716, 5481.314835645544, 5506.063969125258, 5549.306336707911, 5633.295838020247, 5648.604597678205, 5652.519535839418, 5654.5193658538665, 5655.236543066716, 6076.453119219292, 6102.450779429784, 6114.602550834182, 6138.877222455526, 6171.444569988723, 6328.968355158195, 6764.966175169093, 6772.458203343721, 6785.558938668971, 6807.897881531781, 1829.6369204942403, 1848.1775609853755, 1886.1512319456026, 1905.8856468611928, 1906.2375049979842, 1403.333416627094, 1415.4621243927243, 1437.6621493948915, 1443.0, 1449.7752848308528, 5674.943250567441, 5686.0, 5692.743826527816, 5712.542996560265, 5735.627184233095, 6562.770303039466, 6754.493412993947, 6806.0, 6814.931850681529, 6817.5909445433435, 5702.54379649627, 5732.3121225453215, 5751.4536119068625, 5801.767929282866, 5806.361300256968, 3594.8202589870402, 3600.351936651428, 3617.113807117273, 3621.1852333224815, 3631.8365673544754, 6430.421262086435, 6588.637624930579, 6593.703283352261, 6600.207975042929, 6620.205575330991, 6815.761448349284, 6866.107406037283, 6881.41507971828, 6902.93097069033, 6979.755708550278, 6573.967130164414, 6574.441172500296, 6647.268800431949, 6653.068570400051, 6653.367930046637, 6803.0, 6815.556988795713, 6819.863602728017, 6840.692168852314, 6903.965480172567, 6747.460203183831, 6761.93238067613, 6776.15298087739, 6797.388235058671, 6801.18385793708, 6572.638504882278, 6640.335966403321, 6642.83392915181, 6653.73385064592, 6663.0, 4999.400071991239, 5023.773930173078, 5037.219231019198, 5049.899002020013, 5077.299104799933, 6433.420992110545, 6891.655417229219, 6899.965500172668, 6905.689243984133, 6912.792616221522, 6278.811635650938, 6562.671866406565, 6573.825620730966, 6576.506761992774, 6612.173478315211, 6427.453666438405, 6600.491813111179, 6604.603723776589, 6626.304238054935, 6642.634655094016, 6382.234131904202, 6447.774327898501, 6472.190976127984, 6536.673166341759, 6541.0, 6385.521085918482, 6500.772472963424, 6593.670316484061, 6613.635000899383, 6662.535481549664, 6412.39082287182, 6414.166158399378, 6427.453666438218, 6453.322401147811, 6510.674466276762], "value": 5232.602696536684, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [873.8645509945952, 906.809569990302, 906.8639704044397, 916.7662246127237, 929.1962452478606, 16707.41524046657, 17459.476215713534, 17462.388816391427, 17474.912625436857, 17476.388326408578, 15756.921215393906, 16056.27746751396, 16133.596660083504, 16140.435084772036, 16779.580510487245, 931.7903471718843, 934.0379409208526, 935.1910597333292, 937.2876613773548, 938.4181807279463, 947.0860619502179, 948.4309414351369, 949.539473355422, 949.8242825077348, 952.6379975609259, 989.262999065697, 1020.8979102089805, 1032.5508403844315, 1032.7831155457325, 1033.7570670892335, 1024.923130765188, 1025.5795123999198, 1025.8102251083574, 1025.9948700256489, 1028.819956507612, 744.5309455043342, 745.139364034541, 745.608555508357, 746.6192241956587, 746.6416120262251, 17762.0, 17916.820831791774, 18006.279748810033, 18016.279348826032, 18076.276948922157, 19146.521336966547, 19599.80400195994, 19767.11048002829, 19813.207471701116, 19824.70262946057, 17000.14999250045, 17445.47663570095, 17568.64862702739, 17768.200430980636, 17782.55543611407, 3656.140806910374, 3658.9085272868124, 3685.0, 3685.9262814743556, 3691.7231207659265, 137867.0, 138334.0, 140566.0, 141645.99999999898, 143153.2842335792, 17019.82980170207, 17157.656846863243, 17305.65388692219, 17307.480775576754, 17364.0, 30061.849690751842, 31703.207419814687, 31770.523442148387, 31782.523262151088, 31973.84013079966, 8615.095414981462, 8688.6524539019, 8718.651253949898, 8732.956335218283, 8735.606897689619, 4068.3083875741195, 4208.326667733209, 4218.451601291812, 4222.408862759216, 4235.512916014698, 5124.69251844883, 5160.7614172598305, 5181.145111056709, 5184.766685499161, 5191.221316802435, 1005.4821766790109, 1040.1626690514058, 1050.8896565860475, 1058.2697938422618, 1061.3366645846345, 685.7359916432209, 691.0567075941304, 700.1178515071047, 712.1311999360771, 717.9353858152791, 11175.105991520659, 11236.550537978554, 11845.644630661094, 12588.622341329774, 13026.80459793104, 696.1611258433576, 702.8734827730955, 703.7255470366562, 709.8438343564511, 725.677073702208, 5580.553555715533, 5633.0705433603, 5705.828825135252, 5754.769809207585, 5757.510611597977, 123789.38105309416, 124228.0, 124314.37842810729, 126628.0, 130339.0, 103323.4833825826, 107457.54417852254, 107888.46055769672, 109055.0, 113354.43322783333, 90632.0, 91923.0, 93990.0, 95089.0, 95920.52039739757, 10338.638147665097, 10508.316959397614, 10632.734181645212, 10664.573417063231, 10702.304350217522, 43538.693839184874, 44040.339394909744, 44349.0, 45903.77048114871, 45911.0, 55533.72233138808, 55625.721871392, 56400.15399769089, 56414.15378769404, 56811.431885682265, 14915.776263356276, 14982.0, 15239.923800380928, 15362.769558456408, 15392.69214615679, 15877.206139692738, 15971.680566388839, 16080.67838643244, 16211.675766484368, 16250.431234906722, 14410.279486025447, 14441.06133101345, 14677.48628797987, 14710.63223419423, 14794.482193123189, 14544.0, 14688.55934321972, 14774.77837832412, 14790.0, 14910.701785964004, 14349.0, 14644.780328294872, 14725.852741472449, 14748.262586870827, 14803.407863685763, 11718.0, 11955.64133076009, 11959.880401196224, 12122.636320910387, 12172.0, 11590.246633968765, 11689.941550292195, 11760.0, 11808.232464889754, 11840.644780656594], "value": 8728.219586765155, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1426.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 106.0, 107.0, 109.0, 108.0, 109.0, 111.0, 110.0, 108.0, 109.0], "value": 108.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 120.0, 116.0, 118.0, 119.0, 117.0, 115.0, 116.0], "value": 117.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 163.0, 162.0, 163.0, 168.0, 172.0, 170.0, 165.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 74.0, 76.0, 78.0, 74.0, 75.0, 73.0, 74.0, 81.0], "value": 75.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 81.0, 82.0, 79.0, 79.0, 78.0, 78.0, 79.0, 78.0], "value": 79.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 110.0, 114.0, 115.0, 113.0, 117.0, 114.0, 114.0, 115.0, 113.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 148.0, 150.0, 149.0, 148.0, 149.0, 147.0, 149.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 98.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 52.0, 53.0, 54.0, 53.0, 55.0, 54.0, 56.0, 54.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 38.0, 38.0, 38.0, 39.0, 37.0, 38.0, 38.0, 38.0, 39.0], "value": 38.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 75.0, 76.0, 75.0, 75.0, 78.0, 75.0, 75.0, 74.0, 75.0], "value": 75.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 111.0, 112.0, 113.0, 120.0, 119.0, 112.0, 115.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 170.0, 172.0, 173.0, 179.0, 180.0, 176.0, 175.0, 176.0, 175.0], "value": 174.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 64.0, 65.0, 67.0, 63.0, 66.0, 71.0, 66.0, 64.0], "value": 66.0, "unit": "score"}]}]} 11:45:10 INFO - Return code: 0 11:45:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:45:10 INFO - # TBPL SUCCESS # 11:45:10 INFO - Running post-action listener: _package_coverage_data 11:45:10 INFO - Running post-action listener: _resource_record_post_action 11:45:10 INFO - [mozharness: 2017-09-15 18:45:10.434582Z] Finished run-tests step (success) 11:45:10 INFO - Running post-run listener: _resource_record_post_run 11:45:10 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 333324288; Read time: 8; Write time: 347252 11:45:10 INFO - TinderboxPrint: CPU usage
13.1% 11:45:10 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 11:45:10 INFO - TinderboxPrint: I/O write bytes / time
333,324,288 / 347,252 11:45:10 INFO - TinderboxPrint: CPU idle
8,234.9 (86.9%) 11:45:10 INFO - TinderboxPrint: CPU user
1,195.0 (12.6%) 11:45:10 INFO - TinderboxPrint: Swap in / out
0 / 0 11:45:10 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 9543680; Read time: 0; Write time: 1516 11:45:10 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:45:10 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 322854912; Read time: 0; Write time: 345600 11:45:11 INFO - Running post-run listener: _upload_blobber_files 11:45:11 INFO - Blob upload gear active. 11:45:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:45:11 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:45:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:45:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:45:11 INFO - (blobuploader) - INFO - Open directory for files ... 11:45:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:45:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:45:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:12 INFO - (blobuploader) - INFO - Done attempting. 11:45:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:45:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:45:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:19 INFO - (blobuploader) - INFO - Done attempting. 11:45:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:45:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:45:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:20 INFO - (blobuploader) - INFO - Done attempting. 11:45:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:45:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:21 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:45:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:21 INFO - (blobuploader) - INFO - Done attempting. 11:45:21 INFO - (blobuploader) - INFO - Iteration through files over. 11:45:21 INFO - Return code: 0 11:45:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:45:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:45:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8e0bbf34c317d9798bbb8fdf61fe0b30893332eb03b2219685fe02e4e71fbec3a9ab55df7b60104328e55e2629cd1fb61cf52e13c02333cdb407e42a1419f0e6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0ce317a595306df4e77615b212d9179936017cc8569a34ec0089c4fbab2f166739df924003b814d9c9077393b0417e25a9dddfa351a10517429c742088bd7ec6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/49621ea7cabed67b38187cf8fdc97946f640d41ce85f8c0d6b44080c63f77bf13cd1dd980a85e32568ac943dcd54351f981c13dc09722739fda4b2ed1778f120", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eedb03553238bfdb3b5cd550089862c4dc0327406c2ba5e7463c4a795330205fc537f426b45c0d33e9d40652578a19dd620f71a3614c99f20b786a10b923c8db"} 11:45:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:45:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:45:21 INFO - Contents: 11:45:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8e0bbf34c317d9798bbb8fdf61fe0b30893332eb03b2219685fe02e4e71fbec3a9ab55df7b60104328e55e2629cd1fb61cf52e13c02333cdb407e42a1419f0e6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0ce317a595306df4e77615b212d9179936017cc8569a34ec0089c4fbab2f166739df924003b814d9c9077393b0417e25a9dddfa351a10517429c742088bd7ec6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/49621ea7cabed67b38187cf8fdc97946f640d41ce85f8c0d6b44080c63f77bf13cd1dd980a85e32568ac943dcd54351f981c13dc09722739fda4b2ed1778f120", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eedb03553238bfdb3b5cd550089862c4dc0327406c2ba5e7463c4a795330205fc537f426b45c0d33e9d40652578a19dd620f71a3614c99f20b786a10b923c8db"} 11:45:21 INFO - Running post-run listener: copy_logs_to_upload_dir 11:45:21 INFO - Copying logs to upload dir... 11:45:21 INFO - mkdir: /builds/slave/test/build/upload/logs 11:45:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.841937 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-09-15 11:45:21.989416) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-15 11:45:21.994209) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1505496840.176425-926818285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8e0bbf34c317d9798bbb8fdf61fe0b30893332eb03b2219685fe02e4e71fbec3a9ab55df7b60104328e55e2629cd1fb61cf52e13c02333cdb407e42a1419f0e6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0ce317a595306df4e77615b212d9179936017cc8569a34ec0089c4fbab2f166739df924003b814d9c9077393b0417e25a9dddfa351a10517429c742088bd7ec6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/49621ea7cabed67b38187cf8fdc97946f640d41ce85f8c0d6b44080c63f77bf13cd1dd980a85e32568ac943dcd54351f981c13dc09722739fda4b2ed1778f120", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eedb03553238bfdb3b5cd550089862c4dc0327406c2ba5e7463c4a795330205fc537f426b45c0d33e9d40652578a19dd620f71a3614c99f20b786a10b923c8db"} build_url:https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011277 build_url: 'https://queue.taskcluster.net/v1/task/dGTWU5R0RMmqQFwWXFslJA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8e0bbf34c317d9798bbb8fdf61fe0b30893332eb03b2219685fe02e4e71fbec3a9ab55df7b60104328e55e2629cd1fb61cf52e13c02333cdb407e42a1419f0e6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0ce317a595306df4e77615b212d9179936017cc8569a34ec0089c4fbab2f166739df924003b814d9c9077393b0417e25a9dddfa351a10517429c742088bd7ec6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/49621ea7cabed67b38187cf8fdc97946f640d41ce85f8c0d6b44080c63f77bf13cd1dd980a85e32568ac943dcd54351f981c13dc09722739fda4b2ed1778f120", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eedb03553238bfdb3b5cd550089862c4dc0327406c2ba5e7463c4a795330205fc537f426b45c0d33e9d40652578a19dd620f71a3614c99f20b786a10b923c8db"}' ========= master_lag: 0.07 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-15 11:45:22.073334) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 11:45:22.073657) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1505496840.176425-926818285 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004568 ========= master_lag: 0.13 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 11:45:22.205471) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-15 11:45:22.205791) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-15 11:45:22.206093) ========= ========= Total master_lag: 0.50 =========