builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-068 starttime: 1504607591.45 results: success (0) revision: 3ecda4678c49ca255c38b1697142b9118cdd27e7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-05 03:33:11.452826) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-05 03:33:11.453262) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-05 03:33:11.453545) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-05 03:33:11.470798) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-05 03:33:11.471100) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1504607590.704876-831758737 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-05 03:33:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 98.9M=0s 2017-09-05 03:33:11 (98.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.084399 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-05 03:33:11.572166) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-05 03:33:11.572499) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1504607590.704876-831758737 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019520 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-05 03:33:11.621754) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-09-05 03:33:11.622149) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3ecda4678c49ca255c38b1697142b9118cdd27e7 --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 3ecda4678c49ca255c38b1697142b9118cdd27e7 --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=97facb8ba2ac28944cc45e6b000001d4-1504607590.704876-831758737 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-05 03:33:11,673 truncating revision to first 12 chars 2017-09-05 03:33:11,673 Setting DEBUG logging. 2017-09-05 03:33:11,673 attempt 1/10 2017-09-05 03:33:11,673 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3ecda4678c49?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-05 03:33:12,577 attempt 1/10 2017-09-05 03:33:13,065 current task status: no status available at this point. state: PENDING 2017-09-05 03:33:13,066 sleeping for 9.00s (attempt 1/10) 2017-09-05 03:33:22,075 attempt 2/10 2017-09-05 03:33:22,411 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-09-05 03:33:23,069 unpacking tar archive at: mozilla-central-3ecda4678c49/testing/mozharness/ program finished with exit code 0 elapsedTime=11.816935 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-09-05 03:33:23.457073) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-05 03:33:23.457442) ========= script_repo_revision: 3ecda4678c49ca255c38b1697142b9118cdd27e7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-05 03:33:23.457887) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-05 03:33:23.458192) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-05 03:33:23.472711) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-09-05 03:33:23.473541) ========= /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=97facb8ba2ac28944cc45e6b000001d4-1504607590.704876-831758737 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:33:23 INFO - MultiFileLogger online at 20170905 03:33:23 in /builds/slave/test 03:33:23 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 03:33:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:33:23 INFO - {'append_to_log': False, 03:33:23 INFO - 'base_work_dir': '/builds/slave/test', 03:33:23 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:33:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:33:23 INFO - 'branch': 'Firefox-Non-PGO', 03:33:23 INFO - 'buildbot_json_path': 'buildprops.json', 03:33:23 INFO - 'code_coverage': False, 03:33:23 INFO - 'config_files': ('talos/linux_config.py',), 03:33:23 INFO - 'default_actions': ('clobber', 03:33:23 INFO - 'read-buildbot-config', 03:33:23 INFO - 'download-and-extract', 03:33:23 INFO - 'populate-webroot', 03:33:23 INFO - 'create-virtualenv', 03:33:23 INFO - 'install', 03:33:23 INFO - 'setup-mitmproxy', 03:33:23 INFO - 'run-tests'), 03:33:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:33:23 INFO - 'disable_ccov_upload': False, 03:33:23 INFO - 'disable_stylo': False, 03:33:23 INFO - 'download_minidump_stackwalk': True, 03:33:23 INFO - 'download_symbols': 'ondemand', 03:33:23 INFO - 'enable_stylo': False, 03:33:23 INFO - 'enable_webrender': False, 03:33:23 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:33:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:33:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:33:23 INFO - 'gecko_profile': False, 03:33:23 INFO - 'gecko_profile_interval': 0, 03:33:23 INFO - 'installer_path': 'installer.exe', 03:33:23 INFO - 'log_level': 'info', 03:33:23 INFO - 'log_name': 'talos', 03:33:23 INFO - 'log_to_console': True, 03:33:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:33:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:33:23 INFO - 'opt_config_files': (), 03:33:23 INFO - 'pip_index': False, 03:33:23 INFO - 'suite': 'dromaeojs-e10s', 03:33:23 INFO - 'system_bits': '32', 03:33:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:33:23 INFO - 'title': 'talos-linux64-ix-068', 03:33:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:33:23 INFO - 'use_talos_json': True, 03:33:23 INFO - 'verify': 'False', 03:33:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:33:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:33:23 INFO - 'work_dir': 'build'} 03:33:23 INFO - [mozharness: 2017-09-05 10:33:23.675406Z] Running clobber step. 03:33:23 INFO - Running pre-action listener: _resource_record_pre_action 03:33:23 INFO - Running main action method: clobber 03:33:23 INFO - rmtree: /builds/slave/test/build 03:33:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:33:24 INFO - Running post-action listener: _resource_record_post_action 03:33:24 INFO - [mozharness: 2017-09-05 10:33:24.691177Z] Finished clobber step (success) 03:33:24 INFO - [mozharness: 2017-09-05 10:33:24.691275Z] Running read-buildbot-config step. 03:33:24 INFO - Running pre-action listener: _resource_record_pre_action 03:33:24 INFO - Running main action method: read_buildbot_config 03:33:24 INFO - Using buildbot properties: 03:33:24 INFO - { 03:33:24 INFO - "project": "", 03:33:24 INFO - "product": "firefox", 03:33:24 INFO - "who": "archaeopteryx@coole-files.de", 03:33:24 INFO - "installer_path": "public/build/target.tar.bz2", 03:33:24 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:33:24 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:33:24 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 03:33:24 INFO - "stage_platform": "linux64", 03:33:24 INFO - "basedir": "/builds/slave/test", 03:33:24 INFO - "buildnumber": 1115, 03:33:24 INFO - "platform": "ubuntu64_hw", 03:33:24 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:33:24 INFO - "slavebuilddir": "test", 03:33:24 INFO - "taskId": "Zh9pUblrQWSlXAVor50kTg", 03:33:24 INFO - "branch": "mozilla-central", 03:33:24 INFO - "script_repo_revision": "production", 03:33:24 INFO - "revision": "3ecda4678c49ca255c38b1697142b9118cdd27e7", 03:33:24 INFO - "slavename": "talos-linux64-ix-068", 03:33:24 INFO - "repo_path": "mozilla-central" 03:33:24 INFO - } 03:33:24 INFO - Finding installer, test and symbols from parent task. 03:33:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zh9pUblrQWSlXAVor50kTg'}, attempt #1 03:33:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zh9pUblrQWSlXAVor50kTg'}, attempt #1 03:33:25 INFO - Task dependencies: Oz77JHY8R46lR-xvwFHp5Q 03:33:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Oz77JHY8R46lR-xvwFHp5Q'}, attempt #1 03:33:26 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Oz77JHY8R46lR-xvwFHp5Q/artifacts/public/build/target.tar.bz2 03:33:26 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Oz77JHY8R46lR-xvwFHp5Q/artifacts/public/build/target.test_packages.json 03:33:26 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Oz77JHY8R46lR-xvwFHp5Q/artifacts/public/build/target.crashreporter-symbols.zip 03:33:26 INFO - Running post-action listener: _resource_record_post_action 03:33:26 INFO - [mozharness: 2017-09-05 10:33:26.142564Z] Finished read-buildbot-config step (success) 03:33:26 INFO - [mozharness: 2017-09-05 10:33:26.142782Z] Running download-and-extract step. 03:33:26 INFO - Running pre-action listener: _resource_record_pre_action 03:33:26 INFO - Running main action method: download_and_extract 03:33:26 INFO - mkdir: /builds/slave/test/build/tests 03:33:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:26 INFO - trying https://queue.taskcluster.net/v1/task/Oz77JHY8R46lR-xvwFHp5Q/artifacts/public/build/target.test_packages.json 03:33:26 INFO - Downloading https://queue.taskcluster.net/v1/task/Oz77JHY8R46lR-xvwFHp5Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:33:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Oz77JHY8R46lR-xvwFHp5Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:33:26 INFO - Downloaded 989 bytes. 03:33:26 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:33:26 INFO - Using the following test package requirements: 03:33:26 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:33:26 INFO - u'common': [u'target.common.tests.zip'], 03:33:26 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:33:26 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:33:26 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:33:26 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:33:26 INFO - u'mozbase': [u'target.common.tests.zip'], 03:33:26 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:33:26 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:33:26 INFO - u'web-platform': [u'target.common.tests.zip', 03:33:26 INFO - u'target.web-platform.tests.tar.gz'], 03:33:26 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:33:26 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:33:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Oz77JHY8R46lR-xvwFHp5Q/artifacts/public/build/target.common.tests.zip 03:33:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Oz77JHY8R46lR-xvwFHp5Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:33:26 INFO - Fetch https://queue.taskcluster.net/v1/task/Oz77JHY8R46lR-xvwFHp5Q/artifacts/public/build/target.common.tests.zip into memory 03:33:28 INFO - Content-Length response header: 55022230 03:33:28 INFO - Bytes received: 55022230 03:33:39 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:33:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Oz77JHY8R46lR-xvwFHp5Q/artifacts/public/build/target.common.tests.zip 03:33:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Oz77JHY8R46lR-xvwFHp5Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:33:39 INFO - Fetch https://queue.taskcluster.net/v1/task/Oz77JHY8R46lR-xvwFHp5Q/artifacts/public/build/target.common.tests.zip into memory 03:33:40 INFO - Content-Length response header: 55022230 03:33:40 INFO - Bytes received: 55022230 03:33:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Oz77JHY8R46lR-xvwFHp5Q/artifacts/public/build/target.talos.tests.zip 03:33:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Oz77JHY8R46lR-xvwFHp5Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:33:52 INFO - Fetch https://queue.taskcluster.net/v1/task/Oz77JHY8R46lR-xvwFHp5Q/artifacts/public/build/target.talos.tests.zip into memory 03:33:53 INFO - Content-Length response header: 14496650 03:33:53 INFO - Bytes received: 14496650 03:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:53 INFO - trying https://queue.taskcluster.net/v1/task/Oz77JHY8R46lR-xvwFHp5Q/artifacts/public/build/target.tar.bz2 03:33:53 INFO - Downloading https://queue.taskcluster.net/v1/task/Oz77JHY8R46lR-xvwFHp5Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:33:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Oz77JHY8R46lR-xvwFHp5Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:33:55 INFO - Downloaded 62687364 bytes. 03:33:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Oz77JHY8R46lR-xvwFHp5Q/artifacts/public/build/target.tar.bz2 03:33:55 INFO - mkdir: /builds/slave/test/properties 03:33:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:33:55 INFO - Writing to file /builds/slave/test/properties/build_url 03:33:55 INFO - Contents: 03:33:55 INFO - build_url:https://queue.taskcluster.net/v1/task/Oz77JHY8R46lR-xvwFHp5Q/artifacts/public/build/target.tar.bz2 03:33:55 INFO - Running post-action listener: _resource_record_post_action 03:33:55 INFO - Running post-action listener: find_tests_for_verification 03:33:55 INFO - Running post-action listener: set_extra_try_arguments 03:33:55 INFO - [mozharness: 2017-09-05 10:33:55.810846Z] Finished download-and-extract step (success) 03:33:55 INFO - [mozharness: 2017-09-05 10:33:55.810943Z] Running populate-webroot step. 03:33:55 INFO - Running pre-action listener: _resource_record_pre_action 03:33:55 INFO - Running main action method: populate_webroot 03:33:55 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:33:55 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 03:33:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:33:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:33:55 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 03:33:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:33:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:33:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:33:55 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 03:33:55 INFO - 'talos_options': ['--enable-stylo'], 03:33:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:33:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:33:55 INFO - 'tests': ['damp', 'tps']}, 03:33:55 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 03:33:55 INFO - 'talos_options': ['--enable-stylo'], 03:33:55 INFO - 'tests': ['damp', 'tps']}, 03:33:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:33:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:33:55 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 03:33:55 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:33:55 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:33:55 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:33:55 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 03:33:55 INFO - 'talos_options': ['--enable-stylo'], 03:33:55 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:33:55 INFO - 'other-e10s': {'tests': ['a11yr', 03:33:55 INFO - 'ts_paint', 03:33:55 INFO - 'tpaint', 03:33:55 INFO - 'sessionrestore', 03:33:55 INFO - 'sessionrestore_many_windows', 03:33:55 INFO - 'sessionrestore_no_auto_restore', 03:33:55 INFO - 'tabpaint']}, 03:33:55 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 03:33:55 INFO - 'tests': ['a11yr', 03:33:55 INFO - 'ts_paint', 03:33:55 INFO - 'tpaint', 03:33:55 INFO - 'sessionrestore', 03:33:55 INFO - 'sessionrestore_many_windows', 03:33:55 INFO - 'sessionrestore_no_auto_restore', 03:33:55 INFO - 'tabpaint']}, 03:33:55 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:33:55 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:33:55 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 03:33:55 INFO - 'tests': ['bloom_basic_singleton']}, 03:33:55 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 03:33:55 INFO - 'tests': ['bloom_basic']}, 03:33:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:33:55 INFO - 'tsvgr_opacity', 03:33:55 INFO - 'tart', 03:33:55 INFO - 'tscrollx', 03:33:55 INFO - 'tsvg_static']}, 03:33:55 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 03:33:55 INFO - 'tests': ['tsvgx', 03:33:55 INFO - 'tsvgr_opacity', 03:33:55 INFO - 'tart', 03:33:55 INFO - 'tscrollx', 03:33:55 INFO - 'tsvg_static']}, 03:33:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:33:55 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 03:33:55 INFO - 'talos_options': ['--enable-stylo'], 03:33:55 INFO - 'tests': ['tp5o']}, 03:33:55 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:33:55 INFO - 'talos_options': ['--mitmproxy', 03:33:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:33:55 INFO - '--firstNonBlankPaint'], 03:33:55 INFO - 'tests': ['tp6_google', 03:33:55 INFO - 'tp6_youtube', 03:33:55 INFO - 'tp6_amazon', 03:33:55 INFO - 'tp6_facebook']}, 03:33:55 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:33:55 INFO - 'talos_options': ['--enable-stylo', 03:33:55 INFO - '--mitmproxy', 03:33:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:33:55 INFO - '--firstNonBlankPaint'], 03:33:55 INFO - 'tests': ['tp6_google', 03:33:55 INFO - 'tp6_youtube', 03:33:55 INFO - 'tp6_amazon', 03:33:55 INFO - 'tp6_facebook']}, 03:33:55 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:33:55 INFO - 'talos_options': ['--enable-stylo', 03:33:55 INFO - '--stylo-threads=1', 03:33:55 INFO - '--mitmproxy', 03:33:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:33:55 INFO - '--firstNonBlankPaint'], 03:33:55 INFO - 'tests': ['tp6_google', 03:33:55 INFO - 'tp6_youtube', 03:33:55 INFO - 'tp6_amazon', 03:33:55 INFO - 'tp6_facebook']}, 03:33:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:33:55 INFO - 'talos_options': ['--xperf_path', 03:33:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:33:55 INFO - 'tests': ['tp5n']}, 03:33:55 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 03:33:55 INFO - 'talos_options': ['--enable-stylo', 03:33:55 INFO - '--xperf_path', 03:33:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:33:55 INFO - 'tests': ['tp5n']}}} 03:33:55 INFO - Running post-action listener: _resource_record_post_action 03:33:55 INFO - [mozharness: 2017-09-05 10:33:55.825311Z] Finished populate-webroot step (success) 03:33:55 INFO - [mozharness: 2017-09-05 10:33:55.825401Z] Running create-virtualenv step. 03:33:55 INFO - Running pre-action listener: _resource_record_pre_action 03:33:55 INFO - Running main action method: create_virtualenv 03:33:55 INFO - Creating virtualenv /builds/slave/test/build/venv 03:33:55 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:33:55 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:33:55 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:33:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:33:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:33:56 INFO - Installing distribute.............................................................................................................................................................................................done. 03:33:56 INFO - Installing pip...............done. 03:33:56 INFO - Return code: 0 03:33:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:33:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:33:56 INFO - Reading from file tmpfile_stdout 03:33:56 INFO - Output received: 03:33:56 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:33:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:33:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1675a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1818a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181c090>, '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 0x181cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1816f90>, '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': '97facb8ba2ac28944cc45e6b000001d4-1504607590.704876-831758737', '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 03:33:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:33:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:33:56 INFO - Using env: {'DISPLAY': ':0', 03:33:56 INFO - 'HOME': '/home/cltbld', 03:33:56 INFO - 'LANG': 'en_US.UTF-8', 03:33:56 INFO - 'LANGUAGE': 'en_US:en', 03:33:56 INFO - 'LOGNAME': 'cltbld', 03:33:56 INFO - 'MAIL': '/var/mail/cltbld', 03:33:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:56 INFO - 'MOZ_NO_REMOTE': '1', 03:33:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:56 INFO - 'NO_EM_RESTART': '1', 03:33:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:56 INFO - 'PWD': '/builds/slave/test', 03:33:56 INFO - 'SHELL': '/bin/bash', 03:33:56 INFO - 'SHLVL': '1', 03:33:56 INFO - 'TERM': 'linux', 03:33:56 INFO - 'TMOUT': '86400', 03:33:56 INFO - 'USER': 'cltbld', 03:33:56 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1504607590.704876-831758737', 03:33:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:56 INFO - '_': '/tools/buildbot/bin/python'} 03:33:58 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:33:58 INFO - Downloading/unpacking pip>=1.5 03:33:58 INFO - Running setup.py egg_info for package pip 03:33:58 INFO - warning: no files found matching 'pip/cacert.pem' 03:33:58 INFO - warning: no files found matching '*.html' under directory 'docs' 03:33:58 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:33:58 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:33:58 INFO - Installing collected packages: pip 03:33:58 INFO - Found existing installation: pip 1.1 03:33:58 INFO - Uninstalling pip: 03:33:58 INFO - Successfully uninstalled pip 03:33:58 INFO - Running setup.py install for pip 03:33:58 INFO - warning: no files found matching 'pip/cacert.pem' 03:33:58 INFO - warning: no files found matching '*.html' under directory 'docs' 03:33:58 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:33:58 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:33:58 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:33:58 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:33:58 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:33:58 INFO - Successfully installed pip 03:33:58 INFO - Cleaning up... 03:33:58 INFO - Return code: 0 03:33:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:33:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x14ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1675a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1818a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181c090>, '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 0x181cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1816f90>, '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': '97facb8ba2ac28944cc45e6b000001d4-1504607590.704876-831758737', '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 03:33:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:33:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:33:58 INFO - Using env: {'DISPLAY': ':0', 03:33:58 INFO - 'HOME': '/home/cltbld', 03:33:58 INFO - 'LANG': 'en_US.UTF-8', 03:33:58 INFO - 'LANGUAGE': 'en_US:en', 03:33:58 INFO - 'LOGNAME': 'cltbld', 03:33:58 INFO - 'MAIL': '/var/mail/cltbld', 03:33:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:58 INFO - 'MOZ_NO_REMOTE': '1', 03:33:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:58 INFO - 'NO_EM_RESTART': '1', 03:33:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:58 INFO - 'PWD': '/builds/slave/test', 03:33:58 INFO - 'SHELL': '/bin/bash', 03:33:58 INFO - 'SHLVL': '1', 03:33:58 INFO - 'TERM': 'linux', 03:33:58 INFO - 'TMOUT': '86400', 03:33:58 INFO - 'USER': 'cltbld', 03:33:58 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1504607590.704876-831758737', 03:33:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:58 INFO - '_': '/tools/buildbot/bin/python'} 03:33:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:58 INFO - Downloading/unpacking psutil>=3.1.1 03:33:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:33:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:33:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:33:59 INFO - Installing collected packages: psutil 03:33:59 INFO - Running setup.py install for psutil 03:33:59 INFO - building 'psutil._psutil_linux' extension 03:33:59 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 03:33:59 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 03:33:59 INFO - building 'psutil._psutil_posix' extension 03:33:59 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 03:33:59 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 03:33:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:33:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:33:59 INFO - Successfully installed psutil 03:33:59 INFO - Cleaning up... 03:33:59 INFO - Return code: 0 03:33:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:33: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')]} 03:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33: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')]} 03:33:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1675a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1818a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181c090>, '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 0x181cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1816f90>, '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': '97facb8ba2ac28944cc45e6b000001d4-1504607590.704876-831758737', '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 03:33: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:33: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 mozsystemmonitor==0.3 03:33:59 INFO - Using env: {'DISPLAY': ':0', 03:33:59 INFO - 'HOME': '/home/cltbld', 03:33:59 INFO - 'LANG': 'en_US.UTF-8', 03:33:59 INFO - 'LANGUAGE': 'en_US:en', 03:33:59 INFO - 'LOGNAME': 'cltbld', 03:33:59 INFO - 'MAIL': '/var/mail/cltbld', 03:33:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:59 INFO - 'MOZ_NO_REMOTE': '1', 03:33:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:59 INFO - 'NO_EM_RESTART': '1', 03:33:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:59 INFO - 'PWD': '/builds/slave/test', 03:33:59 INFO - 'SHELL': '/bin/bash', 03:33:59 INFO - 'SHLVL': '1', 03:33:59 INFO - 'TERM': 'linux', 03:33:59 INFO - 'TMOUT': '86400', 03:33:59 INFO - 'USER': 'cltbld', 03:33:59 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1504607590.704876-831758737', 03:33:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:59 INFO - '_': '/tools/buildbot/bin/python'} 03:34:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:34:00 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 03:34:00 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 03:34:00 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 03:34:00 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 03:34:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:34:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:34:01 INFO - Installing collected packages: mozsystemmonitor 03:34:01 INFO - Running setup.py install for mozsystemmonitor 03:34:01 INFO - Successfully installed mozsystemmonitor 03:34:01 INFO - Cleaning up... 03:34:01 INFO - Return code: 0 03:34:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:34:01 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')]} 03:34:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:01 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')]} 03:34:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:01 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 0x14ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1675a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1818a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181c090>, '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 0x181cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1816f90>, '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': '97facb8ba2ac28944cc45e6b000001d4-1504607590.704876-831758737', '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 03:34:01 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 03:34:01 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 03:34:01 INFO - Using env: {'DISPLAY': ':0', 03:34:01 INFO - 'HOME': '/home/cltbld', 03:34:01 INFO - 'LANG': 'en_US.UTF-8', 03:34:01 INFO - 'LANGUAGE': 'en_US:en', 03:34:01 INFO - 'LOGNAME': 'cltbld', 03:34:01 INFO - 'MAIL': '/var/mail/cltbld', 03:34:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:01 INFO - 'MOZ_NO_REMOTE': '1', 03:34:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:01 INFO - 'NO_EM_RESTART': '1', 03:34:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:01 INFO - 'PWD': '/builds/slave/test', 03:34:01 INFO - 'SHELL': '/bin/bash', 03:34:01 INFO - 'SHLVL': '1', 03:34:01 INFO - 'TERM': 'linux', 03:34:01 INFO - 'TMOUT': '86400', 03:34:01 INFO - 'USER': 'cltbld', 03:34:01 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1504607590.704876-831758737', 03:34:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:01 INFO - '_': '/tools/buildbot/bin/python'} 03:34:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:01 INFO - Downloading/unpacking jsonschema==2.5.1 03:34: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 03:34: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 03:34: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 03:34: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 03:34:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:34:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:02 INFO - Downloading functools32-3.2.3-2.tar.gz 03:34:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:34:02 INFO - warning: no files found matching '*.txt' 03:34:02 INFO - no previously-included directories found matching 'build' 03:34:02 INFO - no previously-included directories found matching 'dist' 03:34:02 INFO - no previously-included directories found matching '.git*' 03:34:02 INFO - Installing collected packages: jsonschema, functools32 03:34:03 INFO - Running setup.py install for functools32 03:34:03 INFO - warning: no files found matching '*.txt' 03:34:03 INFO - no previously-included directories found matching 'build' 03:34:03 INFO - no previously-included directories found matching 'dist' 03:34:03 INFO - no previously-included directories found matching '.git*' 03:34:03 INFO - Successfully installed jsonschema functools32 03:34:03 INFO - Cleaning up... 03:34:03 INFO - Return code: 0 03:34:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:34:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x14ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1675a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1818a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181c090>, '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 0x181cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1816f90>, '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': '97facb8ba2ac28944cc45e6b000001d4-1504607590.704876-831758737', '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 03:34:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:34:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:34:03 INFO - Using env: {'DISPLAY': ':0', 03:34:03 INFO - 'HOME': '/home/cltbld', 03:34:03 INFO - 'LANG': 'en_US.UTF-8', 03:34:03 INFO - 'LANGUAGE': 'en_US:en', 03:34:03 INFO - 'LOGNAME': 'cltbld', 03:34:03 INFO - 'MAIL': '/var/mail/cltbld', 03:34:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:03 INFO - 'MOZ_NO_REMOTE': '1', 03:34:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:03 INFO - 'NO_EM_RESTART': '1', 03:34:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:03 INFO - 'PWD': '/builds/slave/test', 03:34:03 INFO - 'SHELL': '/bin/bash', 03:34:03 INFO - 'SHLVL': '1', 03:34:03 INFO - 'TERM': 'linux', 03:34:03 INFO - 'TMOUT': '86400', 03:34:03 INFO - 'USER': 'cltbld', 03:34:03 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1504607590.704876-831758737', 03:34:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:03 INFO - '_': '/tools/buildbot/bin/python'} 03:34:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:34:03 INFO - Cleaning up... 03:34:03 INFO - Return code: 0 03:34:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:34:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1675a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1818a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181c090>, '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 0x181cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1816f90>, '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': '97facb8ba2ac28944cc45e6b000001d4-1504607590.704876-831758737', '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 03:34:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:34:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:34:03 INFO - Using env: {'DISPLAY': ':0', 03:34:03 INFO - 'HOME': '/home/cltbld', 03:34:03 INFO - 'LANG': 'en_US.UTF-8', 03:34:03 INFO - 'LANGUAGE': 'en_US:en', 03:34:03 INFO - 'LOGNAME': 'cltbld', 03:34:03 INFO - 'MAIL': '/var/mail/cltbld', 03:34:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:03 INFO - 'MOZ_NO_REMOTE': '1', 03:34:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:03 INFO - 'NO_EM_RESTART': '1', 03:34:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:03 INFO - 'PWD': '/builds/slave/test', 03:34:03 INFO - 'SHELL': '/bin/bash', 03:34:03 INFO - 'SHLVL': '1', 03:34:03 INFO - 'TERM': 'linux', 03:34:03 INFO - 'TMOUT': '86400', 03:34:03 INFO - 'USER': 'cltbld', 03:34:03 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1504607590.704876-831758737', 03:34:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:03 INFO - '_': '/tools/buildbot/bin/python'} 03:34:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:03 INFO - Downloading/unpacking blobuploader==1.2.4 03:34: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 03:34: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 03:34: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 03:34: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 03:34:04 INFO - Downloading blobuploader-1.2.4.tar.gz 03:34:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:34:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:34:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:34: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 03:34: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 03:34: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 03:34: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 03:34:05 INFO - Downloading docopt-0.6.1.tar.gz 03:34:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:34:05 INFO - Installing collected packages: blobuploader, requests, docopt 03:34:05 INFO - Running setup.py install for blobuploader 03:34:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:34:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:34:05 INFO - Running setup.py install for requests 03:34:05 INFO - Running setup.py install for docopt 03:34:05 INFO - Successfully installed blobuploader requests docopt 03:34:05 INFO - Cleaning up... 03:34:05 INFO - Return code: 0 03:34:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34: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')]} 03:34:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34: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')]} 03:34:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:05 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 0x14ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1675a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1818a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181c090>, '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 0x181cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1816f90>, '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': '97facb8ba2ac28944cc45e6b000001d4-1504607590.704876-831758737', '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 03:34:05 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 03:34:05 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 03:34:05 INFO - Using env: {'DISPLAY': ':0', 03:34:05 INFO - 'HOME': '/home/cltbld', 03:34:05 INFO - 'LANG': 'en_US.UTF-8', 03:34:05 INFO - 'LANGUAGE': 'en_US:en', 03:34:05 INFO - 'LOGNAME': 'cltbld', 03:34:05 INFO - 'MAIL': '/var/mail/cltbld', 03:34:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:05 INFO - 'MOZ_NO_REMOTE': '1', 03:34:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:05 INFO - 'NO_EM_RESTART': '1', 03:34:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:05 INFO - 'PWD': '/builds/slave/test', 03:34:05 INFO - 'SHELL': '/bin/bash', 03:34:05 INFO - 'SHLVL': '1', 03:34:05 INFO - 'TERM': 'linux', 03:34:05 INFO - 'TMOUT': '86400', 03:34:05 INFO - 'USER': 'cltbld', 03:34:05 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1504607590.704876-831758737', 03:34:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:05 INFO - '_': '/tools/buildbot/bin/python'} 03:34:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:34:06 INFO - Running setup.py (path:/tmp/pip-h5e8Xa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:34:06 INFO - Running setup.py (path:/tmp/pip-b1SdGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:34:06 INFO - Running setup.py (path:/tmp/pip-yU1WMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:34:06 INFO - Running setup.py (path:/tmp/pip-hbEyil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:34:06 INFO - Running setup.py (path:/tmp/pip-N3c4oZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:34:06 INFO - Running setup.py (path:/tmp/pip-6fmzdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:34:06 INFO - Running setup.py (path:/tmp/pip-E75Ooe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:34:06 INFO - Running setup.py (path:/tmp/pip-MmgMHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:34:06 INFO - Running setup.py (path:/tmp/pip-Zdkx3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:34:06 INFO - Running setup.py (path:/tmp/pip-aEld6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:34:06 INFO - Running setup.py (path:/tmp/pip-t6Uv8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:34:06 INFO - Running setup.py (path:/tmp/pip-0iLkq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:34:06 INFO - Running setup.py (path:/tmp/pip-etbkjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:34:07 INFO - Running setup.py (path:/tmp/pip-AbleUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:07 INFO - Running setup.py (path:/tmp/pip-_WKF3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:34:07 INFO - Running setup.py (path:/tmp/pip-6x_Otu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:34:07 INFO - Running setup.py (path:/tmp/pip-NIyWvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:34:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:34:07 INFO - Running setup.py install for manifestparser 03:34:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:34:07 INFO - Running setup.py install for mozcrash 03:34:07 INFO - Running setup.py install for mozdebug 03:34:07 INFO - Running setup.py install for mozdevice 03:34:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:34:07 INFO - Running setup.py install for mozfile 03:34:07 INFO - Running setup.py install for mozhttpd 03:34:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:34:07 INFO - Running setup.py install for mozinfo 03:34:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:34:07 INFO - Running setup.py install for mozInstall 03:34:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:34:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:34:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:34:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:34:08 INFO - Running setup.py install for mozleak 03:34:08 INFO - Running setup.py install for mozlog 03:34:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:34:08 INFO - Running setup.py install for moznetwork 03:34:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:34:08 INFO - Running setup.py install for mozprocess 03:34:08 INFO - Running setup.py install for mozprofile 03:34:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:34:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:34:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:34:08 INFO - Running setup.py install for mozrunner 03:34:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:34:08 INFO - Running setup.py install for mozscreenshot 03:34:08 INFO - Running setup.py install for moztest 03:34:08 INFO - Running setup.py install for mozversion 03:34:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:34:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:34:09 INFO - Cleaning up... 03:34:09 INFO - Return code: 0 03:34:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1675a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1818a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181c090>, '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 0x181cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1816f90>, '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': '97facb8ba2ac28944cc45e6b000001d4-1504607590.704876-831758737', '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 03:34:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:34:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:34:09 INFO - Using env: {'DISPLAY': ':0', 03:34:09 INFO - 'HOME': '/home/cltbld', 03:34:09 INFO - 'LANG': 'en_US.UTF-8', 03:34:09 INFO - 'LANGUAGE': 'en_US:en', 03:34:09 INFO - 'LOGNAME': 'cltbld', 03:34:09 INFO - 'MAIL': '/var/mail/cltbld', 03:34:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:09 INFO - 'MOZ_NO_REMOTE': '1', 03:34:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:09 INFO - 'NO_EM_RESTART': '1', 03:34:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:09 INFO - 'PWD': '/builds/slave/test', 03:34:09 INFO - 'SHELL': '/bin/bash', 03:34:09 INFO - 'SHLVL': '1', 03:34:09 INFO - 'TERM': 'linux', 03:34:09 INFO - 'TMOUT': '86400', 03:34:09 INFO - 'USER': 'cltbld', 03:34:09 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1504607590.704876-831758737', 03:34:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:09 INFO - '_': '/tools/buildbot/bin/python'} 03:34:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:34:09 INFO - Running setup.py (path:/tmp/pip-IHvhov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:34:09 INFO - Running setup.py (path:/tmp/pip-l1Fy2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:34:09 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)) 03:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:34:09 INFO - Running setup.py (path:/tmp/pip-dEVmgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:34:09 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)) 03:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:34:09 INFO - Running setup.py (path:/tmp/pip-mjLXyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:34:09 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)) 03:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:34:09 INFO - Running setup.py (path:/tmp/pip-frYdnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:34:09 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)) 03:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:34:09 INFO - Running setup.py (path:/tmp/pip-t6FBqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:34:09 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)) 03:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:34:09 INFO - Running setup.py (path:/tmp/pip-sjdHDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:34:09 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)) 03:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:34:09 INFO - Running setup.py (path:/tmp/pip-XzjBl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:34:09 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)) 03:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:34:09 INFO - Running setup.py (path:/tmp/pip-BRT5bp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:34:09 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)) 03:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:34:09 INFO - Running setup.py (path:/tmp/pip-uMtwg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:34:09 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)) 03:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:34:09 INFO - Running setup.py (path:/tmp/pip-JpmWJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:34:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:34:10 INFO - Running setup.py (path:/tmp/pip-xU3O7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:34:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:34:10 INFO - Running setup.py (path:/tmp/pip-ZrcxmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:34:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:34:10 INFO - Running setup.py (path:/tmp/pip-QlmqSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:34:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:10 INFO - Running setup.py (path:/tmp/pip-6nfOaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:34:10 INFO - Running setup.py (path:/tmp/pip-zNdPni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:34:10 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)) 03:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:34:10 INFO - Running setup.py (path:/tmp/pip-C7kRAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:34:10 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)) 03:34:10 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)) 03:34:10 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)) 03:34:10 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)) 03:34:10 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)) 03:34:10 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)) 03:34:10 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)) 03:34:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:34: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 03:34: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 03:34: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 03:34: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 03:34:11 INFO - Downloading blessings-1.6.tar.gz 03:34:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:34:11 INFO - Installing collected packages: blessings 03:34:11 INFO - Running setup.py install for blessings 03:34:11 INFO - Successfully installed blessings 03:34:11 INFO - Cleaning up... 03:34:11 INFO - Return code: 0 03:34:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:34:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:34:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:34:12 INFO - Reading from file tmpfile_stdout 03:34:12 INFO - Current package versions: 03:34:12 INFO - argparse == 1.2.1 03:34:12 INFO - blessings == 1.6 03:34:12 INFO - blobuploader == 1.2.4 03:34:12 INFO - docopt == 0.6.1 03:34:12 INFO - functools32 == 3.2.3-2 03:34:12 INFO - jsonschema == 2.5.1 03:34:12 INFO - manifestparser == 1.1 03:34:12 INFO - mozInstall == 1.13 03:34:12 INFO - mozcrash == 1.0 03:34:12 INFO - mozdebug == 0.1 03:34:12 INFO - mozdevice == 0.51 03:34:12 INFO - mozfile == 1.2 03:34:12 INFO - mozhttpd == 0.7 03:34:12 INFO - mozinfo == 0.10 03:34:12 INFO - mozleak == 0.1 03:34:12 INFO - mozlog == 3.5 03:34:12 INFO - moznetwork == 0.27 03:34:12 INFO - mozprocess == 0.25 03:34:12 INFO - mozprofile == 0.28 03:34:12 INFO - mozrunner == 6.13 03:34:12 INFO - mozscreenshot == 0.1 03:34:12 INFO - mozsystemmonitor == 0.3 03:34:12 INFO - moztest == 0.8 03:34:12 INFO - mozversion == 1.4 03:34:12 INFO - psutil == 3.1.1 03:34:12 INFO - requests == 1.2.3 03:34:12 INFO - wsgiref == 0.1.2 03:34:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1675a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1818a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181c090>, '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 0x181cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1816f90>, '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': '97facb8ba2ac28944cc45e6b000001d4-1504607590.704876-831758737', '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 03:34:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:34:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:34:12 INFO - Using env: {'DISPLAY': ':0', 03:34:12 INFO - 'HOME': '/home/cltbld', 03:34:12 INFO - 'LANG': 'en_US.UTF-8', 03:34:12 INFO - 'LANGUAGE': 'en_US:en', 03:34:12 INFO - 'LOGNAME': 'cltbld', 03:34:12 INFO - 'MAIL': '/var/mail/cltbld', 03:34:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:12 INFO - 'MOZ_NO_REMOTE': '1', 03:34:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:12 INFO - 'NO_EM_RESTART': '1', 03:34:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:12 INFO - 'PWD': '/builds/slave/test', 03:34:12 INFO - 'SHELL': '/bin/bash', 03:34:12 INFO - 'SHLVL': '1', 03:34:12 INFO - 'TERM': 'linux', 03:34:12 INFO - 'TMOUT': '86400', 03:34:12 INFO - 'USER': 'cltbld', 03:34:12 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1504607590.704876-831758737', 03:34:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:12 INFO - '_': '/tools/buildbot/bin/python'} 03:34:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:34:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:34:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:34:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:34:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:34:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:34:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:34:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:34:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:34:12 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:34:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:34:13 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)) 03:34:13 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)) 03:34:13 INFO - Installing collected packages: simplejson 03:34:13 INFO - Running setup.py install for simplejson 03:34:13 INFO - building 'simplejson._speedups' extension 03:34:13 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 03:34:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:34:14 INFO - Successfully installed simplejson 03:34:14 INFO - Cleaning up... 03:34:14 INFO - Return code: 0 03:34:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:34: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')]} 03:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34: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')]} 03:34:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:14 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 0x14ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1675a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1818a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181c090>, '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 0x181cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1816f90>, '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': '97facb8ba2ac28944cc45e6b000001d4-1504607590.704876-831758737', '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 03:34:14 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 03:34:14 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 03:34:14 INFO - Using env: {'DISPLAY': ':0', 03:34:14 INFO - 'HOME': '/home/cltbld', 03:34:14 INFO - 'LANG': 'en_US.UTF-8', 03:34:14 INFO - 'LANGUAGE': 'en_US:en', 03:34:14 INFO - 'LOGNAME': 'cltbld', 03:34:14 INFO - 'MAIL': '/var/mail/cltbld', 03:34:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:14 INFO - 'MOZ_NO_REMOTE': '1', 03:34:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:14 INFO - 'NO_EM_RESTART': '1', 03:34:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:14 INFO - 'PWD': '/builds/slave/test', 03:34:14 INFO - 'SHELL': '/bin/bash', 03:34:14 INFO - 'SHLVL': '1', 03:34:14 INFO - 'TERM': 'linux', 03:34:14 INFO - 'TMOUT': '86400', 03:34:14 INFO - 'USER': 'cltbld', 03:34:14 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1504607590.704876-831758737', 03:34:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:14 INFO - '_': '/tools/buildbot/bin/python'} 03:34:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:34:14 INFO - Cleaning up... 03:34:14 INFO - Return code: 0 03:34:14 INFO - Running post-action listener: _resource_record_post_action 03:34:14 INFO - Running post-action listener: _start_resource_monitoring 03:34:14 INFO - Starting resource monitoring. 03:34:14 INFO - [mozharness: 2017-09-05 10:34:14.781884Z] Finished create-virtualenv step (success) 03:34:14 INFO - [mozharness: 2017-09-05 10:34:14.782384Z] Running install step. 03:34:14 INFO - Running pre-action listener: _resource_record_pre_action 03:34:14 INFO - Running main action method: install 03:34:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:34:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:34:14 INFO - Reading from file tmpfile_stdout 03:34:14 INFO - Detecting whether we're running mozinstall >=1.0... 03:34:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:34:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:34:15 INFO - Reading from file tmpfile_stdout 03:34:15 INFO - Output received: 03:34:15 INFO - Usage: mozinstall [options] installer 03:34:15 INFO - Options: 03:34:15 INFO - -h, --help show this help message and exit 03:34:15 INFO - -d DEST, --destination=DEST 03:34:15 INFO - Directory to install application into. [default: 03:34:15 INFO - "/builds/slave/test"] 03:34:15 INFO - --app=APP Application being installed. [default: firefox] 03:34:15 INFO - mkdir: /builds/slave/test/build/application 03:34:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:34:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:34:31 INFO - Reading from file tmpfile_stdout 03:34:31 INFO - Output received: 03:34:31 INFO - /builds/slave/test/build/application/firefox/firefox 03:34:31 INFO - Running post-action listener: _resource_record_post_action 03:34:31 INFO - [mozharness: 2017-09-05 10:34:31.652181Z] Finished install step (success) 03:34:31 INFO - [mozharness: 2017-09-05 10:34:31.652329Z] Running setup-mitmproxy step. 03:34:31 INFO - Running pre-action listener: _resource_record_pre_action 03:34:31 INFO - Running main action method: setup_mitmproxy 03:34:31 INFO - Skipping: mitmproxy is not required 03:34:31 INFO - Running post-action listener: _resource_record_post_action 03:34:31 INFO - [mozharness: 2017-09-05 10:34:31.653019Z] Finished setup-mitmproxy step (success) 03:34:31 INFO - [mozharness: 2017-09-05 10:34:31.653152Z] Running run-tests step. 03:34:31 INFO - Running pre-action listener: _resource_record_pre_action 03:34:31 INFO - Running pre-action listener: _set_gcov_prefix 03:34:31 INFO - Running main action method: run_tests 03:34:31 WARNING - Try message not found. 03:34:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:34:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:34:31 INFO - Python 2.7.3 03:34:31 INFO - Return code: 0 03:34:31 INFO - grabbing minidump binary from tooltool 03:34:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:31 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 0x181c090>, '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 0x181cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1816f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:34:31 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 03:34:31 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 03:34:31 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 03:34:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:34:31 INFO - Return code: 0 03:34:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:34:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:34:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:34:31 INFO - ENV: RUST_BACKTRACE is now full 03:34:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:34:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:34:31 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/Oz77JHY8R46lR-xvwFHp5Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 03:34:31 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/Oz77JHY8R46lR-xvwFHp5Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 03:34:31 INFO - Using env: {'DISPLAY': ':0', 03:34:31 INFO - 'HOME': '/home/cltbld', 03:34:31 INFO - 'LANG': 'en_US.UTF-8', 03:34:31 INFO - 'LANGUAGE': 'en_US:en', 03:34:31 INFO - 'LOGNAME': 'cltbld', 03:34:31 INFO - 'MAIL': '/var/mail/cltbld', 03:34:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:34:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:34:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:31 INFO - 'MOZ_NO_REMOTE': '1', 03:34:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:34:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:31 INFO - 'NO_EM_RESTART': '1', 03:34:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:31 INFO - 'PWD': '/builds/slave/test', 03:34:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:34:31 INFO - 'RUST_BACKTRACE': 'full', 03:34:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:34:31 INFO - 'SHELL': '/bin/bash', 03:34:31 INFO - 'SHLVL': '1', 03:34:31 INFO - 'TERM': 'linux', 03:34:31 INFO - 'TMOUT': '86400', 03:34:31 INFO - 'USER': 'cltbld', 03:34:31 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1504607590.704876-831758737', 03:34:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:31 INFO - '_': '/tools/buildbot/bin/python'} 03:34:31 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/Oz77JHY8R46lR-xvwFHp5Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 03:34:32 INFO - mozversion application_buildid: 20170905094120 03:34:32 INFO - mozversion application_changeset: 3ecda4678c49ca255c38b1697142b9118cdd27e7 03:34:32 INFO - mozversion application_display_name: Nightly 03:34:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:34:32 INFO - mozversion application_name: Firefox 03:34:32 INFO - mozversion application_remotingname: firefox 03:34:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:34:32 INFO - mozversion application_vendor: Mozilla 03:34:32 INFO - mozversion application_version: 57.0a1 03:34:32 INFO - mozversion platform_buildid: 20170905094120 03:34:32 INFO - mozversion platform_changeset: 3ecda4678c49ca255c38b1697142b9118cdd27e7 03:34:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:34:32 INFO - mozversion platform_version: 57.0a1 03:34:32 INFO - using testdate: 1504607672 03:34:32 INFO - actual date: 1504607672 03:34:32 INFO - starting webserver on 'localhost:53210' 03:34:32 INFO - SUITE-START | Running 2 tests 03:34:32 INFO - TEST-START | dromaeo_css 03:34:32 INFO - Initialising browser for dromaeo_css test... 03:34:32 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53210/getInfo.html -profile /tmp/tmplvE5ny/profile 03:34:32 INFO - TEST-INFO | started process 6429 (/builds/slave/test/build/application/firefox/firefox http://localhost:53210/getInfo.html) 03:34:38 INFO - TEST-INFO | 6429: exit 0 03:34:38 INFO - Browser initialized. 03:34:38 INFO - Running cycle 1/1 for dromaeo_css test... 03:34:38 INFO - Using env: {'DISPLAY': ':0', 03:34:38 INFO - 'HOME': '/home/cltbld', 03:34:38 INFO - 'JSGC_DISABLE_POISONING': '1', 03:34:38 INFO - 'LANG': 'en_US.UTF-8', 03:34:38 INFO - 'LANGUAGE': 'en_US:en', 03:34:38 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:34:38 INFO - 'LOGNAME': 'cltbld', 03:34:38 INFO - 'MAIL': '/var/mail/cltbld', 03:34:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:34:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:34:38 INFO - 'MOZ_CRASHREPORTER': '1', 03:34:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:38 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:34:38 INFO - 'MOZ_NO_REMOTE': '1', 03:34:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:34:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:38 INFO - 'NO_EM_RESTART': '1', 03:34:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:38 INFO - 'PWD': '/builds/slave/test', 03:34:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:34:38 INFO - 'RUST_BACKTRACE': 'full', 03:34:38 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:34:38 INFO - 'SHELL': '/bin/bash', 03:34:38 INFO - 'SHLVL': '1', 03:34:38 INFO - 'TERM': 'linux', 03:34:38 INFO - 'TMOUT': '86400', 03:34:38 INFO - 'USER': 'cltbld', 03:34:38 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1504607590.704876-831758737', 03:34:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:38 INFO - '_': '/tools/buildbot/bin/python'} 03:34:38 INFO - TEST-INFO | started process 6618 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplvE5ny/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:34:39 INFO - PID 6618 | 03:34:39 INFO - PID 6618 | (/builds/slave/test/build/application/firefox/firefox:6671): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:34:39 INFO - PID 6618 | 03:34:49 INFO - PID 6618 | RSS: Main: 168648704 03:34:49 INFO - PID 6618 | 03:37:48 INFO - PID 6618 | Cycle 1(1): loaded http://localhost:53210/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53210/tests/dromaeo/cssquery-ext.html) 03:37:50 INFO - PID 6618 | RSS: Main: 172474368 03:37:50 INFO - PID 6618 | 03:40:51 INFO - PID 6618 | Cycle 1(1): loaded http://localhost:53210/tests/dromaeo/cssquery-ext.html (next: http://localhost:53210/tests/dromaeo/cssquery-jquery.html) 03:40:52 INFO - PID 6618 | RSS: Main: 169082880 03:40:52 INFO - PID 6618 | 03:43:54 INFO - PID 6618 | Cycle 1(1): loaded http://localhost:53210/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53210/tests/dromaeo/cssquery-mootools.html) 03:43:54 INFO - PID 6618 | RSS: Main: 171511808 03:43:54 INFO - PID 6618 | 03:46:56 INFO - PID 6618 | Cycle 1(1): loaded http://localhost:53210/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53210/tests/dromaeo/cssquery-prototype.html) 03:46:57 INFO - PID 6618 | RSS: Main: 170647552 03:46:57 INFO - PID 6618 | 03:50:00 INFO - PID 6618 | Cycle 1(1): loaded http://localhost:53210/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53210/tests/dromaeo/cssquery-yui.html) 03:50:01 INFO - PID 6618 | RSS: Main: 171421696 03:50:01 INFO - PID 6618 | 03:53:02 INFO - PID 6618 | Cycle 1(1): loaded http://localhost:53210/tests/dromaeo/cssquery-yui.html (next: http://localhost:53210/tests/dromaeo/cssquery-dojo.html) 03:53:02 INFO - PID 6618 | RSS: Main: 173895680 03:53:02 INFO - PID 6618 | 03:53:02 INFO - PID 6618 | __start_tp_report 03:53:02 INFO - PID 6618 | _x_x_mozilla_page_load 03:53:02 INFO - PID 6618 | _x_x_mozilla_page_load_details 03:53:02 INFO - PID 6618 | |i|pagename|runs| 03:53:02 INFO - PID 6618 | |0;dojo.html;3347.4811404232337;3351.7821341612794;3360.1935535471493;3373.865045398184;3405.4381027130526;6421.903671444932;6428;6464.515161362905;6479.319671434502;6541.247756508003;6328.082428047942;6441.6135031898;6453.225612926455;6470.579412338207;6473.546851720382;5906.409359064091;5906.497947674453;5933.940660593382;5949;5969.343372229073;5954.791582294621;5982.611130276518;5990.071538911454;6043.033114701649;6100.450959413652;5979.282486101674;6043.7280322385595;6048.909266361008;6066.545009124311;6079.726412311456;5732.140178973187;6018.307894592134;6018.638881667114;6076.635401875879;6130.386961303879;5443.891122177534;5874.1776151338845;5890.410958904118;5944.524438044946;6033.185519954838;6459.967700161469;6462.224533056016;6499.967500162516;6595.47236221106;6618.106555614979;6712;6773.72905083796;6822.4200942919915;6954.130733658293;7070.222275549685;6956.5478243913985;6959.19969203543;6974.232834388214;6978.685959131801;6982.987466817283;6424.164858568356;6429.4534964528075;6449.32282110381;6451.032345148265;6451.387118223761;7035.366816986393;7065.2228254891925;7082.008518807268;7082.150141982995;7087.468439866928;6725.764598239038;6797.728090876409;6799.082123913307;6805.421539169226;6909.30906909305;6642.236142843538;6895.620740859201;6987.475939304471;6989.89515157273;7034.8944765828555;6819.283975182633;6826.351496607815;6895.310468953065;6944.305569443116;6958.826029349307;6732.697028633724;6829.351211634986;6844.486663500257;6900.758473453405;6923.134608173978;5472.288602481652;5473.233747275384;5488.874780669953;5492.725363731877;5498.752556134904;4734.502877197913;4737.6683632146105;4743.810247590127;4775.259834725553;4799.064182484382;5924.318703349084;5945.1973983512535;6013.428724271187;6027;6027.336992930862;6880.65596720172;6912.827179320457;6913.827154321081;6916.273791251947;6923.653817309114;5837.211976383219;5984.491318237911;5985.072313791369;6015.939840601625;6139.416755408229;5870.26621672291;6011.3086994995265;6013.6993150342305;6014.609050411709;6030.005049166926;6622.470202383798;6686.264510903797;6706.463482921355;6767.052612634235;6781.762638307734;6809.625470598967;6898.8620227596175;6918.066061081689;6930.896036559557;6931.792046238621;6624.8343791405605;6638.103855979574;6675.332466753286;6730.831729206809;6795.014722865256;6300.7479700811455;6900;6915.93084069173;6968.616726080114;6969.895451568129;6965.7213711453005;6995.8251043722275;7014.859702805813;7028.121484814398;7118.074650295428;6607.07500949877;6712.83217919556;6714.664266786739;6789.796306110825;6852.349026842442;6596.175478065242;6607.834804129935;6675.766348177791;6675.7997260082275;6718.160229971254;6571.80284591463;6592.8351791205605;6597.769078082244;6667.299933507106;6683.231428385798;6654.13496245485;6688.431483323972;6696.129503164558;6778.525503214925;6814.080099186546;6478.28738838718;6550.705218265285;6634;6635.104260924713;6637.900431493435 03:53:02 INFO - PID 6618 | |1;ext.html;732.9926700732995;790.8774140008298;819.3404309530827;823.3783493462439;1136.0740996088193;29598;30310.39379212417;40824;41251.17497650053;41328.38007429891;41288.17423651525;41775.79112104435;41896.790516047375;41914.37128443076;41944.16111677764;7535.773926782192;7705;7729;7730.574818384986;7748.263914928101;7667.769966900974;7759.689612415496;7775.377969762406;7779.33875620573;7783.844323113534;7740.651670674833;7787.260210280015;7798.454108212427;7801.4929029612895;7806.4925779824125;7743.4966727162555;7770.57261850598;7779.766607001742;7780.6109694515335;7788.766337009899;7635.236476352376;7682.231776822329;7684.615769211573;7685.846283074307;7690.346320562759;36395.81802090999;36584.634153658386;36600.26799463996;36635.08412289687;36678.26643467142;3551.8224088795455;3572.499850020999;3607.567091948983;3615.023943535257;3620.9094772630633;30335.241618959702;30375.696243037506;30404.69595304041;30483;30513.389732205233;5043.218301163325;5212.8957420851375;5224.52979231871;5245.868853278698;5269.051570717269;179641;179978;180244;181116;181994.9999999987;45802.77098614552;45810.31284530668;45886.77056614762;45888.77055614701;46020.3096953546;47341.28988065182;47541.28688069682;47546;47585.286220706024;47636.52363476321;13471.461141554228;13836.962227832953;14967.401303947938;15196.392144314324;15469.84530154684;12395.442205100791;12410.503579856704;12423.254604723745;12431.689207769878;12448.31534265624;13828.654283642989;13901.652458688412;13907.513237036655;13945.930270348583;14032;5825.4174582542255;5846.912296315559;5893.675847828325;5907.409259074058;5924.9703751480965;1024.1857723110145;1040.8802987656366;1046.0951277145214;1047.9214058945608;1049.800537897797;22543.661845072336;23208.3037508875;23722.881385593308;31011.379772404427;31256.687433125833;1135.9772804544027;1155.4338374196584;1161.7153797319543;1164.2723297938787;1165.7085728567858;12690.936545317214;12998;16309.347626095061;16457.177141142896;16632.594406817832;236540;238723;239558;240408;240478;54731.17903231455;55101;55302.44697553053;55349.72325138348;55430.445695543334;1479.8668119869265;1519.4226194046191;1523.0785374848058;1523.6724104317402;1524.8563577317013;27807.44385112327;28067.859660701564;28701.56036736901;28815.42369152647;29081.85459072691;44821.775891120335;45240.54759452363;45261.32108018317;45326.09347813091;45505;211142;211255;213122;213146;213227;35223.29553408866;37553.24893502169;38752.41871371988;39029.6097039026;39117.41323880201;46062.84842878821;48193.75903120462;48657;48712.5128748708;48729.75635121802;34666.82666586752;35665.28669426545;35686.46470303;35828.82085589555;35944.820275898455;35761;36024.459633106046;36151.63848361483;36272.274554508236;36548.451773223955;39047.41428878512;40071;40078;40506.59493405146;40789.1842163161;34450.655493445745;34663.30673386468;34745;34999.30001400009;35176.82411587926;24863.62704559469;26042;26130.477390452466;26826.86586567055;27015.59476607813 03:53:02 INFO - PID 6618 | |2;jquery.html;563.4844117632366;565.8755073883744;573.6787399056528;576.0955300178721;584.643367545797;22073.33779986599;22767.203147889828;22829.657555136688;22837.08651653934;22886.198983035596;25899.611505827426;26020.21939341818;26455.735442645568;26513.86743066282;26515.86742066287;6352.46004089653;6441.4524765395;6452.483801295909;6537.5750576212395;6539.64031978241;6223.315435302113;6404.167458230423;6458.838529036765;6498.3826536478955;6501.187351581052;6471.514636402265;6473.8705225895455;6474.482041436674;6478.060681201223;6480.935190648104;6462.579932304385;6467.482601391877;6475.061116138158;6477.255115661688;6485.383888530606;5922.674252916088;5976.97011514944;5988.041913293852;5999.400059994009;6000;28176.85911570429;28988.855055724587;29433.411331773244;29797.255068623243;30191.849040754874;2059.1454546363243;2095.5808838232415;2096.2348742708955;2100.7794181611016;2108.8734675919495;19190;19814.80185198144;19819.10814013373;19828.80171198284;19848.305309314248;2399.412144024725;2429.6962879640046;2456.4104614892476;2466.1491785334033;2518.1312447205682;134361;135632.643673563;136942;138301;138473;14120.858791411954;14568.854311456962;14592.927035364755;15041.398344066334;15414.306356213772;22748.545029099656;22955;23582.52383499742;23585;23598.174063908024;10231;10240.231982601335;10367.533460994273;10372.11836993849;10443.11233545142;9453.101955314372;9585.664501742405;9632.75918102053;9640.855387169198;9653.951730241304;9042.502662353634;9376.62493500266;9453.669121580711;9504.667336643184;9593.520323983774;2737.219892330716;2781.2907708534194;2820.562812764025;2832.122042166935;2850.900218492343;974.6442548469757;990.4651488196293;994.9801003979879;996.7508122969258;1004.6082028009082;20068.39794806158;20128.39614811558;20209.191632334543;20327.390178294674;20867.269645562334;1038.5015192707392;1059.89930956559;1063.6170978447753;1074.8011617850723;1078.983815242772;11215.831762523569;11343.602973895873;11387.601433949772;11394.886051139549;11396;444918;453685;474306;474711;477046;123509;125334;126646;127379;127649;1212.6180253220207;1250.5810553464692;1282.2691066092239;1285.13895689888;1292.179466039072;20857.478563036046;20989.89505052465;21146.365609031753;21324.466888327916;21376.572468550232;60077;60887;61494.385056150655;62556;63848.36151638424;79186;82011;82836;83133;83429.58285208535;14310.856891430953;14810.407583696531;14840.48058317997;14842.925785371004;14902.180380078766;23379.76620233844;23973.28080157598;24768.380790480383;25150;25297;19451;19611.509712257306;19664.311749089284;19898.90050549738;19927.402177934106;17192.22634981454;17480.562985925455;17843.46469605862;17963.191656375235;18537.629247414705;18992.24031038743;19832.50418739543;19906.203751849764;20113.497162571053;20223.89888050609;14636.414543418145;14692;14908.329125189175;14955;14969.850301497281;18783.436496905113;18829.420284805863;18872;18891.527711807314;18939.62120757605 03:53:02 INFO - PID 6618 | |3;mootools.html;1364.7338768940058;1432.641839540115;1433.5627633571762;1439.035845983191;1444.9060811047289;14794.186319752409;15345.923270383633;15386.230688465588;15394.461193858217;15444.845551544482;14863.554093377188;15388.230588470587;15938.840611593881;15939.760903586455;15989.600259993476;2792.2600510864636;2848.5015122353607;2848.957265641017;2850.1307101334087;2851;2684.2618279972967;2725.9863700681467;2798.958015629757;2799.7200279971944;2813.563897595876;2790.1350581319753;2821.5626577880357;2822.068717323278;2823.1953893140458;2825.547912334027;2717.619533265344;2747.6015977683223;2754.394033312668;2759.5860620906724;2766.405222877071;2667.399835037101;2682.9865850670817;2692.5557283048274;2704.648395708545;2705.580635001578;14196.077254978496;14464.566063018126;14490.347934342979;14500.854991450162;14506.274686265644;7816.452848300622;8134.145914678992;8150.7147249845975;8162.469439486474;8170;5428.4300148484235;5499.642523236017;5529.087700529408;5657.773689052474;5777.133429985493;1937.3897222374908;1943.3101249056522;1967.5376286572643;1986.195590785734;1988.9104990275473;26099.347516312246;26301.473970520674;26485.073022444314;26486.205413837615;26491;6931.6880740366805;7129.89305160423;7218.6390680465765;7418;7427.740029098955;17285;17328.913355433142;17348;17417.738733919003;17577.736333955;7693.769186924401;7810.804729881798;7847.882281765778;7920.801979950432;7937.841243175104;7242.203357630657;7291.416686665054;7451.180370159278;7459.216782237895;7507.699692012258;5151.9484805152215;5292.4707529247535;5323.813666521653;5336.813211537655;5359.785608575691;1390.8539603341503;1439.194051331258;1575.8739300855905;1798.4245041586566;1827.6892928202237;888.8533391990378;909.1726528858707;913.1051569461964;917.7155081924625;926.3839546701369;7869.724559640385;8361.874571881426;8428.873566896502;8437.620307086196;8528.147185281423;969.2197780786535;973.9366941148803;999.160705007797;1001.2190491416707;1008.3596915958273;5016.372953380827;5041.873953151201;5079.619028572872;5142.408623008327;5147.2279158126585;20476.69284960727;21141.894290528755;21898.343049708215;22112.2260720874;22114.115435382726;19342.226310947684;19780.40658780239;19949.401517954484;19952.60094798125;19975.800241997684;10678.786424271471;11309.151813613847;11348.375839328752;11354.716132096764;11362.659120226406;8082.595870206584;8256.545889975869;8422.284105851071;8450.873236901574;8522.70170544028;17451.818522684665;17517.64964700724;17642.20610072524;17743.911280443514;18057.729134062738;17514.562135946195;17687.11564421748;17954.820451795316;18689.15898784531;19029.524261893563;12105.51577936908;12426.813597796221;12589.055820813292;12607.87392126067;12613.243205407705;13809.24049177305;13907.791383129059;13994.16035037901;14020.369083391068;14025;10985.505652245509;11205.71985700364;11244.437778111225;11391.658250252505;11470.197086203885;11163.776724465628;11200.719982000515;11311.264767790068;11388.088952883583;11422.371769552754;10102.39385636864;10213.131883789962;10285.53715082808;10287.279890407899;10291.919348468602;7077.044598979072;7265.745698900513;7287.890681639674;7312.8537429250055;7344.22885597026;7087.220405755466;7312.744053958086;7349.669264882986;7418.221086785809;7489.850202996018 03:53:02 INFO - PID 6618 | |4;prototype.html;515.499965033917;517.9715115668638;521.1401188039735;533.413245430027;541.9891602167957;6390.329015453374;6424.164858568385;6485.967570162143;6514.609123452597;6558.868822623551;6323.272823625284;6365.745370185187;6393.552451328409;6423.710933008014;6446.580972236801;5256.395514515842;5272.340957380327;5311.973440132803;5319.787208511674;5325.920111198335;4901.436334821487;5015.348004759376;5202.1936599826895;5279.366476022883;5291.629585928987;4935.161022626145;4966.279889416032;4993.825216117437;5002.649814512985;5028.6982781033075;4997.325361076245;5019.52314530119;5048.268001139814;5050.469735639469;5083.059633967728;4375.606195442426;4451.243288640939;4482.798274077674;4488.7531185784765;4533.909321813579;6131.202943617302;6176.3514830943;6207.286162091327;6272.18461599989;6285.9057114143325;5719.428057194247;5757.596968212227;5769.134629805562;5787.218725472049;5799.594028418012;6660.400563949268;6690.19717633887;6707.396334329934;6731.9663401683165;6733.831654208684;4923.606111511071;4925.482824303433;4954.47977962316;4966.304717339575;4974.602031837444;6677.4625642256115;6702;6862.416694581017;6892.483063770187;6896.413804826596;5001.9499805002215;5028.731324639014;5039.5968322534845;5064;5085.863937146408;5109.463506331856;5117.795288188431;5133.589312854962;5153.587712982952;5176.948230517647;5696.914546281809;5741.827745167651;5758.424157584292;5763.337216220105;5805.332386775491;6638.800835974928;6670.065680952566;6723.798286051427;6742.685176390557;6767.932320676829;1765.8940463571969;1794.1119146022802;1797.21821007862;1803.6843552378282;1805.627722930556;1169.8947094761513;1245.3337464456654;1248.5318005747845;1250.9554521974253;1253.11029169289;5830.329512106077;5867.501262392744;5871.618344807659;5917.615355001911;5919.792807251725;6829.931700683029;6859.485538584626;6901.723931042802;6914.4468442525485;6940.7223711052;5840.240768700127;5843.824685259449;5846.889091072682;5859.648421094748;5954.07711804671;3571.5714114306447;3590.263995880838;3601.63983601643;3603.630620364297;3614.710823134143;6083.452489275986;6532.281449040602;6541.8364540885905;6541.967290163519;6549.6070235786;6829.385355318045;6918.965405172942;6941.097657304518;6953.33943275388;7025.156981162293;6587.275399705933;6608.768693095719;6617.022339947043;6617.239017512951;6659.368454728622;6732.629705366252;6829.282925292773;6862.416694581017;6865.759698410531;6875.656217189021;6706.295838936841;6732.259451460238;6743.1908171019795;6782.914733642593;6831.146106736658;6610.206775187008;6615.6030638161865;6630.867382652416;6653.600783952978;6687.364700353459;4963.8262660806695;4984.975075124601;4999.47505511916;5029.647924645386;5030.320906677698;6486;6746.886763683937;6748.561343512656;6878.174619045746;6898.586084834926;6574.342565743387;6595.94464885616;6618;6641.26946035926;6660.0039976014;6522.380373864476;6535.836604084936;6537.803865884031;6538.084668146558;6635.23694775107;6505.088658063132;6530.869382612416;6567.573107747981;6597.703103360264;6633.867322653617;6658.500612453989;6706.161729783777;6718.219671786883;6737.494687898526;6748.089007983859;6486;6498.155239818793;6526.836829079121;6526.967365163144;6532.5753826001155 03:53:02 INFO - PID 6618 | |5;yui.html;880.1946219209424;885.7475619448459;910.5174257643444;913.735016845115;919.0074719303153;19309;19876.60246795067;20082.899585502088;20108.396748097544;20203.696944545823;21011.684824727643;21534.246301379455;21668.891655541738;21743.565128697417;21809.454763630918;960.3757557587554;986.4328011393442;988.6786794291847;992.6773798515511;995.278423143219;968;995.9601615935354;1005.8038682456923;1007.9294449388545;1013.0376142664499;1055.2296823318982;1057.3602970202994;1062.3944351719524;1065.4885654885659;1067.6583493282153;1052.310736467615;1062.4156713807413;1064.084886997182;1064.984025239622;1069.8769641491212;776.6078130544096;777.898873146493;779.5089093870881;782.1435528096725;782.2959336597052;19921.9003904981;20086.49783755418;20241.190352385885;20309.695354569692;20590.382288531368;17462.563435914075;17511.912440437845;17721.556961076076;17919.641607167785;17953.7306940396;17516;17593.824061759347;17707.46877593674;17721.291148354052;17762.289508419646;3820.847166113352;3839.9808000960097;3849.5188101487315;3850.5379354477363;3850.7111966602615;131689;133778;134209.32895335558;134751;136635;16111.597210069842;16115.51653450375;16354.591135221715;16620.916895415445;16892;30279.545806812916;30408.69591304103;30413.391732165233;30457.695423045487;31343.37313253722;7676.961615191888;7961.243681850215;8582.613782379807;8948;8950.194482496607;4229.175310814362;4291.763952982616;4323.502797178302;4327.870163895088;4329.393884856123;5106.693598384109;5161.948380516222;5218.191180367049;5224.346956630421;5225.895482090413;1024.8872624011353;1049.7795462952713;1057.629829559648;1057.7672911959357;1059.369675043348;639.5011890725242;648.8929326661048;652.8824811533874;653.7842511971038;664.9102371179829;11633.302001879914;11966.880331196577;12147.574834880737;12493.063020273516;12570.87429125697;681.189384632286;689.8034060292792;691.1602403080282;709.3119673916293;709.9858002839915;5658.858528536737;5747.511461525817;5776.797812076557;5810.331811841608;5849.502792262705;111649.44175279072;112514.74970500544;113799.43100284612;115023;115067;96711.6150934714;98458;98687.50656246673;98754;103427.48286258521;84815;85858.57070714606;86381;87959;90825;11444.542218311175;11577.942110289394;12118.272903625812;12129.818052729039;12145.453454594388;38597;39386.40920386254;40208.396874047496;40434.39348409717;41693.166136677704;71214;71270.28729712637;72507.63746181446;72721;74675.8798618032;15824.367025318857;18135.45593632193;18572;18718.532036698645;18816.52958676044;18742.344017959305;18746.531336716693;18994.715079273545;19826;21526.246581369578;17789.822101778816;18238.544036399195;18822.341218057303;18917.148728306984;19102.23591056342;17664.55838604045;17965.820341796938;18056.368027118988;18059.458216253533;18133.27466901309;17242.224099915784;17490.82509174892;18679.533011674815;19093.522661933563;19124.139413726694;12186.451609677408;12804.743905122032;13396.26320552379;13816.654583635489;14013.649658758204;13863.653408664864;13954.58136255914;14010.78983815264;14222.431102755774;14481.275936202937 03:53:02 INFO - PID 6618 | __end_tp_report 03:53:02 INFO - PID 6618 | __start_cc_report 03:53:02 INFO - PID 6618 | _x_x_mozilla_cycle_collect,377 03:53:02 INFO - PID 6618 | __end_cc_report 03:53:02 INFO - PID 6618 | __startTimestamp1504608782956__endTimestamp 03:53:02 INFO - PID 6618 | 03:53:02 INFO - PID 6618 | ------- Summary: start ------- 03:53:02 INFO - PID 6618 | Number of tests: 6 03:53:02 INFO - PID 6618 | 03:53:02 INFO - PID 6618 | [#0] dojo.html Cycles:165 Average:6363.79 Median:6607.83 stddev:738.70 (11.2%) stddev-sans-first:702.05 03:53:02 INFO - PID 6618 | Values: 3347.5 3351.8 3360.2 3373.9 3405.4 6421.9 6428.0 6464.5 6479.3 6541.2 6328.1 6441.6 6453.2 6470.6 6473.5 5906.4 5906.5 5933.9 5949.0 5969.3 5954.8 5982.6 5990.1 6043.0 6100.5 5979.3 6043.7 6048.9 6066.5 6079.7 5732.1 6018.3 6018.6 6076.6 6130.4 5443.9 5874.2 5890.4 5944.5 6033.2 6460.0 6462.2 6500.0 6595.5 6618.1 6712.0 6773.7 6822.4 6954.1 7070.2 6956.5 6959.2 6974.2 6978.7 6983.0 6424.2 6429.5 6449.3 6451.0 6451.4 7035.4 7065.2 7082.0 7082.2 7087.5 6725.8 6797.7 6799.1 6805.4 6909.3 6642.2 6895.6 6987.5 6989.9 7034.9 6819.3 6826.4 6895.3 6944.3 6958.8 6732.7 6829.4 6844.5 6900.8 6923.1 5472.3 5473.2 5488.9 5492.7 5498.8 4734.5 4737.7 4743.8 4775.3 4799.1 5924.3 5945.2 6013.4 6027.0 6027.3 6880.7 6912.8 6913.8 6916.3 6923.7 5837.2 5984.5 5985.1 6015.9 6139.4 5870.3 6011.3 6013.7 6014.6 6030.0 6622.5 6686.3 6706.5 6767.1 6781.8 6809.6 6898.9 6918.1 6930.9 6931.8 6624.8 6638.1 6675.3 6730.8 6795.0 6300.7 6900.0 6915.9 6968.6 6969.9 6965.7 6995.8 7014.9 7028.1 7118.1 6607.1 6712.8 6714.7 6789.8 6852.3 6596.2 6607.8 6675.8 6675.8 6718.2 6571.8 6592.8 6597.8 6667.3 6683.2 6654.1 6688.4 6696.1 6778.5 6814.1 6478.3 6550.7 6634.0 6635.1 6637.9 03:53:02 INFO - PID 6618 | 03:53:02 INFO - PID 6618 | [#1] ext.html Cycles:180 Average:38857.87 Median:19886.27 stddev:54902.88 (276.1%) stddev-sans-first:54982.26 03:53:02 INFO - PID 6618 | Values: 733.0 790.9 819.3 823.4 1136.1 29598.0 30310.4 40824.0 41251.2 41328.4 41288.2 41775.8 41896.8 41914.4 41944.2 7535.8 7705.0 7729.0 7730.6 7748.3 7667.8 7759.7 7775.4 7779.3 7783.8 7740.7 7787.3 7798.5 7801.5 7806.5 7743.5 7770.6 7779.8 7780.6 7788.8 7635.2 7682.2 7684.6 7685.8 7690.3 36395.8 36584.6 36600.3 36635.1 36678.3 3551.8 3572.5 3607.6 3615.0 3620.9 30335.2 30375.7 30404.7 30483.0 30513.4 5043.2 5212.9 5224.5 5245.9 5269.1 179641.0 179978.0 180244.0 181116.0 181995.0 45802.8 45810.3 45886.8 45888.8 46020.3 47341.3 47541.3 47546.0 47585.3 47636.5 13471.5 13837.0 14967.4 15196.4 15469.8 12395.4 12410.5 12423.3 12431.7 12448.3 13828.7 13901.7 13907.5 13945.9 14032.0 5825.4 5846.9 5893.7 5907.4 5925.0 1024.2 1040.9 1046.1 1047.9 1049.8 22543.7 23208.3 23722.9 31011.4 31256.7 1136.0 1155.4 1161.7 1164.3 1165.7 12690.9 12998.0 16309.3 16457.2 16632.6 236540.0 238723.0 239558.0 240408.0 240478.0 54731.2 55101.0 55302.4 55349.7 55430.4 1479.9 1519.4 1523.1 1523.7 1524.9 27807.4 28067.9 28701.6 28815.4 29081.9 44821.8 45240.5 45261.3 45326.1 45505.0 211142.0 211255.0 213122.0 213146.0 213227.0 35223.3 37553.2 38752.4 39029.6 39117.4 46062.8 48193.8 48657.0 48712.5 48729.8 34666.8 35665.3 35686.5 35828.8 35944.8 35761.0 36024.5 36151.6 36272.3 36548.5 39047.4 40071.0 40078.0 40506.6 40789.2 34450.7 34663.3 34745.0 34999.3 35176.8 24863.6 26042.0 26130.5 26826.9 27015.6 03:53:02 INFO - PID 6618 | 03:53:02 INFO - PID 6618 | [#2] jquery.html Cycles:180 Average:35087.35 Median:22861.64 stddev:79169.96 (346.3%) stddev-sans-first:79349.61 03:53:02 INFO - PID 6618 | Values: 563.5 565.9 573.7 576.1 584.6 22073.3 22767.2 22829.7 22837.1 22886.2 25899.6 26020.2 26455.7 26513.9 26515.9 6352.5 6441.5 6452.5 6537.6 6539.6 6223.3 6404.2 6458.8 6498.4 6501.2 6471.5 6473.9 6474.5 6478.1 6480.9 6462.6 6467.5 6475.1 6477.3 6485.4 5922.7 5977.0 5988.0 5999.4 6000.0 28176.9 28988.9 29433.4 29797.3 30191.8 2059.1 2095.6 2096.2 2100.8 2108.9 19190.0 19814.8 19819.1 19828.8 19848.3 2399.4 2429.7 2456.4 2466.1 2518.1 134361.0 135632.6 136942.0 138301.0 138473.0 14120.9 14568.9 14592.9 15041.4 15414.3 22748.5 22955.0 23582.5 23585.0 23598.2 10231.0 10240.2 10367.5 10372.1 10443.1 9453.1 9585.7 9632.8 9640.9 9654.0 9042.5 9376.6 9453.7 9504.7 9593.5 2737.2 2781.3 2820.6 2832.1 2850.9 974.6 990.5 995.0 996.8 1004.6 20068.4 20128.4 20209.2 20327.4 20867.3 1038.5 1059.9 1063.6 1074.8 1079.0 11215.8 11343.6 11387.6 11394.9 11396.0 444918.0 453685.0 474306.0 474711.0 477046.0 123509.0 125334.0 126646.0 127379.0 127649.0 1212.6 1250.6 1282.3 1285.1 1292.2 20857.5 20989.9 21146.4 21324.5 21376.6 60077.0 60887.0 61494.4 62556.0 63848.4 79186.0 82011.0 82836.0 83133.0 83429.6 14310.9 14810.4 14840.5 14842.9 14902.2 23379.8 23973.3 24768.4 25150.0 25297.0 19451.0 19611.5 19664.3 19898.9 19927.4 17192.2 17480.6 17843.5 17963.2 18537.6 18992.2 19832.5 19906.2 20113.5 20223.9 14636.4 14692.0 14908.3 14955.0 14969.9 18783.4 18829.4 18872.0 18891.5 18939.6 03:53:02 INFO - PID 6618 | 03:53:02 INFO - PID 6618 | [#3] mootools.html Cycles:180 Average:9312.22 Median:26488.60 stddev:6495.69 (24.5%) stddev-sans-first:6486.47 03:53:02 INFO - PID 6618 | Values: 1364.7 1432.6 1433.6 1439.0 1444.9 14794.2 15345.9 15386.2 15394.5 15444.8 14863.6 15388.2 15938.8 15939.8 15989.6 2792.3 2848.5 2849.0 2850.1 2851.0 2684.3 2726.0 2799.0 2799.7 2813.6 2790.1 2821.6 2822.1 2823.2 2825.5 2717.6 2747.6 2754.4 2759.6 2766.4 2667.4 2683.0 2692.6 2704.6 2705.6 14196.1 14464.6 14490.3 14500.9 14506.3 7816.5 8134.1 8150.7 8162.5 8170.0 5428.4 5499.6 5529.1 5657.8 5777.1 1937.4 1943.3 1967.5 1986.2 1988.9 26099.3 26301.5 26485.1 26486.2 26491.0 6931.7 7129.9 7218.6 7418.0 7427.7 17285.0 17328.9 17348.0 17417.7 17577.7 7693.8 7810.8 7847.9 7920.8 7937.8 7242.2 7291.4 7451.2 7459.2 7507.7 5151.9 5292.5 5323.8 5336.8 5359.8 1390.9 1439.2 1575.9 1798.4 1827.7 888.9 909.2 913.1 917.7 926.4 7869.7 8361.9 8428.9 8437.6 8528.1 969.2 973.9 999.2 1001.2 1008.4 5016.4 5041.9 5079.6 5142.4 5147.2 20476.7 21141.9 21898.3 22112.2 22114.1 19342.2 19780.4 19949.4 19952.6 19975.8 10678.8 11309.2 11348.4 11354.7 11362.7 8082.6 8256.5 8422.3 8450.9 8522.7 17451.8 17517.6 17642.2 17743.9 18057.7 17514.6 17687.1 17954.8 18689.2 19029.5 12105.5 12426.8 12589.1 12607.9 12613.2 13809.2 13907.8 13994.2 14020.4 14025.0 10985.5 11205.7 11244.4 11391.7 11470.2 11163.8 11200.7 11311.3 11388.1 11422.4 10102.4 10213.1 10285.5 10287.3 10291.9 7077.0 7265.7 7287.9 7312.9 7344.2 7087.2 7312.7 7349.7 7418.2 7489.9 03:53:02 INFO - PID 6618 | 03:53:02 INFO - PID 6618 | [#4] prototype.html Cycles:180 Average:5600.53 Median:6304.59 stddev:1570.84 (24.9%) stddev-sans-first:1528.17 03:53:02 INFO - PID 6618 | Values: 515.5 518.0 521.1 533.4 542.0 6390.3 6424.2 6486.0 6514.6 6558.9 6323.3 6365.7 6393.6 6423.7 6446.6 5256.4 5272.3 5312.0 5319.8 5325.9 4901.4 5015.3 5202.2 5279.4 5291.6 4935.2 4966.3 4993.8 5002.6 5028.7 4997.3 5019.5 5048.3 5050.5 5083.1 4375.6 4451.2 4482.8 4488.8 4533.9 6131.2 6176.4 6207.3 6272.2 6285.9 5719.4 5757.6 5769.1 5787.2 5799.6 6660.4 6690.2 6707.4 6732.0 6733.8 4923.6 4925.5 4954.5 4966.3 4974.6 6677.5 6702.0 6862.4 6892.5 6896.4 5001.9 5028.7 5039.6 5064.0 5085.9 5109.5 5117.8 5133.6 5153.6 5176.9 5696.9 5741.8 5758.4 5763.3 5805.3 6638.8 6670.1 6723.8 6742.7 6767.9 1765.9 1794.1 1797.2 1803.7 1805.6 1169.9 1245.3 1248.5 1251.0 1253.1 5830.3 5867.5 5871.6 5917.6 5919.8 6829.9 6859.5 6901.7 6914.4 6940.7 5840.2 5843.8 5846.9 5859.6 5954.1 3571.6 3590.3 3601.6 3603.6 3614.7 6083.5 6532.3 6541.8 6542.0 6549.6 6829.4 6919.0 6941.1 6953.3 7025.2 6587.3 6608.8 6617.0 6617.2 6659.4 6732.6 6829.3 6862.4 6865.8 6875.7 6706.3 6732.3 6743.2 6782.9 6831.1 6610.2 6615.6 6630.9 6653.6 6687.4 4963.8 4985.0 4999.5 5029.6 5030.3 6486.0 6746.9 6748.6 6878.2 6898.6 6574.3 6595.9 6618.0 6641.3 6660.0 6522.4 6535.8 6537.8 6538.1 6635.2 6505.1 6530.9 6567.6 6597.7 6633.9 6658.5 6706.2 6718.2 6737.5 6748.1 6486.0 6498.2 6526.8 6527.0 6532.6 03:53:02 INFO - PID 6618 | 03:53:02 INFO - PID 6618 | [#5] yui.html Cycles:180 Average:24177.08 Median:20002.40 stddev:33361.40 (166.8%) stddev-sans-first:33409.13 03:53:02 INFO - PID 6618 | Values: 880.2 885.7 910.5 913.7 919.0 19309.0 19876.6 20082.9 20108.4 20203.7 21011.7 21534.2 21668.9 21743.6 21809.5 960.4 986.4 988.7 992.7 995.3 968.0 996.0 1005.8 1007.9 1013.0 1055.2 1057.4 1062.4 1065.5 1067.7 1052.3 1062.4 1064.1 1065.0 1069.9 776.6 777.9 779.5 782.1 782.3 19921.9 20086.5 20241.2 20309.7 20590.4 17462.6 17511.9 17721.6 17919.6 17953.7 17516.0 17593.8 17707.5 17721.3 17762.3 3820.8 3840.0 3849.5 3850.5 3850.7 131689.0 133778.0 134209.3 134751.0 136635.0 16111.6 16115.5 16354.6 16620.9 16892.0 30279.5 30408.7 30413.4 30457.7 31343.4 7677.0 7961.2 8582.6 8948.0 8950.2 4229.2 4291.8 4323.5 4327.9 4329.4 5106.7 5161.9 5218.2 5224.3 5225.9 1024.9 1049.8 1057.6 1057.8 1059.4 639.5 648.9 652.9 653.8 664.9 11633.3 11966.9 12147.6 12493.1 12570.9 681.2 689.8 691.2 709.3 710.0 5658.9 5747.5 5776.8 5810.3 5849.5 111649.4 112514.7 113799.4 115023.0 115067.0 96711.6 98458.0 98687.5 98754.0 103427.5 84815.0 85858.6 86381.0 87959.0 90825.0 11444.5 11577.9 12118.3 12129.8 12145.5 38597.0 39386.4 40208.4 40434.4 41693.2 71214.0 71270.3 72507.6 72721.0 74675.9 15824.4 18135.5 18572.0 18718.5 18816.5 18742.3 18746.5 18994.7 19826.0 21526.2 17789.8 18238.5 18822.3 18917.1 19102.2 17664.6 17965.8 18056.4 18059.5 18133.3 17242.2 17490.8 18679.5 19093.5 19124.1 12186.5 12804.7 13396.3 13816.7 14013.6 13863.7 13954.6 14010.8 14222.4 14481.3 03:53:02 INFO - PID 6618 | -------- Summary: end -------- 03:53:02 INFO - PID 6618 | 03:53:03 INFO - TEST-INFO | 6618: exit 0 03:53:03 INFO - TEST-OK | dromaeo_css | took 1111758ms 03:53:03 INFO - TEST-START | kraken 03:53:03 INFO - Initialising browser for kraken test... 03:53:03 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53210/getInfo.html -profile /tmp/tmpydWp5L/profile 03:53:03 INFO - TEST-INFO | started process 6990 (/builds/slave/test/build/application/firefox/firefox http://localhost:53210/getInfo.html) 03:53:09 INFO - TEST-INFO | 6990: exit 0 03:53:10 INFO - Browser initialized. 03:53:10 INFO - Running cycle 1/1 for kraken test... 03:53:10 INFO - Using env: {'DISPLAY': ':0', 03:53:10 INFO - 'HOME': '/home/cltbld', 03:53:10 INFO - 'JSGC_DISABLE_POISONING': '1', 03:53:10 INFO - 'LANG': 'en_US.UTF-8', 03:53:10 INFO - 'LANGUAGE': 'en_US:en', 03:53:10 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:53:10 INFO - 'LOGNAME': 'cltbld', 03:53:10 INFO - 'MAIL': '/var/mail/cltbld', 03:53:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:53:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:53:10 INFO - 'MOZ_CRASHREPORTER': '1', 03:53:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:10 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:53:10 INFO - 'MOZ_NO_REMOTE': '1', 03:53:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:53:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:10 INFO - 'NO_EM_RESTART': '1', 03:53:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:10 INFO - 'PWD': '/builds/slave/test', 03:53:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:53:10 INFO - 'RUST_BACKTRACE': 'full', 03:53:10 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:53:10 INFO - 'SHELL': '/bin/bash', 03:53:10 INFO - 'SHLVL': '1', 03:53:10 INFO - 'TERM': 'linux', 03:53:10 INFO - 'TMOUT': '86400', 03:53:10 INFO - 'USER': 'cltbld', 03:53:10 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1504607590.704876-831758737', 03:53:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:10 INFO - '_': '/tools/buildbot/bin/python'} 03:53:10 INFO - TEST-INFO | started process 7176 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpydWp5L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:53:11 INFO - PID 7176 | 03:53:11 INFO - PID 7176 | (/builds/slave/test/build/application/firefox/firefox:7229): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:53:11 INFO - PID 7176 | 03:53:21 INFO - PID 7176 | RSS: Main: 164438016 03:53:21 INFO - PID 7176 | 03:53:24 INFO - PID 7176 | Cycle 1(1): loaded http://localhost:53210/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53210/tests/kraken/driver.html?testName=audio-beat-detection) 03:53:24 INFO - PID 7176 | RSS: Main: 170151936 03:53:24 INFO - PID 7176 | 03:53:27 INFO - PID 7176 | Cycle 1(1): loaded http://localhost:53210/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53210/tests/kraken/driver.html?testName=audio-dft) 03:53:28 INFO - PID 7176 | RSS: Main: 174383104 03:53:28 INFO - PID 7176 | 03:53:31 INFO - PID 7176 | Cycle 1(1): loaded http://localhost:53210/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53210/tests/kraken/driver.html?testName=audio-fft) 03:53:31 INFO - PID 7176 | RSS: Main: 167669760 03:53:31 INFO - PID 7176 | 03:53:33 INFO - PID 7176 | Cycle 1(1): loaded http://localhost:53210/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53210/tests/kraken/driver.html?testName=audio-oscillator) 03:53:34 INFO - PID 7176 | RSS: Main: 168681472 03:53:34 INFO - PID 7176 | 03:53:36 INFO - PID 7176 | Cycle 1(1): loaded http://localhost:53210/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53210/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:53:37 INFO - PID 7176 | RSS: Main: 169287680 03:53:37 INFO - PID 7176 | 03:53:40 INFO - PID 7176 | Cycle 1(1): loaded http://localhost:53210/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53210/tests/kraken/driver.html?testName=imaging-darkroom) 03:53:41 INFO - PID 7176 | RSS: Main: 169844736 03:53:41 INFO - PID 7176 | 03:53:44 INFO - PID 7176 | Cycle 1(1): loaded http://localhost:53210/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53210/tests/kraken/driver.html?testName=imaging-desaturate) 03:53:45 INFO - PID 7176 | RSS: Main: 169820160 03:53:45 INFO - PID 7176 | 03:53:48 INFO - PID 7176 | Cycle 1(1): loaded http://localhost:53210/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53210/tests/kraken/driver.html?testName=json-parse-financial) 03:53:48 INFO - PID 7176 | RSS: Main: 170061824 03:53:48 INFO - PID 7176 | 03:53:50 INFO - PID 7176 | Cycle 1(1): loaded http://localhost:53210/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53210/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:53:51 INFO - PID 7176 | RSS: Main: 170082304 03:53:51 INFO - PID 7176 | 03:53:52 INFO - PID 7176 | Cycle 1(1): loaded http://localhost:53210/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53210/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:53:53 INFO - PID 7176 | RSS: Main: 170192896 03:53:53 INFO - PID 7176 | 03:53:55 INFO - PID 7176 | Cycle 1(1): loaded http://localhost:53210/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53210/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:53:55 INFO - PID 7176 | RSS: Main: 169889792 03:53:55 INFO - PID 7176 | 03:53:58 INFO - PID 7176 | Cycle 1(1): loaded http://localhost:53210/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53210/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:53:59 INFO - PID 7176 | RSS: Main: 170307584 03:53:59 INFO - PID 7176 | 03:54:02 INFO - PID 7176 | Cycle 1(1): loaded http://localhost:53210/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53210/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:54:02 INFO - PID 7176 | RSS: Main: 170569728 03:54:02 INFO - PID 7176 | 03:54:04 INFO - PID 7176 | Cycle 1(1): loaded http://localhost:53210/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53210/tests/kraken/driver.html?testName=ai-astar) 03:54:04 INFO - PID 7176 | RSS: Main: 172113920 03:54:04 INFO - PID 7176 | 03:54:04 INFO - PID 7176 | __start_tp_report 03:54:04 INFO - PID 7176 | _x_x_mozilla_page_load 03:54:04 INFO - PID 7176 | _x_x_mozilla_page_load_details 03:54:04 INFO - PID 7176 | |i|pagename|runs| 03:54:04 INFO - PID 7176 | |0;ai-astar;100;109;100;108;107;113;111;99;109;110 03:54:04 INFO - PID 7176 | |1;audio-beat-detection;143;122;156;172;124;145;143;119;165;117 03:54:04 INFO - PID 7176 | |2;audio-dft;166;164;163;163;164;161;160;166;169;164 03:54:04 INFO - PID 7176 | |3;audio-fft;74;73;74;183;74;74;73;74;154;75 03:54:04 INFO - PID 7176 | |4;audio-oscillator;80;79;138;80;90;80;130;79;79;135 03:54:04 INFO - PID 7176 | |5;imaging-gaussian-blur;115;114;115;114;115;115;115;114;114;114 03:54:04 INFO - PID 7176 | |6;imaging-darkroom;156;148;148;148;149;147;148;147;151;148 03:54:04 INFO - PID 7176 | |7;imaging-desaturate;94;95;95;94;94;94;94;94;94;94 03:54:04 INFO - PID 7176 | |8;json-parse-financial;53;54;54;52;51;52;52;51;51;53 03:54:04 INFO - PID 7176 | |9;json-stringify-tinderbox;38;39;38;39;39;38;39;39;39;50 03:54:04 INFO - PID 7176 | |10;stanford-crypto-aes;77;73;74;74;78;79;77;76;74;74 03:54:04 INFO - PID 7176 | |11;stanford-crypto-ccm;141;132;119;118;118;118;121;127;127;161 03:54:04 INFO - PID 7176 | |12;stanford-crypto-pbkdf2;171;172;169;172;173;170;168;169;173;182 03:54:04 INFO - PID 7176 | |13;stanford-crypto-sha256-iterative;64;66;65;63;63;64;65;65;64;64 03:54:04 INFO - PID 7176 | __end_tp_report 03:54:04 INFO - PID 7176 | __start_cc_report 03:54:04 INFO - PID 7176 | _x_x_mozilla_cycle_collect,923 03:54:04 INFO - PID 7176 | __end_cc_report 03:54:04 INFO - PID 7176 | __startTimestamp1504608844940__endTimestamp 03:54:04 INFO - PID 7176 | 03:54:04 INFO - PID 7176 | ------- Summary: start ------- 03:54:04 INFO - PID 7176 | Number of tests: 14 03:54:04 INFO - PID 7176 | 03:54:04 INFO - PID 7176 | [#0] ai-astar Cycles:10 Average:106.60 Median:109.50 stddev:5.06 (4.6%) stddev-sans-first:4.77 03:54:04 INFO - PID 7176 | Values: 100.0 109.0 100.0 108.0 107.0 113.0 111.0 99.0 109.0 110.0 03:54:04 INFO - PID 7176 | 03:54:04 INFO - PID 7176 | [#1] audio-beat-detection Cycles:10 Average:140.60 Median:144.00 stddev:19.70 (13.7%) stddev-sans-first:20.88 03:54:04 INFO - PID 7176 | Values: 143.0 122.0 156.0 172.0 124.0 145.0 143.0 119.0 165.0 117.0 03:54:04 INFO - PID 7176 | 03:54:04 INFO - PID 7176 | [#2] audio-dft Cycles:10 Average:164.00 Median:164.00 stddev:2.58 (1.6%) stddev-sans-first:2.64 03:54:04 INFO - PID 7176 | Values: 166.0 164.0 163.0 163.0 164.0 161.0 160.0 166.0 169.0 164.0 03:54:04 INFO - PID 7176 | 03:54:04 INFO - PID 7176 | [#3] audio-fft Cycles:10 Average:92.80 Median:74.00 stddev:40.48 (54.7%) stddev-sans-first:42.36 03:54:04 INFO - PID 7176 | Values: 74.0 73.0 74.0 183.0 74.0 74.0 73.0 74.0 154.0 75.0 03:54:04 INFO - PID 7176 | 03:54:04 INFO - PID 7176 | [#4] audio-oscillator Cycles:10 Average:97.00 Median:79.50 stddev:26.04 (32.8%) stddev-sans-first:26.88 03:54:04 INFO - PID 7176 | Values: 80.0 79.0 138.0 80.0 90.0 80.0 130.0 79.0 79.0 135.0 03:54:04 INFO - PID 7176 | 03:54:04 INFO - PID 7176 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:115.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 03:54:04 INFO - PID 7176 | Values: 115.0 114.0 115.0 114.0 115.0 115.0 115.0 114.0 114.0 114.0 03:54:04 INFO - PID 7176 | 03:54:04 INFO - PID 7176 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:148.00 stddev:2.71 (1.8%) stddev-sans-first:1.20 03:54:04 INFO - PID 7176 | Values: 156.0 148.0 148.0 148.0 149.0 147.0 148.0 147.0 151.0 148.0 03:54:04 INFO - PID 7176 | 03:54:04 INFO - PID 7176 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:54:04 INFO - PID 7176 | Values: 94.0 95.0 95.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 03:54:04 INFO - PID 7176 | 03:54:04 INFO - PID 7176 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.50 stddev:1.16 (2.2%) stddev-sans-first:1.20 03:54:04 INFO - PID 7176 | Values: 53.0 54.0 54.0 52.0 51.0 52.0 52.0 51.0 51.0 53.0 03:54:04 INFO - PID 7176 | 03:54:04 INFO - PID 7176 | [#9] json-stringify-tinderbox Cycles:10 Average:39.80 Median:39.00 stddev:3.61 (9.3%) stddev-sans-first:3.77 03:54:04 INFO - PID 7176 | Values: 38.0 39.0 38.0 39.0 39.0 38.0 39.0 39.0 39.0 50.0 03:54:04 INFO - PID 7176 | 03:54:04 INFO - PID 7176 | [#10] stanford-crypto-aes Cycles:10 Average:75.60 Median:76.50 stddev:2.07 (2.7%) stddev-sans-first:2.13 03:54:04 INFO - PID 7176 | Values: 77.0 73.0 74.0 74.0 78.0 79.0 77.0 76.0 74.0 74.0 03:54:04 INFO - PID 7176 | 03:54:04 INFO - PID 7176 | [#11] stanford-crypto-ccm Cycles:10 Average:128.20 Median:127.00 stddev:13.77 (10.8%) stddev-sans-first:13.80 03:54:04 INFO - PID 7176 | Values: 141.0 132.0 119.0 118.0 118.0 118.0 121.0 127.0 127.0 161.0 03:54:04 INFO - PID 7176 | 03:54:04 INFO - PID 7176 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.90 Median:172.00 stddev:3.96 (2.3%) stddev-sans-first:4.18 03:54:04 INFO - PID 7176 | Values: 171.0 172.0 169.0 172.0 173.0 170.0 168.0 169.0 173.0 182.0 03:54:04 INFO - PID 7176 | 03:54:04 INFO - PID 7176 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:64.50 stddev:0.95 (1.5%) stddev-sans-first:1.00 03:54:04 INFO - PID 7176 | Values: 64.0 66.0 65.0 63.0 63.0 64.0 65.0 65.0 64.0 64.0 03:54:04 INFO - PID 7176 | -------- Summary: end -------- 03:54:04 INFO - PID 7176 | 03:54:05 INFO - PID 7176 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:54:05 INFO - TEST-INFO | 7176: exit 0 03:54:05 INFO - TEST-OK | kraken | took 61858ms 03:54:05 INFO - SUITE-END | took 1173s 03:54:06 INFO - Completed test suite (00:19:34) 03:54:06 INFO - javascript benchmark 03:54:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8719.85950863679, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3347.4811404232337, 3351.7821341612794, 3360.1935535471493, 3373.865045398184, 3405.4381027130526, 6421.903671444932, 6428.0, 6464.515161362905, 6479.319671434502, 6541.247756508003, 6328.082428047942, 6441.6135031898, 6453.225612926455, 6470.579412338207, 6473.546851720382, 5906.409359064091, 5906.497947674453, 5933.940660593382, 5949.0, 5969.343372229073, 5954.791582294621, 5982.611130276518, 5990.071538911454, 6043.033114701649, 6100.450959413652, 5979.282486101674, 6043.7280322385595, 6048.909266361008, 6066.545009124311, 6079.726412311456, 5732.140178973187, 6018.307894592134, 6018.638881667114, 6076.635401875879, 6130.386961303879, 5443.891122177534, 5874.1776151338845, 5890.410958904118, 5944.524438044946, 6033.185519954838, 6459.967700161469, 6462.224533056016, 6499.967500162516, 6595.47236221106, 6618.106555614979, 6712.0, 6773.72905083796, 6822.4200942919915, 6954.130733658293, 7070.222275549685, 6956.5478243913985, 6959.19969203543, 6974.232834388214, 6978.685959131801, 6982.987466817283, 6424.164858568356, 6429.4534964528075, 6449.32282110381, 6451.032345148265, 6451.387118223761, 7035.366816986393, 7065.2228254891925, 7082.008518807268, 7082.150141982995, 7087.468439866928, 6725.764598239038, 6797.728090876409, 6799.082123913307, 6805.421539169226, 6909.30906909305, 6642.236142843538, 6895.620740859201, 6987.475939304471, 6989.89515157273, 7034.8944765828555, 6819.283975182633, 6826.351496607815, 6895.310468953065, 6944.305569443116, 6958.826029349307, 6732.697028633724, 6829.351211634986, 6844.486663500257, 6900.758473453405, 6923.134608173978, 5472.288602481652, 5473.233747275384, 5488.874780669953, 5492.725363731877, 5498.752556134904, 4734.502877197913, 4737.6683632146105, 4743.810247590127, 4775.259834725553, 4799.064182484382, 5924.318703349084, 5945.1973983512535, 6013.428724271187, 6027.0, 6027.336992930862, 6880.65596720172, 6912.827179320457, 6913.827154321081, 6916.273791251947, 6923.653817309114, 5837.211976383219, 5984.491318237911, 5985.072313791369, 6015.939840601625, 6139.416755408229, 5870.26621672291, 6011.3086994995265, 6013.6993150342305, 6014.609050411709, 6030.005049166926, 6622.470202383798, 6686.264510903797, 6706.463482921355, 6767.052612634235, 6781.762638307734, 6809.625470598967, 6898.8620227596175, 6918.066061081689, 6930.896036559557, 6931.792046238621, 6624.8343791405605, 6638.103855979574, 6675.332466753286, 6730.831729206809, 6795.014722865256, 6300.7479700811455, 6900.0, 6915.93084069173, 6968.616726080114, 6969.895451568129, 6965.7213711453005, 6995.8251043722275, 7014.859702805813, 7028.121484814398, 7118.074650295428, 6607.07500949877, 6712.83217919556, 6714.664266786739, 6789.796306110825, 6852.349026842442, 6596.175478065242, 6607.834804129935, 6675.766348177791, 6675.7997260082275, 6718.160229971254, 6571.80284591463, 6592.8351791205605, 6597.769078082244, 6667.299933507106, 6683.231428385798, 6654.13496245485, 6688.431483323972, 6696.129503164558, 6778.525503214925, 6814.080099186546, 6478.28738838718, 6550.705218265285, 6634.0, 6635.104260924713, 6637.900431493435], "value": 6310.314490994698, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.9926700732995, 790.8774140008298, 819.3404309530827, 823.3783493462439, 1136.0740996088193, 29598.0, 30310.39379212417, 40824.0, 41251.17497650053, 41328.38007429891, 41288.17423651525, 41775.79112104435, 41896.790516047375, 41914.37128443076, 41944.16111677764, 7535.773926782192, 7705.0, 7729.0, 7730.574818384986, 7748.263914928101, 7667.769966900974, 7759.689612415496, 7775.377969762406, 7779.33875620573, 7783.844323113534, 7740.651670674833, 7787.260210280015, 7798.454108212427, 7801.4929029612895, 7806.4925779824125, 7743.4966727162555, 7770.57261850598, 7779.766607001742, 7780.6109694515335, 7788.766337009899, 7635.236476352376, 7682.231776822329, 7684.615769211573, 7685.846283074307, 7690.346320562759, 36395.81802090999, 36584.634153658386, 36600.26799463996, 36635.08412289687, 36678.26643467142, 3551.8224088795455, 3572.499850020999, 3607.567091948983, 3615.023943535257, 3620.9094772630633, 30335.241618959702, 30375.696243037506, 30404.69595304041, 30483.0, 30513.389732205233, 5043.218301163325, 5212.8957420851375, 5224.52979231871, 5245.868853278698, 5269.051570717269, 179641.0, 179978.0, 180244.0, 181116.0, 181994.9999999987, 45802.77098614552, 45810.31284530668, 45886.77056614762, 45888.77055614701, 46020.3096953546, 47341.28988065182, 47541.28688069682, 47546.0, 47585.286220706024, 47636.52363476321, 13471.461141554228, 13836.962227832953, 14967.401303947938, 15196.392144314324, 15469.84530154684, 12395.442205100791, 12410.503579856704, 12423.254604723745, 12431.689207769878, 12448.31534265624, 13828.654283642989, 13901.652458688412, 13907.513237036655, 13945.930270348583, 14032.0, 5825.4174582542255, 5846.912296315559, 5893.675847828325, 5907.409259074058, 5924.9703751480965, 1024.1857723110145, 1040.8802987656366, 1046.0951277145214, 1047.9214058945608, 1049.800537897797, 22543.661845072336, 23208.3037508875, 23722.881385593308, 31011.379772404427, 31256.687433125833, 1135.9772804544027, 1155.4338374196584, 1161.7153797319543, 1164.2723297938787, 1165.7085728567858, 12690.936545317214, 12998.0, 16309.347626095061, 16457.177141142896, 16632.594406817832, 236540.0, 238723.0, 239558.0, 240408.0, 240478.0, 54731.17903231455, 55101.0, 55302.44697553053, 55349.72325138348, 55430.445695543334, 1479.8668119869265, 1519.4226194046191, 1523.0785374848058, 1523.6724104317402, 1524.8563577317013, 27807.44385112327, 28067.859660701564, 28701.56036736901, 28815.42369152647, 29081.85459072691, 44821.775891120335, 45240.54759452363, 45261.32108018317, 45326.09347813091, 45505.0, 211142.0, 211255.0, 213122.0, 213146.0, 213227.0, 35223.29553408866, 37553.24893502169, 38752.41871371988, 39029.6097039026, 39117.41323880201, 46062.84842878821, 48193.75903120462, 48657.0, 48712.5128748708, 48729.75635121802, 34666.82666586752, 35665.28669426545, 35686.46470303, 35828.82085589555, 35944.820275898455, 35761.0, 36024.459633106046, 36151.63848361483, 36272.274554508236, 36548.451773223955, 39047.41428878512, 40071.0, 40078.0, 40506.59493405146, 40789.1842163161, 34450.655493445745, 34663.30673386468, 34745.0, 34999.30001400009, 35176.82411587926, 24863.62704559469, 26042.0, 26130.477390452466, 26826.86586567055, 27015.59476607813], "value": 17779.680256198553, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.4844117632366, 565.8755073883744, 573.6787399056528, 576.0955300178721, 584.643367545797, 22073.33779986599, 22767.203147889828, 22829.657555136688, 22837.08651653934, 22886.198983035596, 25899.611505827426, 26020.21939341818, 26455.735442645568, 26513.86743066282, 26515.86742066287, 6352.46004089653, 6441.4524765395, 6452.483801295909, 6537.5750576212395, 6539.64031978241, 6223.315435302113, 6404.167458230423, 6458.838529036765, 6498.3826536478955, 6501.187351581052, 6471.514636402265, 6473.8705225895455, 6474.482041436674, 6478.060681201223, 6480.935190648104, 6462.579932304385, 6467.482601391877, 6475.061116138158, 6477.255115661688, 6485.383888530606, 5922.674252916088, 5976.97011514944, 5988.041913293852, 5999.400059994009, 6000.0, 28176.85911570429, 28988.855055724587, 29433.411331773244, 29797.255068623243, 30191.849040754874, 2059.1454546363243, 2095.5808838232415, 2096.2348742708955, 2100.7794181611016, 2108.8734675919495, 19190.0, 19814.80185198144, 19819.10814013373, 19828.80171198284, 19848.305309314248, 2399.412144024725, 2429.6962879640046, 2456.4104614892476, 2466.1491785334033, 2518.1312447205682, 134361.0, 135632.643673563, 136942.0, 138301.0, 138473.0, 14120.858791411954, 14568.854311456962, 14592.927035364755, 15041.398344066334, 15414.306356213772, 22748.545029099656, 22955.0, 23582.52383499742, 23585.0, 23598.174063908024, 10231.0, 10240.231982601335, 10367.533460994273, 10372.11836993849, 10443.11233545142, 9453.101955314372, 9585.664501742405, 9632.75918102053, 9640.855387169198, 9653.951730241304, 9042.502662353634, 9376.62493500266, 9453.669121580711, 9504.667336643184, 9593.520323983774, 2737.219892330716, 2781.2907708534194, 2820.562812764025, 2832.122042166935, 2850.900218492343, 974.6442548469757, 990.4651488196293, 994.9801003979879, 996.7508122969258, 1004.6082028009082, 20068.39794806158, 20128.39614811558, 20209.191632334543, 20327.390178294674, 20867.269645562334, 1038.5015192707392, 1059.89930956559, 1063.6170978447753, 1074.8011617850723, 1078.983815242772, 11215.831762523569, 11343.602973895873, 11387.601433949772, 11394.886051139549, 11396.0, 444918.0, 453685.0, 474306.0, 474711.0, 477046.0, 123509.0, 125334.0, 126646.0, 127379.0, 127649.0, 1212.6180253220207, 1250.5810553464692, 1282.2691066092239, 1285.13895689888, 1292.179466039072, 20857.478563036046, 20989.89505052465, 21146.365609031753, 21324.466888327916, 21376.572468550232, 60077.0, 60887.0, 61494.385056150655, 62556.0, 63848.36151638424, 79186.0, 82011.0, 82836.0, 83133.0, 83429.58285208535, 14310.856891430953, 14810.407583696531, 14840.48058317997, 14842.925785371004, 14902.180380078766, 23379.76620233844, 23973.28080157598, 24768.380790480383, 25150.0, 25297.0, 19451.0, 19611.509712257306, 19664.311749089284, 19898.90050549738, 19927.402177934106, 17192.22634981454, 17480.562985925455, 17843.46469605862, 17963.191656375235, 18537.629247414705, 18992.24031038743, 19832.50418739543, 19906.203751849764, 20113.497162571053, 20223.89888050609, 14636.414543418145, 14692.0, 14908.329125189175, 14955.0, 14969.850301497281, 18783.436496905113, 18829.420284805863, 18872.0, 18891.527711807314, 18939.62120757605], "value": 12307.615541166335, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1364.7338768940058, 1432.641839540115, 1433.5627633571762, 1439.035845983191, 1444.9060811047289, 14794.186319752409, 15345.923270383633, 15386.230688465588, 15394.461193858217, 15444.845551544482, 14863.554093377188, 15388.230588470587, 15938.840611593881, 15939.760903586455, 15989.600259993476, 2792.2600510864636, 2848.5015122353607, 2848.957265641017, 2850.1307101334087, 2851.0, 2684.2618279972967, 2725.9863700681467, 2798.958015629757, 2799.7200279971944, 2813.563897595876, 2790.1350581319753, 2821.5626577880357, 2822.068717323278, 2823.1953893140458, 2825.547912334027, 2717.619533265344, 2747.6015977683223, 2754.394033312668, 2759.5860620906724, 2766.405222877071, 2667.399835037101, 2682.9865850670817, 2692.5557283048274, 2704.648395708545, 2705.580635001578, 14196.077254978496, 14464.566063018126, 14490.347934342979, 14500.854991450162, 14506.274686265644, 7816.452848300622, 8134.145914678992, 8150.7147249845975, 8162.469439486474, 8170.0, 5428.4300148484235, 5499.642523236017, 5529.087700529408, 5657.773689052474, 5777.133429985493, 1937.3897222374908, 1943.3101249056522, 1967.5376286572643, 1986.195590785734, 1988.9104990275473, 26099.347516312246, 26301.473970520674, 26485.073022444314, 26486.205413837615, 26491.0, 6931.6880740366805, 7129.89305160423, 7218.6390680465765, 7418.0, 7427.740029098955, 17285.0, 17328.913355433142, 17348.0, 17417.738733919003, 17577.736333955, 7693.769186924401, 7810.804729881798, 7847.882281765778, 7920.801979950432, 7937.841243175104, 7242.203357630657, 7291.416686665054, 7451.180370159278, 7459.216782237895, 7507.699692012258, 5151.9484805152215, 5292.4707529247535, 5323.813666521653, 5336.813211537655, 5359.785608575691, 1390.8539603341503, 1439.194051331258, 1575.8739300855905, 1798.4245041586566, 1827.6892928202237, 888.8533391990378, 909.1726528858707, 913.1051569461964, 917.7155081924625, 926.3839546701369, 7869.724559640385, 8361.874571881426, 8428.873566896502, 8437.620307086196, 8528.147185281423, 969.2197780786535, 973.9366941148803, 999.160705007797, 1001.2190491416707, 1008.3596915958273, 5016.372953380827, 5041.873953151201, 5079.619028572872, 5142.408623008327, 5147.2279158126585, 20476.69284960727, 21141.894290528755, 21898.343049708215, 22112.2260720874, 22114.115435382726, 19342.226310947684, 19780.40658780239, 19949.401517954484, 19952.60094798125, 19975.800241997684, 10678.786424271471, 11309.151813613847, 11348.375839328752, 11354.716132096764, 11362.659120226406, 8082.595870206584, 8256.545889975869, 8422.284105851071, 8450.873236901574, 8522.70170544028, 17451.818522684665, 17517.64964700724, 17642.20610072524, 17743.911280443514, 18057.729134062738, 17514.562135946195, 17687.11564421748, 17954.820451795316, 18689.15898784531, 19029.524261893563, 12105.51577936908, 12426.813597796221, 12589.055820813292, 12607.87392126067, 12613.243205407705, 13809.24049177305, 13907.791383129059, 13994.16035037901, 14020.369083391068, 14025.0, 10985.505652245509, 11205.71985700364, 11244.437778111225, 11391.658250252505, 11470.197086203885, 11163.776724465628, 11200.719982000515, 11311.264767790068, 11388.088952883583, 11422.371769552754, 10102.39385636864, 10213.131883789962, 10285.53715082808, 10287.279890407899, 10291.919348468602, 7077.044598979072, 7265.745698900513, 7287.890681639674, 7312.8537429250055, 7344.22885597026, 7087.220405755466, 7312.744053958086, 7349.669264882986, 7418.221086785809, 7489.850202996018], "value": 6742.226283412973, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [515.499965033917, 517.9715115668638, 521.1401188039735, 533.413245430027, 541.9891602167957, 6390.329015453374, 6424.164858568385, 6485.967570162143, 6514.609123452597, 6558.868822623551, 6323.272823625284, 6365.745370185187, 6393.552451328409, 6423.710933008014, 6446.580972236801, 5256.395514515842, 5272.340957380327, 5311.973440132803, 5319.787208511674, 5325.920111198335, 4901.436334821487, 5015.348004759376, 5202.1936599826895, 5279.366476022883, 5291.629585928987, 4935.161022626145, 4966.279889416032, 4993.825216117437, 5002.649814512985, 5028.6982781033075, 4997.325361076245, 5019.52314530119, 5048.268001139814, 5050.469735639469, 5083.059633967728, 4375.606195442426, 4451.243288640939, 4482.798274077674, 4488.7531185784765, 4533.909321813579, 6131.202943617302, 6176.3514830943, 6207.286162091327, 6272.18461599989, 6285.9057114143325, 5719.428057194247, 5757.596968212227, 5769.134629805562, 5787.218725472049, 5799.594028418012, 6660.400563949268, 6690.19717633887, 6707.396334329934, 6731.9663401683165, 6733.831654208684, 4923.606111511071, 4925.482824303433, 4954.47977962316, 4966.304717339575, 4974.602031837444, 6677.4625642256115, 6702.0, 6862.416694581017, 6892.483063770187, 6896.413804826596, 5001.9499805002215, 5028.731324639014, 5039.5968322534845, 5064.0, 5085.863937146408, 5109.463506331856, 5117.795288188431, 5133.589312854962, 5153.587712982952, 5176.948230517647, 5696.914546281809, 5741.827745167651, 5758.424157584292, 5763.337216220105, 5805.332386775491, 6638.800835974928, 6670.065680952566, 6723.798286051427, 6742.685176390557, 6767.932320676829, 1765.8940463571969, 1794.1119146022802, 1797.21821007862, 1803.6843552378282, 1805.627722930556, 1169.8947094761513, 1245.3337464456654, 1248.5318005747845, 1250.9554521974253, 1253.11029169289, 5830.329512106077, 5867.501262392744, 5871.618344807659, 5917.615355001911, 5919.792807251725, 6829.931700683029, 6859.485538584626, 6901.723931042802, 6914.4468442525485, 6940.7223711052, 5840.240768700127, 5843.824685259449, 5846.889091072682, 5859.648421094748, 5954.07711804671, 3571.5714114306447, 3590.263995880838, 3601.63983601643, 3603.630620364297, 3614.710823134143, 6083.452489275986, 6532.281449040602, 6541.8364540885905, 6541.967290163519, 6549.6070235786, 6829.385355318045, 6918.965405172942, 6941.097657304518, 6953.33943275388, 7025.156981162293, 6587.275399705933, 6608.768693095719, 6617.022339947043, 6617.239017512951, 6659.368454728622, 6732.629705366252, 6829.282925292773, 6862.416694581017, 6865.759698410531, 6875.656217189021, 6706.295838936841, 6732.259451460238, 6743.1908171019795, 6782.914733642593, 6831.146106736658, 6610.206775187008, 6615.6030638161865, 6630.867382652416, 6653.600783952978, 6687.364700353459, 4963.8262660806695, 4984.975075124601, 4999.47505511916, 5029.647924645386, 5030.320906677698, 6486.0, 6746.886763683937, 6748.561343512656, 6878.174619045746, 6898.586084834926, 6574.342565743387, 6595.94464885616, 6618.0, 6641.26946035926, 6660.0039976014, 6522.380373864476, 6535.836604084936, 6537.803865884031, 6538.084668146558, 6635.23694775107, 6505.088658063132, 6530.869382612416, 6567.573107747981, 6597.703103360264, 6633.867322653617, 6658.500612453989, 6706.161729783777, 6718.219671786883, 6737.494687898526, 6748.089007983859, 6486.0, 6498.155239818793, 6526.836829079121, 6526.967365163144, 6532.5753826001155], "value": 5138.61059665201, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [880.1946219209424, 885.7475619448459, 910.5174257643444, 913.735016845115, 919.0074719303153, 19309.0, 19876.60246795067, 20082.899585502088, 20108.396748097544, 20203.696944545823, 21011.684824727643, 21534.246301379455, 21668.891655541738, 21743.565128697417, 21809.454763630918, 960.3757557587554, 986.4328011393442, 988.6786794291847, 992.6773798515511, 995.278423143219, 968.0, 995.9601615935354, 1005.8038682456923, 1007.9294449388545, 1013.0376142664499, 1055.2296823318982, 1057.3602970202994, 1062.3944351719524, 1065.4885654885659, 1067.6583493282153, 1052.310736467615, 1062.4156713807413, 1064.084886997182, 1064.984025239622, 1069.8769641491212, 776.6078130544096, 777.898873146493, 779.5089093870881, 782.1435528096725, 782.2959336597052, 19921.9003904981, 20086.49783755418, 20241.190352385885, 20309.695354569692, 20590.382288531368, 17462.563435914075, 17511.912440437845, 17721.556961076076, 17919.641607167785, 17953.7306940396, 17516.0, 17593.824061759347, 17707.46877593674, 17721.291148354052, 17762.289508419646, 3820.847166113352, 3839.9808000960097, 3849.5188101487315, 3850.5379354477363, 3850.7111966602615, 131689.0, 133778.0, 134209.32895335558, 134751.0, 136635.0, 16111.597210069842, 16115.51653450375, 16354.591135221715, 16620.916895415445, 16892.0, 30279.545806812916, 30408.69591304103, 30413.391732165233, 30457.695423045487, 31343.37313253722, 7676.961615191888, 7961.243681850215, 8582.613782379807, 8948.0, 8950.194482496607, 4229.175310814362, 4291.763952982616, 4323.502797178302, 4327.870163895088, 4329.393884856123, 5106.693598384109, 5161.948380516222, 5218.191180367049, 5224.346956630421, 5225.895482090413, 1024.8872624011353, 1049.7795462952713, 1057.629829559648, 1057.7672911959357, 1059.369675043348, 639.5011890725242, 648.8929326661048, 652.8824811533874, 653.7842511971038, 664.9102371179829, 11633.302001879914, 11966.880331196577, 12147.574834880737, 12493.063020273516, 12570.87429125697, 681.189384632286, 689.8034060292792, 691.1602403080282, 709.3119673916293, 709.9858002839915, 5658.858528536737, 5747.511461525817, 5776.797812076557, 5810.331811841608, 5849.502792262705, 111649.44175279072, 112514.74970500544, 113799.43100284612, 115023.0, 115067.0, 96711.6150934714, 98458.0, 98687.50656246673, 98754.0, 103427.48286258521, 84815.0, 85858.57070714606, 86381.0, 87959.0, 90825.0, 11444.542218311175, 11577.942110289394, 12118.272903625812, 12129.818052729039, 12145.453454594388, 38597.0, 39386.40920386254, 40208.396874047496, 40434.39348409717, 41693.166136677704, 71214.0, 71270.28729712637, 72507.63746181446, 72721.0, 74675.8798618032, 15824.367025318857, 18135.45593632193, 18572.0, 18718.532036698645, 18816.52958676044, 18742.344017959305, 18746.531336716693, 18994.715079273545, 19826.0, 21526.246581369578, 17789.822101778816, 18238.544036399195, 18822.341218057303, 18917.148728306984, 19102.23591056342, 17664.55838604045, 17965.820341796938, 18056.368027118988, 18059.458216253533, 18133.27466901309, 17242.224099915784, 17490.82509174892, 18679.533011674815, 19093.522661933563, 19124.139413726694, 12186.451609677408, 12804.743905122032, 13396.26320552379, 13816.654583635489, 14013.649658758204, 13863.653408664864, 13954.58136255914, 14010.78983815264, 14222.431102755774, 14481.275936202937], "value": 9188.2568546859, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1490.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 109.0, 100.0, 108.0, 107.0, 113.0, 111.0, 99.0, 109.0, 110.0], "value": 106.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 122.0, 156.0, 172.0, 124.0, 145.0, 143.0, 119.0, 165.0, 117.0], "value": 140.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 163.0, 163.0, 164.0, 161.0, 160.0, 166.0, 169.0, 164.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 74.0, 183.0, 74.0, 74.0, 73.0, 74.0, 154.0, 75.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 138.0, 80.0, 90.0, 80.0, 130.0, 79.0, 79.0, 135.0], "value": 97.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 115.0, 114.0, 115.0, 115.0, 115.0, 114.0, 114.0, 114.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 148.0, 148.0, 148.0, 149.0, 147.0, 148.0, 147.0, 151.0, 148.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 52.0, 51.0, 52.0, 52.0, 51.0, 51.0, 53.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 39.0, 38.0, 39.0, 39.0, 38.0, 39.0, 39.0, 39.0, 50.0], "value": 39.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 74.0, 74.0, 78.0, 79.0, 77.0, 76.0, 74.0, 74.0], "value": 75.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 132.0, 119.0, 118.0, 118.0, 118.0, 121.0, 127.0, 127.0, 161.0], "value": 128.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 172.0, 169.0, 172.0, 173.0, 170.0, 168.0, 169.0, 173.0, 182.0], "value": 171.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 63.0, 63.0, 64.0, 65.0, 65.0, 64.0, 64.0], "value": 64.3, "unit": "score"}]}]} 03:54:06 INFO - Return code: 0 03:54:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:54:06 INFO - # TBPL SUCCESS # 03:54:06 INFO - Running post-action listener: _package_coverage_data 03:54:06 INFO - Running post-action listener: _resource_record_post_action 03:54:06 INFO - [mozharness: 2017-09-05 10:54:06.245749Z] Finished run-tests step (success) 03:54:06 INFO - Running post-run listener: _resource_record_post_run 03:54:06 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 872448; Write bytes: 390557696; Read time: 240; Write time: 226076 03:54:06 INFO - TinderboxPrint: CPU usage
13.1% 03:54:06 INFO - TinderboxPrint: I/O read bytes / time
872,448 / 240 03:54:06 INFO - TinderboxPrint: I/O write bytes / time
390,557,696 / 226,076 03:54:06 INFO - TinderboxPrint: CPU idle
8,249.0 (86.9%) 03:54:06 INFO - TinderboxPrint: CPU user
1,193.7 (12.6%) 03:54:06 INFO - TinderboxPrint: Swap in / out
0 / 0 03:54:06 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 106164224; Read time: 60; Write time: 73564 03:54:06 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:54:06 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 868352; Write bytes: 284393472; Read time: 180; Write time: 152512 03:54:06 INFO - Running post-run listener: _upload_blobber_files 03:54:06 INFO - Blob upload gear active. 03:54:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:54:06 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 03:54:06 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'] 03:54:06 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 03:54:07 INFO - (blobuploader) - INFO - Open directory for files ... 03:54:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:54:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:54:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:54:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:54:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:54:08 INFO - (blobuploader) - INFO - Done attempting. 03:54:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:54:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:54:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:54:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:54:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:54:09 INFO - (blobuploader) - INFO - Done attempting. 03:54:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:54:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:54:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:54:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:54:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:54:16 INFO - (blobuploader) - INFO - Done attempting. 03:54:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:54:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:54:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:54:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:54:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:54:17 INFO - (blobuploader) - INFO - Done attempting. 03:54:17 INFO - (blobuploader) - INFO - Iteration through files over. 03:54:17 INFO - Return code: 0 03:54:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:54:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:54:17 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/46a3ebc2a3220b783ce628c3bf2656bba5f48ebe1c0e405250ed17711fa645835cd281a7a2dd6986ee2a227d0c1ea34dd3487ce8fe1c53014c25bb4064be9219", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e98d9f19ef0a8a6e65e3d7a4bb1af94390e1b9620b6c0d06fc2cfa82a5cf2d9622dc078b3f790e0a988d6e8d742c41cf7b6c181d9a1683604c23d264757c14c0", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6763d102bc12b75438bedff9a28402691a545818e64d4348654f5c0945b0722ef3586ac06df3cdc5af11e1dba3b932765f9487492b76cd1e1861ad25bec75a36", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/840aa78bc6d5253556f280ee748a480a4b4ba089e967a45662c4463248ec7e1cca4d9f7090a6578abdf8a58a9321a70a4ef7723336ca6aed64f66be2ca1a74d4"} 03:54:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:54:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:54:17 INFO - Contents: 03:54:17 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/46a3ebc2a3220b783ce628c3bf2656bba5f48ebe1c0e405250ed17711fa645835cd281a7a2dd6986ee2a227d0c1ea34dd3487ce8fe1c53014c25bb4064be9219", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e98d9f19ef0a8a6e65e3d7a4bb1af94390e1b9620b6c0d06fc2cfa82a5cf2d9622dc078b3f790e0a988d6e8d742c41cf7b6c181d9a1683604c23d264757c14c0", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6763d102bc12b75438bedff9a28402691a545818e64d4348654f5c0945b0722ef3586ac06df3cdc5af11e1dba3b932765f9487492b76cd1e1861ad25bec75a36", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/840aa78bc6d5253556f280ee748a480a4b4ba089e967a45662c4463248ec7e1cca4d9f7090a6578abdf8a58a9321a70a4ef7723336ca6aed64f66be2ca1a74d4"} 03:54:17 INFO - Running post-run listener: copy_logs_to_upload_dir 03:54:17 INFO - Copying logs to upload dir... 03:54:17 INFO - mkdir: /builds/slave/test/build/upload/logs 03:54:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.966329 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-09-05 03:54:17.474470) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-05 03:54:17.478330) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1504607590.704876-831758737 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/46a3ebc2a3220b783ce628c3bf2656bba5f48ebe1c0e405250ed17711fa645835cd281a7a2dd6986ee2a227d0c1ea34dd3487ce8fe1c53014c25bb4064be9219", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e98d9f19ef0a8a6e65e3d7a4bb1af94390e1b9620b6c0d06fc2cfa82a5cf2d9622dc078b3f790e0a988d6e8d742c41cf7b6c181d9a1683604c23d264757c14c0", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6763d102bc12b75438bedff9a28402691a545818e64d4348654f5c0945b0722ef3586ac06df3cdc5af11e1dba3b932765f9487492b76cd1e1861ad25bec75a36", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/840aa78bc6d5253556f280ee748a480a4b4ba089e967a45662c4463248ec7e1cca4d9f7090a6578abdf8a58a9321a70a4ef7723336ca6aed64f66be2ca1a74d4"} build_url:https://queue.taskcluster.net/v1/task/Oz77JHY8R46lR-xvwFHp5Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011395 build_url: 'https://queue.taskcluster.net/v1/task/Oz77JHY8R46lR-xvwFHp5Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/46a3ebc2a3220b783ce628c3bf2656bba5f48ebe1c0e405250ed17711fa645835cd281a7a2dd6986ee2a227d0c1ea34dd3487ce8fe1c53014c25bb4064be9219", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e98d9f19ef0a8a6e65e3d7a4bb1af94390e1b9620b6c0d06fc2cfa82a5cf2d9622dc078b3f790e0a988d6e8d742c41cf7b6c181d9a1683604c23d264757c14c0", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6763d102bc12b75438bedff9a28402691a545818e64d4348654f5c0945b0722ef3586ac06df3cdc5af11e1dba3b932765f9487492b76cd1e1861ad25bec75a36", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/840aa78bc6d5253556f280ee748a480a4b4ba089e967a45662c4463248ec7e1cca4d9f7090a6578abdf8a58a9321a70a4ef7723336ca6aed64f66be2ca1a74d4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-05 03:54:17.507143) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-05 03:54:17.507492) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1504607590.704876-831758737 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004455 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-05 03:54:17.592228) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-05 03:54:17.592899) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-05 03:54:17.593608) ========= ========= Total master_lag: 0.20 =========