builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-049 starttime: 1498958919.75 results: success (0) revision: 4d3de12dcdc539f14fcb06539da39fa7176c8955 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-01 18:28:39.749623) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-01 18:28:39.750302) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-01 18:28:39.750565) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-01 18:28:39.859827) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-01 18:28:39.860070) ========= 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=db7e7c15f3ca076d53731445000001ba-1498946375.671674-1308135519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-01 18:28:40-- 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% 50.2M=0s 2017-07-01 18:28:40 (50.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.378565 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-01 18:28:40.275033) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-01 18:28:40.277331) ========= 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=db7e7c15f3ca076d53731445000001ba-1498946375.671674-1308135519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.065117 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-01 18:28:40.352319) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-01 18:28:40.352646) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4d3de12dcdc539f14fcb06539da39fa7176c8955 --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 4d3de12dcdc539f14fcb06539da39fa7176c8955 --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=db7e7c15f3ca076d53731445000001ba-1498946375.671674-1308135519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-01 18:28:40,866 truncating revision to first 12 chars 2017-07-01 18:28:40,866 Setting DEBUG logging. 2017-07-01 18:28:40,866 attempt 1/10 2017-07-01 18:28:40,866 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4d3de12dcdc5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-01 18:28:41,774 unpacking tar archive at: mozilla-central-4d3de12dcdc5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.203392 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-01 18:28:41.570429) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-01 18:28:41.570696) ========= script_repo_revision: 4d3de12dcdc539f14fcb06539da39fa7176c8955 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-01 18:28:41.571032) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-01 18:28:41.571284) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-01 18:28:41.583262) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-07-01 18:28:41.583532) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1498946375.671674-1308135519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:28:42 INFO - MultiFileLogger online at 20170701 18:28:42 in /builds/slave/test 18:28:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:28:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:28:42 INFO - {'append_to_log': False, 18:28:42 INFO - 'base_work_dir': '/builds/slave/test', 18:28:42 INFO - 'blob_upload_branch': 'Firefox', 18:28:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:28:42 INFO - 'branch': 'Firefox', 18:28:42 INFO - 'buildbot_json_path': 'buildprops.json', 18:28:42 INFO - 'code_coverage': False, 18:28:42 INFO - 'config_files': ('talos/linux_config.py',), 18:28:42 INFO - 'default_actions': ('clobber', 18:28:42 INFO - 'read-buildbot-config', 18:28:42 INFO - 'download-and-extract', 18:28:42 INFO - 'populate-webroot', 18:28:42 INFO - 'create-virtualenv', 18:28:42 INFO - 'install', 18:28:42 INFO - 'setup-mitmproxy', 18:28:42 INFO - 'run-tests'), 18:28:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:28:42 INFO - 'disable_ccov_upload': False, 18:28:42 INFO - 'download_minidump_stackwalk': True, 18:28:42 INFO - 'download_symbols': 'ondemand', 18:28:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:28:42 INFO - 'tooltool.py': '/tools/tooltool.py', 18:28:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:28:42 INFO - '/tools/misc-python/virtualenv.py')}, 18:28:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:28:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:28:42 INFO - 'gecko_profile': False, 18:28:42 INFO - 'gecko_profile_interval': 0, 18:28:42 INFO - 'installer_path': 'installer.exe', 18:28:42 INFO - 'log_level': 'info', 18:28:42 INFO - 'log_name': 'talos', 18:28:42 INFO - 'log_to_console': True, 18:28:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:28:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:28:42 INFO - 'opt_config_files': (), 18:28:42 INFO - 'pip_index': False, 18:28:42 INFO - 'suite': 'dromaeojs-e10s', 18:28:42 INFO - 'system_bits': '32', 18:28:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:28:42 INFO - 'title': 'talos-linux64-ix-049', 18:28:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:28:42 INFO - 'use_talos_json': True, 18:28:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:28:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:28:42 INFO - 'work_dir': 'build'} 18:28:42 INFO - [mozharness: 2017-07-02 01:28:42.333526Z] Running clobber step. 18:28:42 INFO - Running pre-action listener: _resource_record_pre_action 18:28:42 INFO - Running main action method: clobber 18:28:42 INFO - rmtree: /builds/slave/test/build 18:28:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:28:44 INFO - Running post-action listener: _resource_record_post_action 18:28:44 INFO - [mozharness: 2017-07-02 01:28:44.421663Z] Finished clobber step (success) 18:28:44 INFO - [mozharness: 2017-07-02 01:28:44.421870Z] Running read-buildbot-config step. 18:28:44 INFO - Running pre-action listener: _resource_record_pre_action 18:28:44 INFO - Running main action method: read_buildbot_config 18:28:44 INFO - Using buildbot properties: 18:28:44 INFO - { 18:28:44 INFO - "project": "", 18:28:44 INFO - "product": "firefox", 18:28:44 INFO - "who": "philringnalda@gmail.com", 18:28:44 INFO - "installer_path": "public/build/target.tar.bz2", 18:28:44 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 18:28:44 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 18:28:44 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 18:28:44 INFO - "stage_platform": "linux64-stylo", 18:28:44 INFO - "basedir": "/builds/slave/test", 18:28:44 INFO - "buildnumber": 186, 18:28:44 INFO - "platform": "ubuntu64_hw_stylo", 18:28:44 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:28:44 INFO - "slavebuilddir": "test", 18:28:44 INFO - "taskId": "T7_CRYhsTbq_uGanhpnGGQ", 18:28:44 INFO - "branch": "mozilla-central", 18:28:44 INFO - "script_repo_revision": "production", 18:28:44 INFO - "revision": "4d3de12dcdc539f14fcb06539da39fa7176c8955", 18:28:44 INFO - "slavename": "talos-linux64-ix-049", 18:28:44 INFO - "repo_path": "mozilla-central" 18:28:44 INFO - } 18:28:44 INFO - Finding installer, test and symbols from parent task. 18:28:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T7_CRYhsTbq_uGanhpnGGQ'}, attempt #1 18:28:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T7_CRYhsTbq_uGanhpnGGQ'}, attempt #1 18:28:45 INFO - Task dependencies: am1KHi4NTKavzzas9GpRJQ 18:28:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/am1KHi4NTKavzzas9GpRJQ'}, attempt #1 18:28:45 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/am1KHi4NTKavzzas9GpRJQ/artifacts/public/build/target.tar.bz2 18:28:45 INFO - Set test_url: https://queue.taskcluster.net/v1/task/am1KHi4NTKavzzas9GpRJQ/artifacts/public/build/test_packages.json 18:28:45 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/am1KHi4NTKavzzas9GpRJQ/artifacts/public/build/target.crashreporter-symbols.zip 18:28:45 INFO - Running post-action listener: _resource_record_post_action 18:28:45 INFO - [mozharness: 2017-07-02 01:28:45.802631Z] Finished read-buildbot-config step (success) 18:28:45 INFO - [mozharness: 2017-07-02 01:28:45.802857Z] Running download-and-extract step. 18:28:45 INFO - Running pre-action listener: _resource_record_pre_action 18:28:45 INFO - Running main action method: download_and_extract 18:28:45 INFO - mkdir: /builds/slave/test/build/tests 18:28:45 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')]} 18:28:45 INFO - trying https://queue.taskcluster.net/v1/task/am1KHi4NTKavzzas9GpRJQ/artifacts/public/build/target.test_packages.json 18:28:45 INFO - Downloading https://queue.taskcluster.net/v1/task/am1KHi4NTKavzzas9GpRJQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:28:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/am1KHi4NTKavzzas9GpRJQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:28:46 INFO - Downloaded 989 bytes. 18:28:46 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:28:46 INFO - Using the following test package requirements: 18:28:46 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:28:46 INFO - u'common': [u'target.common.tests.zip'], 18:28:46 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:28:46 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:28:46 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:28:46 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:28:46 INFO - u'mozbase': [u'target.common.tests.zip'], 18:28:46 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:28:46 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:28:46 INFO - u'web-platform': [u'target.common.tests.zip', 18:28:46 INFO - u'target.web-platform.tests.tar.gz'], 18:28:46 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:28:46 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:28:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/am1KHi4NTKavzzas9GpRJQ/artifacts/public/build/target.common.tests.zip 18:28:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/am1KHi4NTKavzzas9GpRJQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:28:46 INFO - Fetch https://queue.taskcluster.net/v1/task/am1KHi4NTKavzzas9GpRJQ/artifacts/public/build/target.common.tests.zip into memory 18:28:47 INFO - Content-Length response header: 67762265 18:28:47 INFO - Bytes received: 67762265 18:28:58 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:28:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/am1KHi4NTKavzzas9GpRJQ/artifacts/public/build/target.common.tests.zip 18:28:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/am1KHi4NTKavzzas9GpRJQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:28:58 INFO - Fetch https://queue.taskcluster.net/v1/task/am1KHi4NTKavzzas9GpRJQ/artifacts/public/build/target.common.tests.zip into memory 18:28:59 INFO - Content-Length response header: 67762265 18:28:59 INFO - Bytes received: 67762265 18:29:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/am1KHi4NTKavzzas9GpRJQ/artifacts/public/build/target.talos.tests.zip 18:29:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/am1KHi4NTKavzzas9GpRJQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:29:12 INFO - Fetch https://queue.taskcluster.net/v1/task/am1KHi4NTKavzzas9GpRJQ/artifacts/public/build/target.talos.tests.zip into memory 18:29:13 INFO - Content-Length response header: 14470867 18:29:13 INFO - Bytes received: 14470867 18:29:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:29:13 INFO - trying https://queue.taskcluster.net/v1/task/am1KHi4NTKavzzas9GpRJQ/artifacts/public/build/target.tar.bz2 18:29:13 INFO - Downloading https://queue.taskcluster.net/v1/task/am1KHi4NTKavzzas9GpRJQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:29:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/am1KHi4NTKavzzas9GpRJQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:29:14 INFO - Downloaded 61869639 bytes. 18:29:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/am1KHi4NTKavzzas9GpRJQ/artifacts/public/build/target.tar.bz2 18:29:14 INFO - mkdir: /builds/slave/test/properties 18:29:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:29:14 INFO - Writing to file /builds/slave/test/properties/build_url 18:29:14 INFO - Contents: 18:29:14 INFO - build_url:https://queue.taskcluster.net/v1/task/am1KHi4NTKavzzas9GpRJQ/artifacts/public/build/target.tar.bz2 18:29:14 INFO - Running post-action listener: _resource_record_post_action 18:29:14 INFO - Running post-action listener: set_extra_try_arguments 18:29:14 INFO - [mozharness: 2017-07-02 01:29:14.649901Z] Finished download-and-extract step (success) 18:29:14 INFO - [mozharness: 2017-07-02 01:29:14.649998Z] Running populate-webroot step. 18:29:14 INFO - Running pre-action listener: _resource_record_pre_action 18:29:14 INFO - Running main action method: populate_webroot 18:29:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:29:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:29:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:29:14 INFO - '--tppagecycles', 18:29:14 INFO - '7'], 18:29:14 INFO - 'tests': ['tsvgm']}}, 18:29:14 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:29:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:29:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:29:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:29:14 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:29:14 INFO - 'talos_options': ['--disable-e10s'], 18:29:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:29:14 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:29:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:29:14 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:29:14 INFO - 'talos_options': ['--disable-e10s'], 18:29:14 INFO - 'tests': ['damp', 'tps']}, 18:29:14 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:29:14 INFO - 'tests': ['damp', 'tps']}, 18:29:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:29:14 INFO - 'tests': ['dromaeo_dom']}, 18:29:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:29:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:29:14 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 18:29:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:29:14 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:29:14 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:29:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:29:14 INFO - 'tests': ['a11yr', 18:29:14 INFO - 'ts_paint', 18:29:14 INFO - 'tpaint', 18:29:14 INFO - 'sessionrestore', 18:29:14 INFO - 'sessionrestore_no_auto_restore', 18:29:14 INFO - 'tabpaint']}, 18:29:14 INFO - 'other-e10s': {'tests': ['a11yr', 18:29:14 INFO - 'ts_paint', 18:29:14 INFO - 'tpaint', 18:29:14 INFO - 'sessionrestore', 18:29:14 INFO - 'sessionrestore_many_windows', 18:29:14 INFO - 'sessionrestore_no_auto_restore', 18:29:14 INFO - 'tabpaint']}, 18:29:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:29:14 INFO - 'ts_paint', 18:29:14 INFO - 'tpaint', 18:29:14 INFO - 'sessionrestore', 18:29:14 INFO - 'sessionrestore_many_windows', 18:29:14 INFO - 'sessionrestore_no_auto_restore', 18:29:14 INFO - 'tabpaint']}, 18:29:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:29:14 INFO - 'ts_paint', 18:29:14 INFO - 'tpaint', 18:29:14 INFO - 'sessionrestore', 18:29:14 INFO - 'sessionrestore_many_windows', 18:29:14 INFO - 'sessionrestore_no_auto_restore', 18:29:14 INFO - 'tabpaint']}, 18:29:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:29:14 INFO - 'tests': ['a11yr', 18:29:14 INFO - 'ts_paint', 18:29:14 INFO - 'tpaint', 18:29:14 INFO - 'sessionrestore', 18:29:14 INFO - 'sessionrestore_no_auto_restore', 18:29:14 INFO - 'tabpaint']}, 18:29:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:29:14 INFO - 'tests': ['a11yr', 18:29:14 INFO - 'ts_paint', 18:29:14 INFO - 'tpaint', 18:29:14 INFO - 'sessionrestore', 18:29:14 INFO - 'sessionrestore_no_auto_restore', 18:29:14 INFO - 'tabpaint']}, 18:29:14 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 18:29:14 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 18:29:14 INFO - 'bloom_basic_ref']}, 18:29:14 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:29:14 INFO - 'talos_options': ['--mitmproxy', 18:29:14 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:29:14 INFO - '--firstNonBlankPaint'], 18:29:14 INFO - 'tests': ['quantum_pageload_google', 18:29:14 INFO - 'quantum_pageload_youtube', 18:29:14 INFO - 'quantum_pageload_amazon', 18:29:14 INFO - 'quantum_pageload_facebook']}, 18:29:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:29:14 INFO - 'tests': ['tsvgx', 18:29:14 INFO - 'tsvgr_opacity', 18:29:14 INFO - 'tart', 18:29:14 INFO - 'tscrollx', 18:29:14 INFO - 'cart', 18:29:14 INFO - 'tsvg_static']}, 18:29:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:29:14 INFO - 'tsvgr_opacity', 18:29:14 INFO - 'tart', 18:29:14 INFO - 'tscrollx', 18:29:14 INFO - 'cart', 18:29:14 INFO - 'tsvg_static']}, 18:29:14 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:29:14 INFO - 'talos_options': ['--disable-e10s'], 18:29:14 INFO - 'tests': ['tp5o']}, 18:29:14 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:29:14 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:29:14 INFO - 'talos_options': ['--disable-e10s', 18:29:14 INFO - '--xperf_path', 18:29:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:29:14 INFO - 'tests': ['tp5n']}, 18:29:14 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:29:14 INFO - 'talos_options': ['--xperf_path', 18:29:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:29:14 INFO - 'tests': ['tp5n']}}, 18:29:14 INFO - 'talos.zip': {'path': '', 18:29:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:29:14 INFO - Running post-action listener: _resource_record_post_action 18:29:14 INFO - [mozharness: 2017-07-02 01:29:14.665142Z] Finished populate-webroot step (success) 18:29:14 INFO - [mozharness: 2017-07-02 01:29:14.665232Z] Running create-virtualenv step. 18:29:14 INFO - Running pre-action listener: _resource_record_pre_action 18:29:14 INFO - Running main action method: create_virtualenv 18:29:14 INFO - Creating virtualenv /builds/slave/test/build/venv 18:29:14 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:29:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:29:14 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:29:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:29:14 INFO - Using real prefix '/usr' 18:29:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:29:15 INFO - Installing distribute.............................................................................................................................................................................................done. 18:29:17 INFO - Installing pip.................done. 18:29:17 INFO - Return code: 0 18:29:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:29:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:29:17 INFO - Reading from file tmpfile_stdout 18:29:17 INFO - Output received: 18:29:17 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:29:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:29:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:17 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 0x1c5f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcefa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd22a0>, '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 0x1fd32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fcd4d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1498946375.671674-1308135519', '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 18:29:17 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 18:29:17 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 18:29:17 INFO - Using env: {'DISPLAY': ':0', 18:29:17 INFO - 'HOME': '/home/cltbld', 18:29:17 INFO - 'LANG': 'en_US.UTF-8', 18:29:17 INFO - 'LANGUAGE': 'en_US:en', 18:29:17 INFO - 'LOGNAME': 'cltbld', 18:29:17 INFO - 'MAIL': '/var/mail/cltbld', 18:29:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:17 INFO - 'MOZ_NO_REMOTE': '1', 18:29:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:17 INFO - 'NO_EM_RESTART': '1', 18:29:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:17 INFO - 'PWD': '/builds/slave/test', 18:29:17 INFO - 'SHELL': '/bin/bash', 18:29:17 INFO - 'SHLVL': '1', 18:29:17 INFO - 'TERM': 'linux', 18:29:17 INFO - 'TMOUT': '86400', 18:29:17 INFO - 'USER': 'cltbld', 18:29:17 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1498946375.671674-1308135519', 18:29:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:17 INFO - '_': '/tools/buildbot/bin/python'} 18:29:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:29:17 INFO - Cleaning up... 18:29:17 INFO - Return code: 0 18:29:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:29:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:17 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 0x1c5f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcefa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd22a0>, '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 0x1fd32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fcd4d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1498946375.671674-1308135519', '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 18:29:17 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 18:29:17 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 18:29:17 INFO - Using env: {'DISPLAY': ':0', 18:29:17 INFO - 'HOME': '/home/cltbld', 18:29:17 INFO - 'LANG': 'en_US.UTF-8', 18:29:17 INFO - 'LANGUAGE': 'en_US:en', 18:29:17 INFO - 'LOGNAME': 'cltbld', 18:29:17 INFO - 'MAIL': '/var/mail/cltbld', 18:29:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:17 INFO - 'MOZ_NO_REMOTE': '1', 18:29:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:17 INFO - 'NO_EM_RESTART': '1', 18:29:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:17 INFO - 'PWD': '/builds/slave/test', 18:29:17 INFO - 'SHELL': '/bin/bash', 18:29:17 INFO - 'SHLVL': '1', 18:29:17 INFO - 'TERM': 'linux', 18:29:17 INFO - 'TMOUT': '86400', 18:29:17 INFO - 'USER': 'cltbld', 18:29:17 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1498946375.671674-1308135519', 18:29:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:17 INFO - '_': '/tools/buildbot/bin/python'} 18:29:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:18 INFO - Downloading/unpacking psutil>=3.1.1 18:29:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:29:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:29:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:29:19 INFO - Installing collected packages: psutil 18:29:19 INFO - Running setup.py install for psutil 18:29:19 INFO - building 'psutil._psutil_linux' extension 18:29:19 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 18:29:20 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 18:29:20 INFO - building 'psutil._psutil_posix' extension 18:29:20 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 18:29:20 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 18:29:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:29:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:29:20 INFO - Successfully installed psutil 18:29:20 INFO - Cleaning up... 18:29:20 INFO - Return code: 0 18:29:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:29:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:29:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcefa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd22a0>, '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 0x1fd32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fcd4d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1498946375.671674-1308135519', '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 18:29:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:29:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:29:20 INFO - Using env: {'DISPLAY': ':0', 18:29:20 INFO - 'HOME': '/home/cltbld', 18:29:20 INFO - 'LANG': 'en_US.UTF-8', 18:29:20 INFO - 'LANGUAGE': 'en_US:en', 18:29:20 INFO - 'LOGNAME': 'cltbld', 18:29:20 INFO - 'MAIL': '/var/mail/cltbld', 18:29:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:20 INFO - 'MOZ_NO_REMOTE': '1', 18:29:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:20 INFO - 'NO_EM_RESTART': '1', 18:29:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:20 INFO - 'PWD': '/builds/slave/test', 18:29:20 INFO - 'SHELL': '/bin/bash', 18:29:20 INFO - 'SHLVL': '1', 18:29:20 INFO - 'TERM': 'linux', 18:29:20 INFO - 'TMOUT': '86400', 18:29:20 INFO - 'USER': 'cltbld', 18:29:20 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1498946375.671674-1308135519', 18:29:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:20 INFO - '_': '/tools/buildbot/bin/python'} 18:29:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:29:21 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 18:29:21 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 18:29:21 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 18:29:21 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 18:29:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:29:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:29:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:29:22 INFO - Installing collected packages: mozsystemmonitor 18:29:22 INFO - Running setup.py install for mozsystemmonitor 18:29:22 INFO - Successfully installed mozsystemmonitor 18:29:22 INFO - Cleaning up... 18:29:22 INFO - Return code: 0 18:29:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:29:22 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')]} 18:29:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:22 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')]} 18:29:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:22 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 0x1c5f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcefa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd22a0>, '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 0x1fd32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fcd4d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1498946375.671674-1308135519', '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 18:29:22 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 18:29:22 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 18:29:22 INFO - Using env: {'DISPLAY': ':0', 18:29:22 INFO - 'HOME': '/home/cltbld', 18:29:22 INFO - 'LANG': 'en_US.UTF-8', 18:29:22 INFO - 'LANGUAGE': 'en_US:en', 18:29:22 INFO - 'LOGNAME': 'cltbld', 18:29:22 INFO - 'MAIL': '/var/mail/cltbld', 18:29:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:22 INFO - 'MOZ_NO_REMOTE': '1', 18:29:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:22 INFO - 'NO_EM_RESTART': '1', 18:29:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:22 INFO - 'PWD': '/builds/slave/test', 18:29:22 INFO - 'SHELL': '/bin/bash', 18:29:22 INFO - 'SHLVL': '1', 18:29:22 INFO - 'TERM': 'linux', 18:29:22 INFO - 'TMOUT': '86400', 18:29:22 INFO - 'USER': 'cltbld', 18:29:22 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1498946375.671674-1308135519', 18:29:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:22 INFO - '_': '/tools/buildbot/bin/python'} 18:29:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:22 INFO - Downloading/unpacking jsonschema==2.5.1 18:29:22 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 18:29:22 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 18:29:22 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 18:29:22 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 18:29:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:29:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:29:23 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 18:29:23 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 18:29:23 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 18:29:23 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 18:29:23 INFO - Downloading functools32-3.2.3-2.tar.gz 18:29:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:29:23 INFO - warning: no files found matching '*.txt' 18:29:23 INFO - no previously-included directories found matching 'build' 18:29:23 INFO - no previously-included directories found matching 'dist' 18:29:23 INFO - no previously-included directories found matching '.git*' 18:29:23 INFO - Installing collected packages: jsonschema, functools32 18:29:23 INFO - Running setup.py install for functools32 18:29:24 INFO - warning: no files found matching '*.txt' 18:29:24 INFO - no previously-included directories found matching 'build' 18:29:24 INFO - no previously-included directories found matching 'dist' 18:29:24 INFO - no previously-included directories found matching '.git*' 18:29:24 INFO - Successfully installed jsonschema functools32 18:29:24 INFO - Cleaning up... 18:29:24 INFO - Return code: 0 18:29:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:29:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:24 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 0x1c5f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcefa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd22a0>, '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 0x1fd32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fcd4d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1498946375.671674-1308135519', '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 18:29:24 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 18:29:24 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 18:29:24 INFO - Using env: {'DISPLAY': ':0', 18:29:24 INFO - 'HOME': '/home/cltbld', 18:29:24 INFO - 'LANG': 'en_US.UTF-8', 18:29:24 INFO - 'LANGUAGE': 'en_US:en', 18:29:24 INFO - 'LOGNAME': 'cltbld', 18:29:24 INFO - 'MAIL': '/var/mail/cltbld', 18:29:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:24 INFO - 'MOZ_NO_REMOTE': '1', 18:29:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:24 INFO - 'NO_EM_RESTART': '1', 18:29:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:24 INFO - 'PWD': '/builds/slave/test', 18:29:24 INFO - 'SHELL': '/bin/bash', 18:29:24 INFO - 'SHLVL': '1', 18:29:24 INFO - 'TERM': 'linux', 18:29:24 INFO - 'TMOUT': '86400', 18:29:24 INFO - 'USER': 'cltbld', 18:29:24 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1498946375.671674-1308135519', 18:29:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:24 INFO - '_': '/tools/buildbot/bin/python'} 18:29:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:29:24 INFO - Cleaning up... 18:29:24 INFO - Return code: 0 18:29:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:29:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:24 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 0x1c5f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcefa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd22a0>, '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 0x1fd32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fcd4d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1498946375.671674-1308135519', '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 18:29:24 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 18:29:24 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 18:29:24 INFO - Using env: {'DISPLAY': ':0', 18:29:24 INFO - 'HOME': '/home/cltbld', 18:29:24 INFO - 'LANG': 'en_US.UTF-8', 18:29:24 INFO - 'LANGUAGE': 'en_US:en', 18:29:24 INFO - 'LOGNAME': 'cltbld', 18:29:24 INFO - 'MAIL': '/var/mail/cltbld', 18:29:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:24 INFO - 'MOZ_NO_REMOTE': '1', 18:29:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:24 INFO - 'NO_EM_RESTART': '1', 18:29:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:24 INFO - 'PWD': '/builds/slave/test', 18:29:24 INFO - 'SHELL': '/bin/bash', 18:29:24 INFO - 'SHLVL': '1', 18:29:24 INFO - 'TERM': 'linux', 18:29:24 INFO - 'TMOUT': '86400', 18:29:24 INFO - 'USER': 'cltbld', 18:29:24 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1498946375.671674-1308135519', 18:29:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:24 INFO - '_': '/tools/buildbot/bin/python'} 18:29:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:24 INFO - Downloading/unpacking blobuploader==1.2.4 18:29:24 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 18:29:24 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 18:29:24 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 18:29:24 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 18:29:25 INFO - Downloading blobuploader-1.2.4.tar.gz 18:29:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:29:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:29:25 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 18:29:25 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 18:29:25 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 18:29:25 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 18:29:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:29:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:29:26 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 18:29:26 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 18:29:26 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 18:29:26 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 18:29:26 INFO - Downloading docopt-0.6.1.tar.gz 18:29:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:29:26 INFO - Installing collected packages: blobuploader, requests, docopt 18:29:26 INFO - Running setup.py install for blobuploader 18:29:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:29:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:29:26 INFO - Running setup.py install for requests 18:29:26 INFO - Running setup.py install for docopt 18:29:26 INFO - Successfully installed blobuploader requests docopt 18:29:26 INFO - Cleaning up... 18:29:27 INFO - Return code: 0 18:29:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:29:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:29:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:29:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:27 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 0x1c5f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcefa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd22a0>, '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 0x1fd32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fcd4d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1498946375.671674-1308135519', '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 18:29:27 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 18:29:27 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 18:29:27 INFO - Using env: {'DISPLAY': ':0', 18:29:27 INFO - 'HOME': '/home/cltbld', 18:29:27 INFO - 'LANG': 'en_US.UTF-8', 18:29:27 INFO - 'LANGUAGE': 'en_US:en', 18:29:27 INFO - 'LOGNAME': 'cltbld', 18:29:27 INFO - 'MAIL': '/var/mail/cltbld', 18:29:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:27 INFO - 'MOZ_NO_REMOTE': '1', 18:29:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:27 INFO - 'NO_EM_RESTART': '1', 18:29:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:27 INFO - 'PWD': '/builds/slave/test', 18:29:27 INFO - 'SHELL': '/bin/bash', 18:29:27 INFO - 'SHLVL': '1', 18:29:27 INFO - 'TERM': 'linux', 18:29:27 INFO - 'TMOUT': '86400', 18:29:27 INFO - 'USER': 'cltbld', 18:29:27 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1498946375.671674-1308135519', 18:29:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:27 INFO - '_': '/tools/buildbot/bin/python'} 18:29:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:29:27 INFO - Running setup.py (path:/tmp/pip-TupYrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:29:27 INFO - Running setup.py (path:/tmp/pip-zH4g1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:29:27 INFO - Running setup.py (path:/tmp/pip-dMacaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:29:27 INFO - Running setup.py (path:/tmp/pip-7qX20D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:29:27 INFO - Running setup.py (path:/tmp/pip-nl2mAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:29:27 INFO - Running setup.py (path:/tmp/pip-DkEZFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:29:27 INFO - Running setup.py (path:/tmp/pip-CjhYkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:29:27 INFO - Running setup.py (path:/tmp/pip-XcACsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:29:27 INFO - Running setup.py (path:/tmp/pip-fmpFto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:29:27 INFO - Running setup.py (path:/tmp/pip-9qG2AN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:29:27 INFO - Running setup.py (path:/tmp/pip-qa7_Lt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:29:28 INFO - Running setup.py (path:/tmp/pip-wgDRYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:29:28 INFO - Running setup.py (path:/tmp/pip-yWcrH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:29:28 INFO - Running setup.py (path:/tmp/pip-2h9VL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:29:28 INFO - Running setup.py (path:/tmp/pip-kMOoLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:29:28 INFO - Running setup.py (path:/tmp/pip-57izif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:29:28 INFO - Running setup.py (path:/tmp/pip-jhSJVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:29:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:29:28 INFO - Running setup.py install for manifestparser 18:29:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:29:28 INFO - Running setup.py install for mozcrash 18:29:28 INFO - Running setup.py install for mozdebug 18:29:28 INFO - Running setup.py install for mozdevice 18:29:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:29:28 INFO - Running setup.py install for mozfile 18:29:28 INFO - Running setup.py install for mozhttpd 18:29:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:29:29 INFO - Running setup.py install for mozinfo 18:29:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:29:29 INFO - Running setup.py install for mozInstall 18:29:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:29:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:29:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:29:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:29:29 INFO - Running setup.py install for mozleak 18:29:29 INFO - Running setup.py install for mozlog 18:29:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:29:29 INFO - Running setup.py install for moznetwork 18:29:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:29:29 INFO - Running setup.py install for mozprocess 18:29:29 INFO - Running setup.py install for mozprofile 18:29:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:29:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:29:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:29:29 INFO - Running setup.py install for mozrunner 18:29:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:29:29 INFO - Running setup.py install for mozscreenshot 18:29:30 INFO - Running setup.py install for moztest 18:29:30 INFO - Running setup.py install for mozversion 18:29:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:29:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:29:30 INFO - Cleaning up... 18:29:30 INFO - Return code: 0 18:29:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:29:30 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')]} 18:29:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:30 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')]} 18:29:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:30 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 0x1c5f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcefa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd22a0>, '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 0x1fd32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fcd4d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1498946375.671674-1308135519', '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 18:29:30 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 18:29:30 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 18:29:30 INFO - Using env: {'DISPLAY': ':0', 18:29:30 INFO - 'HOME': '/home/cltbld', 18:29:30 INFO - 'LANG': 'en_US.UTF-8', 18:29:30 INFO - 'LANGUAGE': 'en_US:en', 18:29:30 INFO - 'LOGNAME': 'cltbld', 18:29:30 INFO - 'MAIL': '/var/mail/cltbld', 18:29:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:30 INFO - 'MOZ_NO_REMOTE': '1', 18:29:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:30 INFO - 'NO_EM_RESTART': '1', 18:29:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:30 INFO - 'PWD': '/builds/slave/test', 18:29:30 INFO - 'SHELL': '/bin/bash', 18:29:30 INFO - 'SHLVL': '1', 18:29:30 INFO - 'TERM': 'linux', 18:29:30 INFO - 'TMOUT': '86400', 18:29:30 INFO - 'USER': 'cltbld', 18:29:30 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1498946375.671674-1308135519', 18:29:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:30 INFO - '_': '/tools/buildbot/bin/python'} 18:29:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:29:30 INFO - Running setup.py (path:/tmp/pip-ZCHzhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:29:30 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)) 18:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:29:30 INFO - Running setup.py (path:/tmp/pip-4ftG27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:29:30 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)) 18:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:29:30 INFO - Running setup.py (path:/tmp/pip-KTeIJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:29:30 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)) 18:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:29:30 INFO - Running setup.py (path:/tmp/pip-Yb8oTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:29:30 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)) 18:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:29:30 INFO - Running setup.py (path:/tmp/pip-pOq4LQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:29:30 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)) 18:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:29:30 INFO - Running setup.py (path:/tmp/pip-qKbkdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:29:30 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)) 18:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:29:30 INFO - Running setup.py (path:/tmp/pip-bgZ0HV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:29:30 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)) 18:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:29:30 INFO - Running setup.py (path:/tmp/pip-Uk9kNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:29:31 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)) 18:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:29:31 INFO - Running setup.py (path:/tmp/pip-fDqxgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:29:31 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)) 18:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:29:31 INFO - Running setup.py (path:/tmp/pip-QZCvwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:29:31 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)) 18:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:29:31 INFO - Running setup.py (path:/tmp/pip-BN3E0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:29:31 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)) 18:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:29:31 INFO - Running setup.py (path:/tmp/pip-DjywtD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:29:31 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)) 18:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:29:31 INFO - Running setup.py (path:/tmp/pip-veIPLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:29:31 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)) 18:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:29:31 INFO - Running setup.py (path:/tmp/pip-A7qtkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:29:31 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)) 18:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:29:31 INFO - Running setup.py (path:/tmp/pip-5ByKjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:29:31 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)) 18:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:29:31 INFO - Running setup.py (path:/tmp/pip-rtPvfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:29:31 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)) 18:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:29:31 INFO - Running setup.py (path:/tmp/pip-8S2ccu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:29:31 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)) 18:29:31 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)) 18:29:31 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)) 18:29:31 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)) 18:29:31 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)) 18:29:31 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)) 18:29:31 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)) 18:29:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:29:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:32 INFO - Downloading blessings-1.6.tar.gz 18:29:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:29:32 INFO - Installing collected packages: blessings 18:29:32 INFO - Running setup.py install for blessings 18:29:33 INFO - Successfully installed blessings 18:29:33 INFO - Cleaning up... 18:29:33 INFO - Return code: 0 18:29:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:29:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:29:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:29:33 INFO - Reading from file tmpfile_stdout 18:29:33 INFO - Current package versions: 18:29:33 INFO - argparse == 1.2.1 18:29:33 INFO - blessings == 1.6 18:29:33 INFO - blobuploader == 1.2.4 18:29:33 INFO - docopt == 0.6.1 18:29:33 INFO - functools32 == 3.2.3-2 18:29:33 INFO - jsonschema == 2.5.1 18:29:33 INFO - manifestparser == 1.1 18:29:33 INFO - mozInstall == 1.13 18:29:33 INFO - mozcrash == 1.0 18:29:33 INFO - mozdebug == 0.1 18:29:33 INFO - mozdevice == 0.51 18:29:33 INFO - mozfile == 1.2 18:29:33 INFO - mozhttpd == 0.7 18:29:33 INFO - mozinfo == 0.10 18:29:33 INFO - mozleak == 0.1 18:29:33 INFO - mozlog == 3.5 18:29:33 INFO - moznetwork == 0.27 18:29:33 INFO - mozprocess == 0.25 18:29:33 INFO - mozprofile == 0.28 18:29:33 INFO - mozrunner == 6.13 18:29:33 INFO - mozscreenshot == 0.1 18:29:33 INFO - mozsystemmonitor == 0.3 18:29:33 INFO - moztest == 0.8 18:29:33 INFO - mozversion == 1.4 18:29:33 INFO - psutil == 3.1.1 18:29:33 INFO - requests == 1.2.3 18:29:33 INFO - wsgiref == 0.1.2 18:29:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:29:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:29:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:29:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:33 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 0x1c5f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcefa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd22a0>, '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 0x1fd32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fcd4d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1498946375.671674-1308135519', '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 18:29:33 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 18:29:33 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 18:29:33 INFO - Using env: {'DISPLAY': ':0', 18:29:33 INFO - 'HOME': '/home/cltbld', 18:29:33 INFO - 'LANG': 'en_US.UTF-8', 18:29:33 INFO - 'LANGUAGE': 'en_US:en', 18:29:33 INFO - 'LOGNAME': 'cltbld', 18:29:33 INFO - 'MAIL': '/var/mail/cltbld', 18:29:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:33 INFO - 'MOZ_NO_REMOTE': '1', 18:29:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:33 INFO - 'NO_EM_RESTART': '1', 18:29:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:33 INFO - 'PWD': '/builds/slave/test', 18:29:33 INFO - 'SHELL': '/bin/bash', 18:29:33 INFO - 'SHLVL': '1', 18:29:33 INFO - 'TERM': 'linux', 18:29:33 INFO - 'TMOUT': '86400', 18:29:33 INFO - 'USER': 'cltbld', 18:29:33 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1498946375.671674-1308135519', 18:29:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:33 INFO - '_': '/tools/buildbot/bin/python'} 18:29:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:33 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)) 18:29:33 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)) 18:29:33 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)) 18:29:33 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)) 18:29:33 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)) 18:29:33 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)) 18:29:33 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)) 18:29:33 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)) 18:29:33 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)) 18:29:33 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:29:33 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 18:29:33 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 18:29:33 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 18:29:33 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 18:29:34 INFO - Downloading marionette_driver-1.4.0.tar.gz 18:29:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 18:29:34 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 18:29:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:29:34 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)) 18:29:34 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)) 18:29:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:29:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:29:34 INFO - Installing collected packages: marionette-driver, simplejson 18:29:34 INFO - Running setup.py install for marionette-driver 18:29:35 INFO - Running setup.py install for simplejson 18:29:35 INFO - building 'simplejson._speedups' extension 18:29:35 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 18:29:35 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 18:29:36 INFO - Successfully installed marionette-driver simplejson 18:29:36 INFO - Cleaning up... 18:29:36 INFO - Return code: 0 18:29:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:29:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:29:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:29:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fcefa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd22a0>, '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 0x1fd32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fcd4d0>, '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': 'db7e7c15f3ca076d53731445000001ba-1498946375.671674-1308135519', '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 18:29:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:29:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:29:36 INFO - Using env: {'DISPLAY': ':0', 18:29:36 INFO - 'HOME': '/home/cltbld', 18:29:36 INFO - 'LANG': 'en_US.UTF-8', 18:29:36 INFO - 'LANGUAGE': 'en_US:en', 18:29:36 INFO - 'LOGNAME': 'cltbld', 18:29:36 INFO - 'MAIL': '/var/mail/cltbld', 18:29:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:36 INFO - 'MOZ_NO_REMOTE': '1', 18:29:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:36 INFO - 'NO_EM_RESTART': '1', 18:29:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:36 INFO - 'PWD': '/builds/slave/test', 18:29:36 INFO - 'SHELL': '/bin/bash', 18:29:36 INFO - 'SHLVL': '1', 18:29:36 INFO - 'TERM': 'linux', 18:29:36 INFO - 'TMOUT': '86400', 18:29:36 INFO - 'USER': 'cltbld', 18:29:36 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1498946375.671674-1308135519', 18:29:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:36 INFO - '_': '/tools/buildbot/bin/python'} 18:29:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:29:36 INFO - Cleaning up... 18:29:36 INFO - Return code: 0 18:29:36 INFO - Running post-action listener: _resource_record_post_action 18:29:36 INFO - Running post-action listener: _start_resource_monitoring 18:29:36 INFO - Starting resource monitoring. 18:29:36 INFO - [mozharness: 2017-07-02 01:29:36.348677Z] Finished create-virtualenv step (success) 18:29:36 INFO - [mozharness: 2017-07-02 01:29:36.349707Z] Running install step. 18:29:36 INFO - Running pre-action listener: _resource_record_pre_action 18:29:36 INFO - Running main action method: install 18:29:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:29:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:29:36 INFO - Reading from file tmpfile_stdout 18:29:36 INFO - Detecting whether we're running mozinstall >=1.0... 18:29:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:29:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:29:36 INFO - Reading from file tmpfile_stdout 18:29:36 INFO - Output received: 18:29:36 INFO - Usage: mozinstall [options] installer 18:29:36 INFO - Options: 18:29:36 INFO - -h, --help show this help message and exit 18:29:36 INFO - -d DEST, --destination=DEST 18:29:36 INFO - Directory to install application into. [default: 18:29:36 INFO - "/builds/slave/test"] 18:29:36 INFO - --app=APP Application being installed. [default: firefox] 18:29:36 INFO - mkdir: /builds/slave/test/build/application 18:29:36 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'] 18:29:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:29:54 INFO - Reading from file tmpfile_stdout 18:29:54 INFO - Output received: 18:29:54 INFO - /builds/slave/test/build/application/firefox/firefox 18:29:54 INFO - Running post-action listener: _resource_record_post_action 18:29:54 INFO - [mozharness: 2017-07-02 01:29:54.672626Z] Finished install step (success) 18:29:54 INFO - [mozharness: 2017-07-02 01:29:54.672863Z] Running setup-mitmproxy step. 18:29:54 INFO - Running pre-action listener: _resource_record_pre_action 18:29:54 INFO - Running main action method: setup_mitmproxy 18:29:54 INFO - Skipping: mitmproxy is not required 18:29:54 INFO - Running post-action listener: _resource_record_post_action 18:29:54 INFO - [mozharness: 2017-07-02 01:29:54.673399Z] Finished setup-mitmproxy step (success) 18:29:54 INFO - [mozharness: 2017-07-02 01:29:54.673502Z] Running run-tests step. 18:29:54 INFO - Running pre-action listener: _resource_record_pre_action 18:29:54 INFO - Running pre-action listener: _set_gcov_prefix 18:29:54 INFO - Running main action method: run_tests 18:29:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:29:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:29:54 INFO - Python 2.7.3 18:29:54 INFO - Return code: 0 18:29:54 INFO - grabbing minidump binary from tooltool 18:29:54 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')]} 18:29:54 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 0x1fd22a0>, '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 0x1fd32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fcd4d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:29:54 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 18:29:54 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:29:54 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 18:29:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:29:54 INFO - Return code: 0 18:29:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:29:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:29:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:29:54 INFO - ENV: RUST_BACKTRACE is now 1 18:29:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:29:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:29:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/am1KHi4NTKavzzas9GpRJQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 18:29:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/am1KHi4NTKavzzas9GpRJQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-049 --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 18:29:54 INFO - Using env: {'DISPLAY': ':0', 18:29:54 INFO - 'HOME': '/home/cltbld', 18:29:54 INFO - 'LANG': 'en_US.UTF-8', 18:29:54 INFO - 'LANGUAGE': 'en_US:en', 18:29:54 INFO - 'LOGNAME': 'cltbld', 18:29:54 INFO - 'MAIL': '/var/mail/cltbld', 18:29:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:29:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:29:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:54 INFO - 'MOZ_NO_REMOTE': '1', 18:29:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:29:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:54 INFO - 'NO_EM_RESTART': '1', 18:29:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:54 INFO - 'PWD': '/builds/slave/test', 18:29:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:29:54 INFO - 'RUST_BACKTRACE': '1', 18:29:54 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:29:54 INFO - 'SHELL': '/bin/bash', 18:29:54 INFO - 'SHLVL': '1', 18:29:54 INFO - 'TERM': 'linux', 18:29:54 INFO - 'TMOUT': '86400', 18:29:54 INFO - 'USER': 'cltbld', 18:29:54 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1498946375.671674-1308135519', 18:29:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:54 INFO - '_': '/tools/buildbot/bin/python'} 18:29:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/am1KHi4NTKavzzas9GpRJQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 18:29:55 INFO - mozversion application_buildid: 20170702003930 18:29:55 INFO - mozversion application_changeset: 4d3de12dcdc539f14fcb06539da39fa7176c8955 18:29:55 INFO - mozversion application_display_name: Nightly 18:29:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:29:55 INFO - mozversion application_name: Firefox 18:29:55 INFO - mozversion application_remotingname: firefox 18:29:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:29:55 INFO - mozversion application_vendor: Mozilla 18:29:55 INFO - mozversion application_version: 56.0a1 18:29:55 INFO - mozversion platform_buildid: 20170702003930 18:29:55 INFO - mozversion platform_changeset: 4d3de12dcdc539f14fcb06539da39fa7176c8955 18:29:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:29:55 INFO - mozversion platform_version: 56.0a1 18:29:55 INFO - using testdate: 1498958995 18:29:55 INFO - actual date: 1498958995 18:29:55 INFO - starting webserver on 'localhost:41239' 18:29:55 INFO - SUITE-START | Running 2 tests 18:29:55 INFO - TEST-START | dromaeo_css 18:29:55 INFO - Initialising browser for dromaeo_css test... 18:29:55 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41239/getInfo.html -profile /tmp/tmpKHHt0c/profile 18:29:55 INFO - TEST-INFO | started process 3362 (/builds/slave/test/build/application/firefox/firefox http://localhost:41239/getInfo.html) 18:30:04 INFO - TEST-INFO | 3362: exit 0 18:30:04 INFO - Browser initialized. 18:30:04 INFO - Running cycle 1/1 for dromaeo_css test... 18:30:04 INFO - TEST-INFO | started process 3584 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKHHt0c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:30:16 INFO - PID 3584 | RSS: Main: 172376064 18:30:16 INFO - PID 3584 | 18:33:15 INFO - PID 3584 | Cycle 1(1): loaded http://localhost:41239/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41239/tests/dromaeo/cssquery-ext.html) 18:33:17 INFO - PID 3584 | RSS: Main: 177434624 18:33:17 INFO - PID 3584 | 18:36:19 INFO - PID 3584 | Cycle 1(1): loaded http://localhost:41239/tests/dromaeo/cssquery-ext.html (next: http://localhost:41239/tests/dromaeo/cssquery-jquery.html) 18:36:19 INFO - PID 3584 | RSS: Main: 176656384 18:36:19 INFO - PID 3584 | 18:39:21 INFO - PID 3584 | Cycle 1(1): loaded http://localhost:41239/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41239/tests/dromaeo/cssquery-mootools.html) 18:39:22 INFO - PID 3584 | RSS: Main: 179781632 18:39:22 INFO - PID 3584 | 18:42:23 INFO - PID 3584 | Cycle 1(1): loaded http://localhost:41239/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41239/tests/dromaeo/cssquery-prototype.html) 18:42:24 INFO - PID 3584 | RSS: Main: 177074176 18:42:24 INFO - PID 3584 | 18:45:27 INFO - PID 3584 | Cycle 1(1): loaded http://localhost:41239/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41239/tests/dromaeo/cssquery-yui.html) 18:45:28 INFO - PID 3584 | RSS: Main: 177602560 18:45:28 INFO - PID 3584 | 18:48:30 INFO - PID 3584 | Cycle 1(1): loaded http://localhost:41239/tests/dromaeo/cssquery-yui.html (next: http://localhost:41239/tests/dromaeo/cssquery-dojo.html) 18:48:30 INFO - PID 3584 | RSS: Main: 181706752 18:48:30 INFO - PID 3584 | 18:48:30 INFO - PID 3584 | __start_tp_report 18:48:30 INFO - PID 3584 | _x_x_mozilla_page_load 18:48:30 INFO - PID 3584 | _x_x_mozilla_page_load_details 18:48:30 INFO - PID 3584 | |i|pagename|runs| 18:48:30 INFO - PID 3584 | |0;dojo.html;3100.503919372898;3150.4329220740265;3155.6213254409467;3164.0507847645713;3202.1514298710845;6070.2412198475195;6078.483328917042;6089.604175728575;6096.786612468564;6144.016957286835;6039.698015099239;6065;6093.055576385656;6101.389861013897;6126.693665316739;5546.140348246028;5570.275864137657;5593.468620481048;5631.352394474647;5663.122216056498;5703.230063941377;5714.799982000631;5743.339515955677;5743.5405167586705;5747.3677895431465;5687.630304030225;5699.059655156894;5703.859228154365;5713.342965558952;5718.6568805871575;5709.0580054290995;5719.256496655429;5731.369549349568;5731.484166425042;5738.885222295572;5626.774929002835;5643.830685079454;5653.038983372795;5699.74351154199;5742.454466825645;6194.039923811816;6194.163787888622;6209.627422354628;6282.591631543935;6316.810495685137;6366.427021568081;6608.173978252718;6634.270230274666;6667.799966001027;6677.76627818024;6627.93372066278;6652.168478940132;6660.9000864987065;6664.400203981665;6673.0991316172185;6111.297200821918;6113.786017489411;6135.447809697193;6138.048602466625;6168.1056246843955;5219.895602087937;6646.734130634817;6655.567388119854;6664.7000884959325;6744;6270.9372906271265;6315.652639104802;6339.904901426482;6414.454771344394;6427.646479443675;6406.199225096863;6421.8073457796345;6516.478681705452;6517.348265173445;6521.934780652227;6298.71655775482;6472.741090356333;6478.740850365933;6480.902786458207;6488.448481878999;6543.705533251015;6591.802245932629;6616.536842420985;6617.569857959217;6688.030235615905;5227.764750586232;5297.814576489882;5341.599380046512;5363.517283444508;5378.300820893259;4495.797689103998;4528.547145285445;4533.84131555394;4545.749983750859;4550.613197878151;5673.319201695823;5686.459786320293;5701.543876489871;5712.314522257273;5720.885582288331;6586.637734924625;6603.537752357385;6611;6621.172353455818;6623.536352455379;5593.356763972114;5685.232493613309;5711.200431939532;5711.828645140652;5711.828645140652;5620.747066382022;5635.3237611486065;5644.096944488862;5652.18043383707;5669.433056694297;5242;6309.463695585835;6319.462845658079;6373.075903993895;6423.164988551458;6552.737890484327;6558.147440832661;6639.800805975829;6651.933480665131;6669.333066693292;6282.780102696383;6320.115183874169;6383.904241436289;6412.583182093149;6429.260635027032;6351.523635727432;6385.233771947396;6432.485401167989;6450.225972883284;6463.57986730861;5032.295478633067;6578.243501997332;6649.667516624246;6659.4006539411685;6693.631850248088;6355.269144048493;6359.841003974752;6426.775062872777;6427.068075129174;6457.192850893638;6386.233651961795;6413.743450261937;6482.967585162044;6500.992346186349;6512.967435162794;6243.562950593415;6296.842578935563;6312.7159277833525;6335.714892829926;6375.362463753588;6378.075179098912;6459.903101453576;6460.966245400713;6466.676666166767;6471.320511346241;6148.907766383419;6170.784022559189;6215.409536094064;6231.657258850625;6318.747250109944 18:48:30 INFO - PID 3584 | |1;ext.html;827.8468483330585;846.8137009857829;858.5707146426787;884.9424787388823;885.2165833237585;38660;39924.40113398294;39987.80006099969;40209.79895100521;40357.991050223725;36080.45879311812;36253.09367265819;36312.81843590785;36537.53849846003;36540;6704.22901366343;6871.450283977295;6894.103766510347;6915.204751453572;6930.44556435484;6763.763268285611;6847.965760171192;6863.828404289883;6869.656517174146;6873.106496155518;6770.1875774907085;6812.863742725142;6820.556663816836;6836.384725374715;6850.691718872663;6796;6818.931810681929;6833.214180369222;6833.9316606834045;6863.622500762481;6214.471769899564;6233.937660623426;6273.12176295319;6282.591631543981;6285;32446.188845278823;32682.836585817156;32778.344433111444;32787.83606081978;32830.671693283;3374.4263475209273;3406.369821583015;3421.5209870618132;3428.6228514863346;3430.691237788586;28576.428471430663;30786.692133078832;30794.076177714705;30892.227694307596;31012.844935775403;4662.463816661059;4798.23228283473;4818.903621927577;4928.137575924199;4946.851594452172;182535.08732456385;185102;186496.99999999863;194386;195936;47440.28839567409;47769.28346074812;47900.28149577759;48076.75961620169;48204;50445.49554504408;50515.49484505108;50536;50636.240456393185;50684.74657626688;15854.60363490922;15976.680466390608;16001.759973600405;16011.839881601269;16080.678386432206;13320.267385293902;13373.799393009112;13379.598612041655;13401.731965360637;13403.262820544769;14008.879289656803;14118.152910825384;14188.929055354658;14246.358913848902;14310.427582896567;5586.441355864381;5785.71071446426;5807.216025836543;5862.12068189775;5902.144189092557;965.8309795785709;978.2995375311215;978.814025335184;1015.8831734350497;1017.3743147963949;22576.774232257467;22671.9797609108;22674.206402775824;22957.88521057384;23020.65469017966;1059.2955684469741;1078.8489611454402;1080.5515710979855;1101.4217535793773;1101.9724506887392;15320.693586128438;15938.28277727505;15983.840161598235;16098.597535061717;16323.836761632469;223311;226994;227164;227365;227406;55698;56057;56156.157657635165;56162.7191864038;56248.71875640596;1380.8895288376905;1448.4857875454272;1450.6881020580627;1457.7230326237982;1467.39103272143;25697.229083127535;26997.595036074083;27012.72987270102;27280.454390912466;27416.451670966868;37468.25063498769;37603.623963760016;37632;37640.43539346857;37661.81169094137;200073;201121;202375;202933;203399;31791.523127153574;32732.345353093282;32924.859884107456;33048.173795655304;33113;39755.80122099371;39921.80039099902;42716.572834272505;42816;42901.141977159656;30654.540181896842;31442.056738297888;31547.684523154476;31930.201744955633;32009;30227.395452091274;31110.68889311078;31272.687273126976;31586.368272634878;31615.683843161274;34065;34088.48867267043;34147.31705365929;36994.630053700195;37901.431478527295;32186.517202241517;32490.02529924106;33147;33321.83339083289;34062.48906266457;23886.88056559706;24312.635310470003;24634;25052;25175.87412062928 18:48:30 INFO - PID 3584 | |2;jquery.html;561.9241402410673;564.7486868343586;565.6606036378172;566.3373852592468;585.7071464267866;21419.571608567818;22201.2229571965;22232.999515021842;22279.220227292048;22324.107035718593;23635.818209089564;25846.612300815505;25972.48055038898;25989;26242.737572624315;6340.873182536358;6528.281888992207;6547.247066587332;6560.311167327433;6578.473722102244;6449.451796597295;6454.386833250857;6464.93535064648;6487.286398496161;6514.706838192293;5870.823875283749;6372.936270637304;6445.8710825783455;6455.031745238205;6461.224653041641;6377.170967774183;6432.678366081701;6439.742410303582;6448.613083215022;6472.482201423874;5950.9702451487465;5983.670898100603;5989.970050149721;6019.789307374221;6022.277326720778;27013.459730805273;28057.579136312972;28408;28638.570421443696;28653.426931461254;1931.3723040012053;1982.0486166639948;1994.5113447205526;1995.7804641489424;1997.121266642687;17147.74278385825;17580.824191758045;17622.471325860246;17626.206820692973;17674.823251767575;2282.657601359793;2308.1575225042907;2359.799417049536;2362.83460157789;2365.9408514787096;118630.4068479652;121555;121687;121852.39073804574;123215.3839230807;14004.649883752987;14594.41622335116;14706.55880323592;14722.337494812758;15218.467353642569;23129.653055204184;23133.884330578578;23189.3043208704;23226.767732322798;23251.88374058119;9277.67528136512;9430.3398762086;9471.100245476806;9502.239820814319;9537.523123843781;8422.747317580483;8434.62044208012;8440.62017209227;8512.40371686629;8628.35287353451;8923.687670931486;8981.191692747683;9013.098690130935;9114.13415725505;9143.908560914439;2665.7334266573575;2676.531606968773;2686.9731302687114;2708.5530887403356;2870.478646317455;961.7980224153006;973.6105557776805;983.6557204978201;1002.9398236105857;1008.5411137932223;19384.2246310146;19644.410667679993;19838.50403739918;19901.800981990284;20236.279916207288;1000.7190795781412;1020.8315627921459;1048.5962904281753;1059.1103473082649;1079.8110330692098;10908.23642345044;10946.452677366258;12450.377481125908;13323.13399629021;13523.120997135155;514090;526509;537523;551107;556279;104385.47807260916;106160;109286;113344;113906.99999999834;1249.4939549482474;1261.4610175585772;1326.1048792065317;1331.2744554217975;1332.0342751505275;19365.709514357015;20034.599308013465;20196.79803201949;20216.19135234574;20264.898675506527;50078.49921500738;50213.24680129874;51032.74483627558;52418.21372679489;52441.47558524366;61653.691731541054;65431;65646.67176664087;65800;66393;12564.183328083645;12673.746525069262;12769.489220431078;12831.486740530274;12874.098813082994;14538.200398978157;16335.836641633432;17784.822151778317;17915.641687165924;18009.819901800813;14991.325390357679;15123.16822574725;15199.544013679608;15280.617984550476;15470.530299621518;14242;14333.140011599337;14430.639234019234;14603.123812571279;15117.244137793286;16038;16156.838431615533;16234.675306493567;16299.674006520041;16367.42714005004;12552.309622970824;12576.245425274512;12639.87360126387;12688.302143382203;12689.619311420673;15680.215989200266;15723.292451839923;15803.920980395025;15824.841751582337;16042.518724438285 18:48:30 INFO - PID 3584 | |3;mootools.html;1346.4479563379014;1411.477753231304;1416.334322868253;1419.687668712883;1426.693260948896;13438.126521776077;14016.78974815376;14063.859361406383;14065.085769424993;14101.57695269141;13494.662633434145;14165.150090994523;14493.63765905853;14543.12741235524;14652.4871629493;2660.9600855987173;2705.2154875086203;2719.456108778242;2725.7819374450096;2735.8358498490156;2571.3186005708503;2631.3290111021756;2637.301115204463;2659.6143559183906;2663.853488058156;2478;2490.9377265568323;2515.5094756522485;2542.1356738708837;2543.631173479844;2626.7635912767846;2708.4583083383204;2722.754952054325;2723.9319017024536;2724.2372135802007;2563.6923569171818;2610.386559158615;2618.5417551928335;2618.764311212;2621;14007.64980875476;14136.363863626162;14138.646533836634;14195.148291102567;14210.360533775902;7314.96342518284;7631.084269887593;7649.04386951631;7655.693772249159;7686.730964416274;4836.830710925101;4872.293517439987;5108;5135.35808023997;5153.201253805666;1797.8202179782047;1828.6708392489347;1828.9908550457296;1905.560463363628;1910.5128192310872;22404.887975560017;22462.101515939343;22466.77533224663;22495.66256506154;22547.549049019093;6287.2769631492965;6294.622322660655;6431;6533.705983230766;6563.376479234561;15595.220238988006;15694.68610627781;15710.450134245246;15711.921440392953;15745.606359841096;7297.270272972766;7495.287947644965;7498.512596681198;7498.925010749932;7508.324250817453;6751.729930802713;6925.168979722465;6970.477214208955;6979.616121113286;7077.3984211341585;4962.503749625081;4989.950100498949;5010.5240002199735;5129.820141367506;5215.895682086337;1408.7816388459805;1411.7670584353673;1419.1201455097905;1421.992890035564;1438.2592964623227;873.1617647058767;874.2961915657829;897.6185121323412;905.298393744853;922.1700469577299;7125.323094306136;7184.533005354635;7184.928150718531;7202.387797037206;7284.70861165558;705.8694141583824;728.1989811207629;971.6356366362614;1008.1481148429565;1016.9745756356002;4789.808407663724;5081.983603279285;5120.078385890501;5228.503292187236;5405.324334458192;17420.30318787234;18308.084595770157;18623.720644190347;18791.34230301933;18821.52946176329;18029.639407211784;18437.1703273353;18970.71543926842;18971.14629841633;18975.43073707791;10262.230332725076;10573.4713264338;10598.311109777995;10630.840537391945;10669.039786419415;7480.177180510248;8148.1037085919315;8166.346692264723;8256.463329883538;8339.53760287013;15469.381224750883;15754.842451575338;15777.763333549776;16050.678986419973;16132.112733799753;15502.258603908618;15921.363145474515;16222.78329125344;16703.83296167023;16785;11400.600978965696;11661.533538658698;11661.941690291495;11676.88323116758;11717.707057323634;13011.869881301065;13406.798898016343;13418;13443.529476468277;13494.865051349361;10844.945775271073;11068.612598559012;11122.277051991594;11144.554217831195;11559.30644161353;10653.307535010199;11022.393768342497;11050.778984420105;11288.604898828502;11339;9110.817783644423;9344;9352.485613291063;9439.292053096182;9500.572474238814;6334.968325158345;6507.446867016357;6854.417374523221;6987.755428559976;7024.26245244242;6923.342282483156;7035.964820175866;7045.26024767392;7085.716571337089;7096.609686467294 18:48:30 INFO - PID 3584 | |4;prototype.html;487.3480620747649;501.6372883717688;518.5644058990447;521.4003895520151;523.4111624422525;6029.7286622102;6088.726007329681;6110.541709371792;6149.508039356852;6207.875842483148;5745;5918.7632494700265;5970.313413957396;6019.699015049252;6027.758889644409;4912.164931961575;4912.410510738717;4918.409790825106;4928.950710492894;4956.132676781567;4916.3608730864935;4939.814444533304;4949.925751113737;4974.303597496335;4989.600831933437;4647.256438969765;4834.685745426554;4868.318435419044;4889.071076495455;4924.827631032915;4826.1312963666705;4838.250071238928;4866.270059491069;4867.269909513566;4889.779959901813;4361.6074553290355;4402.449693788277;4406.933895991563;4414.955850441486;4445.26653102241;5889.734961926681;5899.115132730082;5911.852203694899;5918.260217472816;5952.58331916766;5527.640703354269;5555.527780138693;5567.554595632339;5612.971935140339;5618.757837832411;6431.903521447182;6438.903416448757;6484.351564843525;6501.577397469149;6517.869642607168;4850.248211527219;4850.684705494132;4873.512648735134;4882.145624515695;4887;6757.70238119037;6775.525713200078;6825.726970921157;6868.347506986828;6872.793816185523;4921.630877684188;4925;4930.580900623416;4930.605551555867;4944.653874228769;4950.579200767975;4963.429205641398;4983.526564976321;4985.825496107619;5012.724300163453;5556.693972001574;5561.416051314634;5599.524040456607;5610.186522954149;5614.820887613647;6423.389777971085;6469.805905822833;6479.153441269215;6531.608103513804;6543.905950096018;1719.733441316598;1775.9644807104044;1776.7956684981134;1782.616737401465;1787.1600347836495;1117.7261570915016;1124.7019539821954;1215.866254711981;1223.6818427208989;1230.267990545624;5467.343918729778;5473.726313684379;5498.890022199534;5546.750396232179;5690.345610254791;6523.315051919575;6569.80290591283;6580.407763301326;6587.703553340111;6639.43564796988;5634.915476267859;5635.69003704792;5692.601517893708;5704.89083449521;5711.143328500675;3452.654734526527;3502.7022703070525;3509.666581674737;3545.3441113394106;3563.55455568054;6270.617165477181;6422.165118534561;6447.451966582799;6478.805635830932;6492.642904640195;6679.165104361955;6706.396424321834;6724.193096828314;6761.4590832733265;6806.8298292542095;6340.207474065742;6365.427111559982;6382.170317858649;6431.324710905287;6450.2259728831905;6520.510961677798;6547.345265473415;6549.24683661385;6581.407673309425;6604.570702904296;6557.475401967736;6572.638504882278;6595.274519802914;6629.7348106075215;6668.266490685924;6431.874421976229;6433.420992110732;6450.967745161244;6464.870702586016;6468;4893.266010098514;4940.827071052496;4965.975170124127;4984.252362145708;4989.401271847401;6684.799456016327;6685.565438246498;6710.228323742832;6753.86492270142;6756.29058948823;6348.873022539616;6377.660691254889;6400.263969643551;6453.580517266362;6457;6372.267189273293;6438.871222575616;6447.161868957006;6466.902996455151;6481.189851268591;6298.08677741734;6368.5860419072615;6406.13517175194;6406.423421892052;6444.420002199825;6442.324995501297;6509.967450162909;6576.572522786004;6591.604503729792;6593.901091483727;5949.940500595112;6065.3934606539;6209;6215.440610345091;6236.937630623817 18:48:30 INFO - PID 3584 | |5;yui.html;911.1253196930942;922.1055576091189;925.3846192282133;937.6671281694998;950.8145911547247;18648.347307844244;18748.718769218456;18995;19012;19099.140538675758;17421.651566968652;19757.802421975775;19777.505562360948;19821.108050137744;20142.093605787737;1003.1642094966231;1038.9896101039005;1042.0152955457097;1042.9113525350317;1044.2377064742743;1074.2211896375104;1076.252004856625;1076.5532304093792;1076.6608518316743;1077.348204336377;792.2117493094379;1116.4752566293828;1119.9608013719521;1128.661401579527;1132.9037031852301;810.2140923304415;973.6008236622986;1101.9559217631286;1105.8230683090667;1108.4346983038627;803.8271771569141;805.0862271322034;806.5967016491754;807.8142027333687;808.3775492870516;18587.44237672872;19404.320848770367;19516.70724939127;19704.605907881763;19777.604447911104;20380;20444.080016399297;20660.79339206619;20761.377158685264;20876.686849697267;15471.5358539244;15662.530124096294;15900.363985440568;15957.84042159575;16066.196690165561;3545.911352216215;3561.786292822413;3561.9109522261892;3564.6791788739138;3569.5716514018486;101835.99999999926;103089;106570;106720.46639766752;112186;16050.197490125447;16185;16620.085895275875;16639.084850333347;16653.250603722863;27208.863955680492;28375.432491350057;28934.131976040753;28945.276368090967;29110.563341549892;8865.556722163867;8947.552622368985;8978.371513993958;9002.189802917768;9007.324450666227;4043.757374557536;4072.735272207297;4093.692973027035;4097.569755175723;4202.768847713344;4988.6009119270375;5099.923501147486;5103.209002604528;5116.872078198;5145.048166089286;1024.073213741565;1032.667858462575;1062.7343164208949;1068.604616291977;1070.1920050362082;648.2318452633644;660.8050625065617;669.3674477618702;686.5674624986227;690.8998195261659;11254.43727813606;11309.60416385439;11845.940770296265;13452.798208026887;13769.449222031208;675.3078094952713;693.7779910428615;709.2198581560242;712.7826013065961;720.3228964773097;5218.530332270114;5227.843164705065;5240.3973543042275;5468.972655136698;5504.80733174337;88828.5558572203;92228;94709;95239;99981.50009249907;87172.56413718018;87935;88321.55839220891;88660.5566972161;89798;72928.63535682288;75447.24552754402;75856.24143758602;75866;77532.83700744493;10805.891941080488;11016.449177540931;11401.258918170292;12288.463942007249;12302.938485307515;34713.511033449024;34817;35575.93272201734;35854.46218306779;36256.818715907306;60052.699736502786;61678;62696.37303627088;63263;66179.33820661924;16341.754873677142;16356.345746170497;16370.263338150051;16495.83504164943;18621.90689046546;19559.21763129516;20136.295229666892;20258.696119557924;20420.489487762923;20506.89746551258;17154;18302.633947321247;18388.172532235814;19021.04894755229;20325.695114573587;16248;16967.91516042412;16987.40544080951;17008.149592520076;17120.914395427943;17618.471445856645;18983.620327593646;19200;19395.8060419394;19444;13713.794293085812;13862.65343366424;13889.652758681113;14065.367058482598;14148.22184779847;14330.49843255481;14445.133292002514;14486.710265794836;14536.127832330094;14730.26348682583 18:48:30 INFO - PID 3584 | __end_tp_report 18:48:30 INFO - PID 3584 | __start_cc_report 18:48:30 INFO - PID 3584 | _x_x_mozilla_cycle_collect,344 18:48:30 INFO - PID 3584 | __end_cc_report 18:48:30 INFO - PID 3584 | __startTimestamp1498960110363__endTimestamp 18:48:30 INFO - PID 3584 | 18:48:30 INFO - PID 3584 | ------- Summary: start ------- 18:48:30 INFO - PID 3584 | Number of tests: 6 18:48:30 INFO - PID 3584 | 18:48:30 INFO - PID 3584 | [#0] dojo.html Cycles:165 Average:6025.59 Median:6282.59 stddev:706.54 (11.2%) stddev-sans-first:670.41 18:48:30 INFO - PID 3584 | Values: 3100.5 3150.4 3155.6 3164.1 3202.2 6070.2 6078.5 6089.6 6096.8 6144.0 6039.7 6065.0 6093.1 6101.4 6126.7 5546.1 5570.3 5593.5 5631.4 5663.1 5703.2 5714.8 5743.3 5743.5 5747.4 5687.6 5699.1 5703.9 5713.3 5718.7 5709.1 5719.3 5731.4 5731.5 5738.9 5626.8 5643.8 5653.0 5699.7 5742.5 6194.0 6194.2 6209.6 6282.6 6316.8 6366.4 6608.2 6634.3 6667.8 6677.8 6627.9 6652.2 6660.9 6664.4 6673.1 6111.3 6113.8 6135.4 6138.0 6168.1 5219.9 6646.7 6655.6 6664.7 6744.0 6270.9 6315.7 6339.9 6414.5 6427.6 6406.2 6421.8 6516.5 6517.3 6521.9 6298.7 6472.7 6478.7 6480.9 6488.4 6543.7 6591.8 6616.5 6617.6 6688.0 5227.8 5297.8 5341.6 5363.5 5378.3 4495.8 4528.5 4533.8 4545.7 4550.6 5673.3 5686.5 5701.5 5712.3 5720.9 6586.6 6603.5 6611.0 6621.2 6623.5 5593.4 5685.2 5711.2 5711.8 5711.8 5620.7 5635.3 5644.1 5652.2 5669.4 5242.0 6309.5 6319.5 6373.1 6423.2 6552.7 6558.1 6639.8 6651.9 6669.3 6282.8 6320.1 6383.9 6412.6 6429.3 6351.5 6385.2 6432.5 6450.2 6463.6 5032.3 6578.2 6649.7 6659.4 6693.6 6355.3 6359.8 6426.8 6427.1 6457.2 6386.2 6413.7 6483.0 6501.0 6513.0 6243.6 6296.8 6312.7 6335.7 6375.4 6378.1 6459.9 6461.0 6466.7 6471.3 6148.9 6170.8 6215.4 6231.7 6318.7 18:48:30 INFO - PID 3584 | 18:48:30 INFO - PID 3584 | [#1] ext.html Cycles:180 Average:37221.80 Median:18348.13 stddev:53476.22 (291.5%) stddev-sans-first:53556.41 18:48:30 INFO - PID 3584 | Values: 827.8 846.8 858.6 884.9 885.2 38660.0 39924.4 39987.8 40209.8 40358.0 36080.5 36253.1 36312.8 36537.5 36540.0 6704.2 6871.5 6894.1 6915.2 6930.4 6763.8 6848.0 6863.8 6869.7 6873.1 6770.2 6812.9 6820.6 6836.4 6850.7 6796.0 6818.9 6833.2 6833.9 6863.6 6214.5 6233.9 6273.1 6282.6 6285.0 32446.2 32682.8 32778.3 32787.8 32830.7 3374.4 3406.4 3421.5 3428.6 3430.7 28576.4 30786.7 30794.1 30892.2 31012.8 4662.5 4798.2 4818.9 4928.1 4946.9 182535.1 185102.0 186497.0 194386.0 195936.0 47440.3 47769.3 47900.3 48076.8 48204.0 50445.5 50515.5 50536.0 50636.2 50684.7 15854.6 15976.7 16001.8 16011.8 16080.7 13320.3 13373.8 13379.6 13401.7 13403.3 14008.9 14118.2 14188.9 14246.4 14310.4 5586.4 5785.7 5807.2 5862.1 5902.1 965.8 978.3 978.8 1015.9 1017.4 22576.8 22672.0 22674.2 22957.9 23020.7 1059.3 1078.8 1080.6 1101.4 1102.0 15320.7 15938.3 15983.8 16098.6 16323.8 223311.0 226994.0 227164.0 227365.0 227406.0 55698.0 56057.0 56156.2 56162.7 56248.7 1380.9 1448.5 1450.7 1457.7 1467.4 25697.2 26997.6 27012.7 27280.5 27416.5 37468.3 37603.6 37632.0 37640.4 37661.8 200073.0 201121.0 202375.0 202933.0 203399.0 31791.5 32732.3 32924.9 33048.2 33113.0 39755.8 39921.8 42716.6 42816.0 42901.1 30654.5 31442.1 31547.7 31930.2 32009.0 30227.4 31110.7 31272.7 31586.4 31615.7 34065.0 34088.5 34147.3 36994.6 37901.4 32186.5 32490.0 33147.0 33321.8 34062.5 23886.9 24312.6 24634.0 25052.0 25175.9 18:48:30 INFO - PID 3584 | 18:48:30 INFO - PID 3584 | [#2] jquery.html Cycles:180 Average:34473.34 Median:22301.66 stddev:89299.19 (400.4%) stddev-sans-first:89513.40 18:48:30 INFO - PID 3584 | Values: 561.9 564.7 565.7 566.3 585.7 21419.6 22201.2 22233.0 22279.2 22324.1 23635.8 25846.6 25972.5 25989.0 26242.7 6340.9 6528.3 6547.2 6560.3 6578.5 6449.5 6454.4 6464.9 6487.3 6514.7 5870.8 6372.9 6445.9 6455.0 6461.2 6377.2 6432.7 6439.7 6448.6 6472.5 5951.0 5983.7 5990.0 6019.8 6022.3 27013.5 28057.6 28408.0 28638.6 28653.4 1931.4 1982.0 1994.5 1995.8 1997.1 17147.7 17580.8 17622.5 17626.2 17674.8 2282.7 2308.2 2359.8 2362.8 2365.9 118630.4 121555.0 121687.0 121852.4 123215.4 14004.6 14594.4 14706.6 14722.3 15218.5 23129.7 23133.9 23189.3 23226.8 23251.9 9277.7 9430.3 9471.1 9502.2 9537.5 8422.7 8434.6 8440.6 8512.4 8628.4 8923.7 8981.2 9013.1 9114.1 9143.9 2665.7 2676.5 2687.0 2708.6 2870.5 961.8 973.6 983.7 1002.9 1008.5 19384.2 19644.4 19838.5 19901.8 20236.3 1000.7 1020.8 1048.6 1059.1 1079.8 10908.2 10946.5 12450.4 13323.1 13523.1 514090.0 526509.0 537523.0 551107.0 556279.0 104385.5 106160.0 109286.0 113344.0 113907.0 1249.5 1261.5 1326.1 1331.3 1332.0 19365.7 20034.6 20196.8 20216.2 20264.9 50078.5 50213.2 51032.7 52418.2 52441.5 61653.7 65431.0 65646.7 65800.0 66393.0 12564.2 12673.7 12769.5 12831.5 12874.1 14538.2 16335.8 17784.8 17915.6 18009.8 14991.3 15123.2 15199.5 15280.6 15470.5 14242.0 14333.1 14430.6 14603.1 15117.2 16038.0 16156.8 16234.7 16299.7 16367.4 12552.3 12576.2 12639.9 12688.3 12689.6 15680.2 15723.3 15803.9 15824.8 16042.5 18:48:30 INFO - PID 3584 | 18:48:30 INFO - PID 3584 | [#3] mootools.html Cycles:180 Average:8584.27 Median:2542.88 stddev:5773.68 (227.1%) stddev-sans-first:5764.27 18:48:30 INFO - PID 3584 | Values: 1346.4 1411.5 1416.3 1419.7 1426.7 13438.1 14016.8 14063.9 14065.1 14101.6 13494.7 14165.2 14493.6 14543.1 14652.5 2661.0 2705.2 2719.5 2725.8 2735.8 2571.3 2631.3 2637.3 2659.6 2663.9 2478.0 2490.9 2515.5 2542.1 2543.6 2626.8 2708.5 2722.8 2723.9 2724.2 2563.7 2610.4 2618.5 2618.8 2621.0 14007.6 14136.4 14138.6 14195.1 14210.4 7315.0 7631.1 7649.0 7655.7 7686.7 4836.8 4872.3 5108.0 5135.4 5153.2 1797.8 1828.7 1829.0 1905.6 1910.5 22404.9 22462.1 22466.8 22495.7 22547.5 6287.3 6294.6 6431.0 6533.7 6563.4 15595.2 15694.7 15710.5 15711.9 15745.6 7297.3 7495.3 7498.5 7498.9 7508.3 6751.7 6925.2 6970.5 6979.6 7077.4 4962.5 4990.0 5010.5 5129.8 5215.9 1408.8 1411.8 1419.1 1422.0 1438.3 873.2 874.3 897.6 905.3 922.2 7125.3 7184.5 7184.9 7202.4 7284.7 705.9 728.2 971.6 1008.1 1017.0 4789.8 5082.0 5120.1 5228.5 5405.3 17420.3 18308.1 18623.7 18791.3 18821.5 18029.6 18437.2 18970.7 18971.1 18975.4 10262.2 10573.5 10598.3 10630.8 10669.0 7480.2 8148.1 8166.3 8256.5 8339.5 15469.4 15754.8 15777.8 16050.7 16132.1 15502.3 15921.4 16222.8 16703.8 16785.0 11400.6 11661.5 11661.9 11676.9 11717.7 13011.9 13406.8 13418.0 13443.5 13494.9 10844.9 11068.6 11122.3 11144.6 11559.3 10653.3 11022.4 11050.8 11288.6 11339.0 9110.8 9344.0 9352.5 9439.3 9500.6 6335.0 6507.4 6854.4 6987.8 7024.3 6923.3 7036.0 7045.3 7085.7 7096.6 18:48:30 INFO - PID 3584 | 18:48:30 INFO - PID 3584 | [#4] prototype.html Cycles:180 Average:5421.98 Median:5934.35 stddev:1520.44 (25.6%) stddev-sans-first:1478.90 18:48:30 INFO - PID 3584 | Values: 487.3 501.6 518.6 521.4 523.4 6029.7 6088.7 6110.5 6149.5 6207.9 5745.0 5918.8 5970.3 6019.7 6027.8 4912.2 4912.4 4918.4 4929.0 4956.1 4916.4 4939.8 4949.9 4974.3 4989.6 4647.3 4834.7 4868.3 4889.1 4924.8 4826.1 4838.3 4866.3 4867.3 4889.8 4361.6 4402.4 4406.9 4415.0 4445.3 5889.7 5899.1 5911.9 5918.3 5952.6 5527.6 5555.5 5567.6 5613.0 5618.8 6431.9 6438.9 6484.4 6501.6 6517.9 4850.2 4850.7 4873.5 4882.1 4887.0 6757.7 6775.5 6825.7 6868.3 6872.8 4921.6 4925.0 4930.6 4930.6 4944.7 4950.6 4963.4 4983.5 4985.8 5012.7 5556.7 5561.4 5599.5 5610.2 5614.8 6423.4 6469.8 6479.2 6531.6 6543.9 1719.7 1776.0 1776.8 1782.6 1787.2 1117.7 1124.7 1215.9 1223.7 1230.3 5467.3 5473.7 5498.9 5546.8 5690.3 6523.3 6569.8 6580.4 6587.7 6639.4 5634.9 5635.7 5692.6 5704.9 5711.1 3452.7 3502.7 3509.7 3545.3 3563.6 6270.6 6422.2 6447.5 6478.8 6492.6 6679.2 6706.4 6724.2 6761.5 6806.8 6340.2 6365.4 6382.2 6431.3 6450.2 6520.5 6547.3 6549.2 6581.4 6604.6 6557.5 6572.6 6595.3 6629.7 6668.3 6431.9 6433.4 6451.0 6464.9 6468.0 4893.3 4940.8 4966.0 4984.3 4989.4 6684.8 6685.6 6710.2 6753.9 6756.3 6348.9 6377.7 6400.3 6453.6 6457.0 6372.3 6438.9 6447.2 6466.9 6481.2 6298.1 6368.6 6406.1 6406.4 6444.4 6442.3 6510.0 6576.6 6591.6 6593.9 5949.9 6065.4 6209.0 6215.4 6236.9 18:48:30 INFO - PID 3584 | 18:48:30 INFO - PID 3584 | [#5] yui.html Cycles:180 Average:21684.31 Median:19978.70 stddev:27645.43 (138.4%) stddev-sans-first:27678.97 18:48:30 INFO - PID 3584 | Values: 911.1 922.1 925.4 937.7 950.8 18648.3 18748.7 18995.0 19012.0 19099.1 17421.7 19757.8 19777.5 19821.1 20142.1 1003.2 1039.0 1042.0 1042.9 1044.2 1074.2 1076.3 1076.6 1076.7 1077.3 792.2 1116.5 1120.0 1128.7 1132.9 810.2 973.6 1102.0 1105.8 1108.4 803.8 805.1 806.6 807.8 808.4 18587.4 19404.3 19516.7 19704.6 19777.6 20380.0 20444.1 20660.8 20761.4 20876.7 15471.5 15662.5 15900.4 15957.8 16066.2 3545.9 3561.8 3561.9 3564.7 3569.6 101836.0 103089.0 106570.0 106720.5 112186.0 16050.2 16185.0 16620.1 16639.1 16653.3 27208.9 28375.4 28934.1 28945.3 29110.6 8865.6 8947.6 8978.4 9002.2 9007.3 4043.8 4072.7 4093.7 4097.6 4202.8 4988.6 5099.9 5103.2 5116.9 5145.0 1024.1 1032.7 1062.7 1068.6 1070.2 648.2 660.8 669.4 686.6 690.9 11254.4 11309.6 11845.9 13452.8 13769.4 675.3 693.8 709.2 712.8 720.3 5218.5 5227.8 5240.4 5469.0 5504.8 88828.6 92228.0 94709.0 95239.0 99981.5 87172.6 87935.0 88321.6 88660.6 89798.0 72928.6 75447.2 75856.2 75866.0 77532.8 10805.9 11016.4 11401.3 12288.5 12302.9 34713.5 34817.0 35575.9 35854.5 36256.8 60052.7 61678.0 62696.4 63263.0 66179.3 16341.8 16356.3 16370.3 16495.8 18621.9 19559.2 20136.3 20258.7 20420.5 20506.9 17154.0 18302.6 18388.2 19021.0 20325.7 16248.0 16967.9 16987.4 17008.1 17120.9 17618.5 18983.6 19200.0 19395.8 19444.0 13713.8 13862.7 13889.7 14065.4 14148.2 14330.5 14445.1 14486.7 14536.1 14730.3 18:48:30 INFO - PID 3584 | -------- Summary: end -------- 18:48:30 INFO - PID 3584 | 18:48:30 INFO - TEST-INFO | 3584: exit 0 18:48:30 INFO - TEST-OK | dromaeo_css | took 1115792ms 18:48:30 INFO - TEST-START | kraken 18:48:30 INFO - Initialising browser for kraken test... 18:48:30 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41239/getInfo.html -profile /tmp/tmp9sOFeT/profile 18:48:30 INFO - TEST-INFO | started process 3998 (/builds/slave/test/build/application/firefox/firefox http://localhost:41239/getInfo.html) 18:48:37 INFO - TEST-INFO | 3998: exit 0 18:48:37 INFO - Browser initialized. 18:48:37 INFO - Running cycle 1/1 for kraken test... 18:48:37 INFO - TEST-INFO | started process 4217 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9sOFeT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:48:48 INFO - PID 4217 | RSS: Main: 172482560 18:48:48 INFO - PID 4217 | 18:48:51 INFO - PID 4217 | Cycle 1(1): loaded http://localhost:41239/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41239/tests/kraken/driver.html?testName=audio-beat-detection) 18:48:52 INFO - PID 4217 | RSS: Main: 176271360 18:48:52 INFO - PID 4217 | 18:48:54 INFO - PID 4217 | Cycle 1(1): loaded http://localhost:41239/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41239/tests/kraken/driver.html?testName=audio-dft) 18:48:55 INFO - PID 4217 | RSS: Main: 176914432 18:48:55 INFO - PID 4217 | 18:48:58 INFO - PID 4217 | Cycle 1(1): loaded http://localhost:41239/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41239/tests/kraken/driver.html?testName=audio-fft) 18:48:58 INFO - PID 4217 | RSS: Main: 172142592 18:48:58 INFO - PID 4217 | 18:49:01 INFO - PID 4217 | Cycle 1(1): loaded http://localhost:41239/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41239/tests/kraken/driver.html?testName=audio-oscillator) 18:49:01 INFO - PID 4217 | RSS: Main: 173047808 18:49:01 INFO - PID 4217 | 18:49:03 INFO - PID 4217 | Cycle 1(1): loaded http://localhost:41239/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41239/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:49:04 INFO - PID 4217 | RSS: Main: 172785664 18:49:04 INFO - PID 4217 | 18:49:07 INFO - PID 4217 | Cycle 1(1): loaded http://localhost:41239/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41239/tests/kraken/driver.html?testName=imaging-darkroom) 18:49:08 INFO - PID 4217 | RSS: Main: 176422912 18:49:08 INFO - PID 4217 | 18:49:11 INFO - PID 4217 | Cycle 1(1): loaded http://localhost:41239/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41239/tests/kraken/driver.html?testName=imaging-desaturate) 18:49:12 INFO - PID 4217 | RSS: Main: 177762304 18:49:12 INFO - PID 4217 | 18:49:14 INFO - PID 4217 | Cycle 1(1): loaded http://localhost:41239/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41239/tests/kraken/driver.html?testName=json-parse-financial) 18:49:15 INFO - PID 4217 | RSS: Main: 177025024 18:49:15 INFO - PID 4217 | 18:49:17 INFO - PID 4217 | Cycle 1(1): loaded http://localhost:41239/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41239/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:49:17 INFO - PID 4217 | RSS: Main: 176427008 18:49:17 INFO - PID 4217 | 18:49:19 INFO - PID 4217 | Cycle 1(1): loaded http://localhost:41239/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41239/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:49:20 INFO - PID 4217 | RSS: Main: 176488448 18:49:20 INFO - PID 4217 | 18:49:22 INFO - PID 4217 | Cycle 1(1): loaded http://localhost:41239/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41239/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:49:22 INFO - PID 4217 | RSS: Main: 176582656 18:49:22 INFO - PID 4217 | 18:49:25 INFO - PID 4217 | Cycle 1(1): loaded http://localhost:41239/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:49:26 INFO - PID 4217 | RSS: Main: 176689152 18:49:26 INFO - PID 4217 | 18:49:29 INFO - PID 4217 | Cycle 1(1): loaded http://localhost:41239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:49:29 INFO - PID 4217 | RSS: Main: 176611328 18:49:29 INFO - PID 4217 | 18:49:31 INFO - PID 4217 | Cycle 1(1): loaded http://localhost:41239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41239/tests/kraken/driver.html?testName=ai-astar) 18:49:31 INFO - PID 4217 | RSS: Main: 178421760 18:49:31 INFO - PID 4217 | 18:49:31 INFO - PID 4217 | __start_tp_report 18:49:31 INFO - PID 4217 | _x_x_mozilla_page_load 18:49:31 INFO - PID 4217 | _x_x_mozilla_page_load_details 18:49:31 INFO - PID 4217 | |i|pagename|runs| 18:49:31 INFO - PID 4217 | |0;ai-astar;100;108;110;108;109;109;111;107;108;111 18:49:31 INFO - PID 4217 | |1;audio-beat-detection;154;122;151;179;122;145;152;123;174;124 18:49:31 INFO - PID 4217 | |2;audio-dft;167;167;163;164;163;169;164;163;163;164 18:49:31 INFO - PID 4217 | |3;audio-fft;77;75;75;163;75;76;76;76;92;74 18:49:31 INFO - PID 4217 | |4;audio-oscillator;82;83;136;81;81;82;133;81;81;132 18:49:31 INFO - PID 4217 | |5;imaging-gaussian-blur;114;114;114;114;115;114;114;114;113;115 18:49:31 INFO - PID 4217 | |6;imaging-darkroom;150;150;150;150;150;152;149;150;149;149 18:49:31 INFO - PID 4217 | |7;imaging-desaturate;94;94;94;94;94;94;94;95;94;94 18:49:31 INFO - PID 4217 | |8;json-parse-financial;55;57;56;55;55;54;55;56;60;55 18:49:31 INFO - PID 4217 | |9;json-stringify-tinderbox;55;54;54;55;55;54;55;55;54;54 18:49:31 INFO - PID 4217 | |10;stanford-crypto-aes;79;78;77;77;77;87;77;77;76;75 18:49:31 INFO - PID 4217 | |11;stanford-crypto-ccm;129;132;130;139;135;127;126;127;127;148 18:49:31 INFO - PID 4217 | |12;stanford-crypto-pbkdf2;186;195;183;184;188;186;187;181;189;186 18:49:31 INFO - PID 4217 | |13;stanford-crypto-sha256-iterative;74;70;69;68;79;69;70;69;67;71 18:49:31 INFO - PID 4217 | __end_tp_report 18:49:31 INFO - PID 4217 | __start_cc_report 18:49:31 INFO - PID 4217 | _x_x_mozilla_cycle_collect,928 18:49:31 INFO - PID 4217 | __end_cc_report 18:49:31 INFO - PID 4217 | __startTimestamp1498960171904__endTimestamp 18:49:31 INFO - PID 4217 | 18:49:31 INFO - PID 4217 | ------- Summary: start ------- 18:49:31 INFO - PID 4217 | Number of tests: 14 18:49:31 INFO - PID 4217 | 18:49:31 INFO - PID 4217 | [#0] ai-astar Cycles:10 Average:108.10 Median:109.00 stddev:3.14 (2.9%) stddev-sans-first:1.41 18:49:31 INFO - PID 4217 | Values: 100.0 108.0 110.0 108.0 109.0 109.0 111.0 107.0 108.0 111.0 18:49:31 INFO - PID 4217 | 18:49:31 INFO - PID 4217 | [#1] audio-beat-detection Cycles:10 Average:144.60 Median:151.50 stddev:21.46 (14.2%) stddev-sans-first:22.49 18:49:31 INFO - PID 4217 | Values: 154.0 122.0 151.0 179.0 122.0 145.0 152.0 123.0 174.0 124.0 18:49:31 INFO - PID 4217 | 18:49:31 INFO - PID 4217 | [#2] audio-dft Cycles:10 Average:164.70 Median:164.00 stddev:2.16 (1.3%) stddev-sans-first:2.13 18:49:31 INFO - PID 4217 | Values: 167.0 167.0 163.0 164.0 163.0 169.0 164.0 163.0 163.0 164.0 18:49:31 INFO - PID 4217 | 18:49:31 INFO - PID 4217 | [#3] audio-fft Cycles:10 Average:85.90 Median:76.00 stddev:27.59 (36.3%) stddev-sans-first:29.08 18:49:31 INFO - PID 4217 | Values: 77.0 75.0 75.0 163.0 75.0 76.0 76.0 76.0 92.0 74.0 18:49:31 INFO - PID 4217 | 18:49:31 INFO - PID 4217 | [#4] audio-oscillator Cycles:10 Average:97.20 Median:81.00 stddev:25.19 (31.1%) stddev-sans-first:26.11 18:49:31 INFO - PID 4217 | Values: 82.0 83.0 136.0 81.0 81.0 82.0 133.0 81.0 81.0 132.0 18:49:31 INFO - PID 4217 | 18:49:31 INFO - PID 4217 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 18:49:31 INFO - PID 4217 | Values: 114.0 114.0 114.0 114.0 115.0 114.0 114.0 114.0 113.0 115.0 18:49:31 INFO - PID 4217 | 18:49:31 INFO - PID 4217 | [#6] imaging-darkroom Cycles:10 Average:149.90 Median:150.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 18:49:31 INFO - PID 4217 | Values: 150.0 150.0 150.0 150.0 150.0 152.0 149.0 150.0 149.0 149.0 18:49:31 INFO - PID 4217 | 18:49:31 INFO - PID 4217 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 18:49:31 INFO - PID 4217 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 94.0 18:49:31 INFO - PID 4217 | 18:49:31 INFO - PID 4217 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:55.50 stddev:1.69 (3.0%) stddev-sans-first:1.76 18:49:31 INFO - PID 4217 | Values: 55.0 57.0 56.0 55.0 55.0 54.0 55.0 56.0 60.0 55.0 18:49:31 INFO - PID 4217 | 18:49:31 INFO - PID 4217 | [#9] json-stringify-tinderbox Cycles:10 Average:54.50 Median:55.00 stddev:0.53 (1.0%) stddev-sans-first:0.53 18:49:31 INFO - PID 4217 | Values: 55.0 54.0 54.0 55.0 55.0 54.0 55.0 55.0 54.0 54.0 18:49:31 INFO - PID 4217 | 18:49:31 INFO - PID 4217 | [#10] stanford-crypto-aes Cycles:10 Average:78.00 Median:77.00 stddev:3.33 (4.3%) stddev-sans-first:3.52 18:49:31 INFO - PID 4217 | Values: 79.0 78.0 77.0 77.0 77.0 87.0 77.0 77.0 76.0 75.0 18:49:31 INFO - PID 4217 | 18:49:31 INFO - PID 4217 | [#11] stanford-crypto-ccm Cycles:10 Average:132.00 Median:131.00 stddev:6.98 (5.3%) stddev-sans-first:7.31 18:49:31 INFO - PID 4217 | Values: 129.0 132.0 130.0 139.0 135.0 127.0 126.0 127.0 127.0 148.0 18:49:31 INFO - PID 4217 | 18:49:31 INFO - PID 4217 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.50 Median:186.50 stddev:3.81 (2.0%) stddev-sans-first:4.03 18:49:31 INFO - PID 4217 | Values: 186.0 195.0 183.0 184.0 188.0 186.0 187.0 181.0 189.0 186.0 18:49:31 INFO - PID 4217 | 18:49:31 INFO - PID 4217 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:70.00 stddev:3.50 (5.0%) stddev-sans-first:3.49 18:49:31 INFO - PID 4217 | Values: 74.0 70.0 69.0 68.0 79.0 69.0 70.0 69.0 67.0 71.0 18:49:31 INFO - PID 4217 | -------- Summary: end -------- 18:49:31 INFO - PID 4217 | 18:49:32 INFO - TEST-INFO | 4217: exit 0 18:49:32 INFO - TEST-OK | kraken | took 61765ms 18:49:32 INFO - SUITE-END | took 1177s 18:49:33 INFO - Completed test suite (00:19:37) 18:49:33 INFO - javascript benchmark 18:49:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8266.63482767962, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3100.503919372898, 3150.4329220740265, 3155.6213254409467, 3164.0507847645713, 3202.1514298710845, 6070.2412198475195, 6078.483328917042, 6089.604175728575, 6096.786612468564, 6144.016957286835, 6039.698015099239, 6065.0, 6093.055576385656, 6101.389861013897, 6126.693665316739, 5546.140348246028, 5570.275864137657, 5593.468620481048, 5631.352394474647, 5663.122216056498, 5703.230063941377, 5714.799982000631, 5743.339515955677, 5743.5405167586705, 5747.3677895431465, 5687.630304030225, 5699.059655156894, 5703.859228154365, 5713.342965558952, 5718.6568805871575, 5709.0580054290995, 5719.256496655429, 5731.369549349568, 5731.484166425042, 5738.885222295572, 5626.774929002835, 5643.830685079454, 5653.038983372795, 5699.74351154199, 5742.454466825645, 6194.039923811816, 6194.163787888622, 6209.627422354628, 6282.591631543935, 6316.810495685137, 6366.427021568081, 6608.173978252718, 6634.270230274666, 6667.799966001027, 6677.76627818024, 6627.93372066278, 6652.168478940132, 6660.9000864987065, 6664.400203981665, 6673.0991316172185, 6111.297200821918, 6113.786017489411, 6135.447809697193, 6138.048602466625, 6168.1056246843955, 5219.895602087937, 6646.734130634817, 6655.567388119854, 6664.7000884959325, 6744.0, 6270.9372906271265, 6315.652639104802, 6339.904901426482, 6414.454771344394, 6427.646479443675, 6406.199225096863, 6421.8073457796345, 6516.478681705452, 6517.348265173445, 6521.934780652227, 6298.71655775482, 6472.741090356333, 6478.740850365933, 6480.902786458207, 6488.448481878999, 6543.705533251015, 6591.802245932629, 6616.536842420985, 6617.569857959217, 6688.030235615905, 5227.764750586232, 5297.814576489882, 5341.599380046512, 5363.517283444508, 5378.300820893259, 4495.797689103998, 4528.547145285445, 4533.84131555394, 4545.749983750859, 4550.613197878151, 5673.319201695823, 5686.459786320293, 5701.543876489871, 5712.314522257273, 5720.885582288331, 6586.637734924625, 6603.537752357385, 6611.0, 6621.172353455818, 6623.536352455379, 5593.356763972114, 5685.232493613309, 5711.200431939532, 5711.828645140652, 5711.828645140652, 5620.747066382022, 5635.3237611486065, 5644.096944488862, 5652.18043383707, 5669.433056694297, 5242.0, 6309.463695585835, 6319.462845658079, 6373.075903993895, 6423.164988551458, 6552.737890484327, 6558.147440832661, 6639.800805975829, 6651.933480665131, 6669.333066693292, 6282.780102696383, 6320.115183874169, 6383.904241436289, 6412.583182093149, 6429.260635027032, 6351.523635727432, 6385.233771947396, 6432.485401167989, 6450.225972883284, 6463.57986730861, 5032.295478633067, 6578.243501997332, 6649.667516624246, 6659.4006539411685, 6693.631850248088, 6355.269144048493, 6359.841003974752, 6426.775062872777, 6427.068075129174, 6457.192850893638, 6386.233651961795, 6413.743450261937, 6482.967585162044, 6500.992346186349, 6512.967435162794, 6243.562950593415, 6296.842578935563, 6312.7159277833525, 6335.714892829926, 6375.362463753588, 6378.075179098912, 6459.903101453576, 6460.966245400713, 6466.676666166767, 6471.320511346241, 6148.907766383419, 6170.784022559189, 6215.409536094064, 6231.657258850625, 6318.747250109944], "value": 5975.849438948624, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [827.8468483330585, 846.8137009857829, 858.5707146426787, 884.9424787388823, 885.2165833237585, 38660.0, 39924.40113398294, 39987.80006099969, 40209.79895100521, 40357.991050223725, 36080.45879311812, 36253.09367265819, 36312.81843590785, 36537.53849846003, 36540.0, 6704.22901366343, 6871.450283977295, 6894.103766510347, 6915.204751453572, 6930.44556435484, 6763.763268285611, 6847.965760171192, 6863.828404289883, 6869.656517174146, 6873.106496155518, 6770.1875774907085, 6812.863742725142, 6820.556663816836, 6836.384725374715, 6850.691718872663, 6796.0, 6818.931810681929, 6833.214180369222, 6833.9316606834045, 6863.622500762481, 6214.471769899564, 6233.937660623426, 6273.12176295319, 6282.591631543981, 6285.0, 32446.188845278823, 32682.836585817156, 32778.344433111444, 32787.83606081978, 32830.671693283, 3374.4263475209273, 3406.369821583015, 3421.5209870618132, 3428.6228514863346, 3430.691237788586, 28576.428471430663, 30786.692133078832, 30794.076177714705, 30892.227694307596, 31012.844935775403, 4662.463816661059, 4798.23228283473, 4818.903621927577, 4928.137575924199, 4946.851594452172, 182535.08732456385, 185102.0, 186496.99999999863, 194386.0, 195936.0, 47440.28839567409, 47769.28346074812, 47900.28149577759, 48076.75961620169, 48204.0, 50445.49554504408, 50515.49484505108, 50536.0, 50636.240456393185, 50684.74657626688, 15854.60363490922, 15976.680466390608, 16001.759973600405, 16011.839881601269, 16080.678386432206, 13320.267385293902, 13373.799393009112, 13379.598612041655, 13401.731965360637, 13403.262820544769, 14008.879289656803, 14118.152910825384, 14188.929055354658, 14246.358913848902, 14310.427582896567, 5586.441355864381, 5785.71071446426, 5807.216025836543, 5862.12068189775, 5902.144189092557, 965.8309795785709, 978.2995375311215, 978.814025335184, 1015.8831734350497, 1017.3743147963949, 22576.774232257467, 22671.9797609108, 22674.206402775824, 22957.88521057384, 23020.65469017966, 1059.2955684469741, 1078.8489611454402, 1080.5515710979855, 1101.4217535793773, 1101.9724506887392, 15320.693586128438, 15938.28277727505, 15983.840161598235, 16098.597535061717, 16323.836761632469, 223311.0, 226994.0, 227164.0, 227365.0, 227406.0, 55698.0, 56057.0, 56156.157657635165, 56162.7191864038, 56248.71875640596, 1380.8895288376905, 1448.4857875454272, 1450.6881020580627, 1457.7230326237982, 1467.39103272143, 25697.229083127535, 26997.595036074083, 27012.72987270102, 27280.454390912466, 27416.451670966868, 37468.25063498769, 37603.623963760016, 37632.0, 37640.43539346857, 37661.81169094137, 200073.0, 201121.0, 202375.0, 202933.0, 203399.0, 31791.523127153574, 32732.345353093282, 32924.859884107456, 33048.173795655304, 33113.0, 39755.80122099371, 39921.80039099902, 42716.572834272505, 42816.0, 42901.141977159656, 30654.540181896842, 31442.056738297888, 31547.684523154476, 31930.201744955633, 32009.0, 30227.395452091274, 31110.68889311078, 31272.687273126976, 31586.368272634878, 31615.683843161274, 34065.0, 34088.48867267043, 34147.31705365929, 36994.630053700195, 37901.431478527295, 32186.517202241517, 32490.02529924106, 33147.0, 33321.83339083289, 34062.48906266457, 23886.88056559706, 24312.635310470003, 24634.0, 25052.0, 25175.87412062928], "value": 16790.211286586924, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.9241402410673, 564.7486868343586, 565.6606036378172, 566.3373852592468, 585.7071464267866, 21419.571608567818, 22201.2229571965, 22232.999515021842, 22279.220227292048, 22324.107035718593, 23635.818209089564, 25846.612300815505, 25972.48055038898, 25989.0, 26242.737572624315, 6340.873182536358, 6528.281888992207, 6547.247066587332, 6560.311167327433, 6578.473722102244, 6449.451796597295, 6454.386833250857, 6464.93535064648, 6487.286398496161, 6514.706838192293, 5870.823875283749, 6372.936270637304, 6445.8710825783455, 6455.031745238205, 6461.224653041641, 6377.170967774183, 6432.678366081701, 6439.742410303582, 6448.613083215022, 6472.482201423874, 5950.9702451487465, 5983.670898100603, 5989.970050149721, 6019.789307374221, 6022.277326720778, 27013.459730805273, 28057.579136312972, 28408.0, 28638.570421443696, 28653.426931461254, 1931.3723040012053, 1982.0486166639948, 1994.5113447205526, 1995.7804641489424, 1997.121266642687, 17147.74278385825, 17580.824191758045, 17622.471325860246, 17626.206820692973, 17674.823251767575, 2282.657601359793, 2308.1575225042907, 2359.799417049536, 2362.83460157789, 2365.9408514787096, 118630.4068479652, 121555.0, 121687.0, 121852.39073804574, 123215.3839230807, 14004.649883752987, 14594.41622335116, 14706.55880323592, 14722.337494812758, 15218.467353642569, 23129.653055204184, 23133.884330578578, 23189.3043208704, 23226.767732322798, 23251.88374058119, 9277.67528136512, 9430.3398762086, 9471.100245476806, 9502.239820814319, 9537.523123843781, 8422.747317580483, 8434.62044208012, 8440.62017209227, 8512.40371686629, 8628.35287353451, 8923.687670931486, 8981.191692747683, 9013.098690130935, 9114.13415725505, 9143.908560914439, 2665.7334266573575, 2676.531606968773, 2686.9731302687114, 2708.5530887403356, 2870.478646317455, 961.7980224153006, 973.6105557776805, 983.6557204978201, 1002.9398236105857, 1008.5411137932223, 19384.2246310146, 19644.410667679993, 19838.50403739918, 19901.800981990284, 20236.279916207288, 1000.7190795781412, 1020.8315627921459, 1048.5962904281753, 1059.1103473082649, 1079.8110330692098, 10908.23642345044, 10946.452677366258, 12450.377481125908, 13323.13399629021, 13523.120997135155, 514090.0, 526509.0, 537523.0, 551107.0, 556279.0, 104385.47807260916, 106160.0, 109286.0, 113344.0, 113906.99999999834, 1249.4939549482474, 1261.4610175585772, 1326.1048792065317, 1331.2744554217975, 1332.0342751505275, 19365.709514357015, 20034.599308013465, 20196.79803201949, 20216.19135234574, 20264.898675506527, 50078.49921500738, 50213.24680129874, 51032.74483627558, 52418.21372679489, 52441.47558524366, 61653.691731541054, 65431.0, 65646.67176664087, 65800.0, 66393.0, 12564.183328083645, 12673.746525069262, 12769.489220431078, 12831.486740530274, 12874.098813082994, 14538.200398978157, 16335.836641633432, 17784.822151778317, 17915.641687165924, 18009.819901800813, 14991.325390357679, 15123.16822574725, 15199.544013679608, 15280.617984550476, 15470.530299621518, 14242.0, 14333.140011599337, 14430.639234019234, 14603.123812571279, 15117.244137793286, 16038.0, 16156.838431615533, 16234.675306493567, 16299.674006520041, 16367.42714005004, 12552.309622970824, 12576.245425274512, 12639.87360126387, 12688.302143382203, 12689.619311420673, 15680.215989200266, 15723.292451839923, 15803.920980395025, 15824.841751582337, 16042.518724438285], "value": 11423.230905316974, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1346.4479563379014, 1411.477753231304, 1416.334322868253, 1419.687668712883, 1426.693260948896, 13438.126521776077, 14016.78974815376, 14063.859361406383, 14065.085769424993, 14101.57695269141, 13494.662633434145, 14165.150090994523, 14493.63765905853, 14543.12741235524, 14652.4871629493, 2660.9600855987173, 2705.2154875086203, 2719.456108778242, 2725.7819374450096, 2735.8358498490156, 2571.3186005708503, 2631.3290111021756, 2637.301115204463, 2659.6143559183906, 2663.853488058156, 2478.0, 2490.9377265568323, 2515.5094756522485, 2542.1356738708837, 2543.631173479844, 2626.7635912767846, 2708.4583083383204, 2722.754952054325, 2723.9319017024536, 2724.2372135802007, 2563.6923569171818, 2610.386559158615, 2618.5417551928335, 2618.764311212, 2621.0, 14007.64980875476, 14136.363863626162, 14138.646533836634, 14195.148291102567, 14210.360533775902, 7314.96342518284, 7631.084269887593, 7649.04386951631, 7655.693772249159, 7686.730964416274, 4836.830710925101, 4872.293517439987, 5108.0, 5135.35808023997, 5153.201253805666, 1797.8202179782047, 1828.6708392489347, 1828.9908550457296, 1905.560463363628, 1910.5128192310872, 22404.887975560017, 22462.101515939343, 22466.77533224663, 22495.66256506154, 22547.549049019093, 6287.2769631492965, 6294.622322660655, 6431.0, 6533.705983230766, 6563.376479234561, 15595.220238988006, 15694.68610627781, 15710.450134245246, 15711.921440392953, 15745.606359841096, 7297.270272972766, 7495.287947644965, 7498.512596681198, 7498.925010749932, 7508.324250817453, 6751.729930802713, 6925.168979722465, 6970.477214208955, 6979.616121113286, 7077.3984211341585, 4962.503749625081, 4989.950100498949, 5010.5240002199735, 5129.820141367506, 5215.895682086337, 1408.7816388459805, 1411.7670584353673, 1419.1201455097905, 1421.992890035564, 1438.2592964623227, 873.1617647058767, 874.2961915657829, 897.6185121323412, 905.298393744853, 922.1700469577299, 7125.323094306136, 7184.533005354635, 7184.928150718531, 7202.387797037206, 7284.70861165558, 705.8694141583824, 728.1989811207629, 971.6356366362614, 1008.1481148429565, 1016.9745756356002, 4789.808407663724, 5081.983603279285, 5120.078385890501, 5228.503292187236, 5405.324334458192, 17420.30318787234, 18308.084595770157, 18623.720644190347, 18791.34230301933, 18821.52946176329, 18029.639407211784, 18437.1703273353, 18970.71543926842, 18971.14629841633, 18975.43073707791, 10262.230332725076, 10573.4713264338, 10598.311109777995, 10630.840537391945, 10669.039786419415, 7480.177180510248, 8148.1037085919315, 8166.346692264723, 8256.463329883538, 8339.53760287013, 15469.381224750883, 15754.842451575338, 15777.763333549776, 16050.678986419973, 16132.112733799753, 15502.258603908618, 15921.363145474515, 16222.78329125344, 16703.83296167023, 16785.0, 11400.600978965696, 11661.533538658698, 11661.941690291495, 11676.88323116758, 11717.707057323634, 13011.869881301065, 13406.798898016343, 13418.0, 13443.529476468277, 13494.865051349361, 10844.945775271073, 11068.612598559012, 11122.277051991594, 11144.554217831195, 11559.30644161353, 10653.307535010199, 11022.393768342497, 11050.778984420105, 11288.604898828502, 11339.0, 9110.817783644423, 9344.0, 9352.485613291063, 9439.292053096182, 9500.572474238814, 6334.968325158345, 6507.446867016357, 6854.417374523221, 6987.755428559976, 7024.26245244242, 6923.342282483156, 7035.964820175866, 7045.26024767392, 7085.716571337089, 7096.609686467294], "value": 6287.584608858881, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [487.3480620747649, 501.6372883717688, 518.5644058990447, 521.4003895520151, 523.4111624422525, 6029.7286622102, 6088.726007329681, 6110.541709371792, 6149.508039356852, 6207.875842483148, 5745.0, 5918.7632494700265, 5970.313413957396, 6019.699015049252, 6027.758889644409, 4912.164931961575, 4912.410510738717, 4918.409790825106, 4928.950710492894, 4956.132676781567, 4916.3608730864935, 4939.814444533304, 4949.925751113737, 4974.303597496335, 4989.600831933437, 4647.256438969765, 4834.685745426554, 4868.318435419044, 4889.071076495455, 4924.827631032915, 4826.1312963666705, 4838.250071238928, 4866.270059491069, 4867.269909513566, 4889.779959901813, 4361.6074553290355, 4402.449693788277, 4406.933895991563, 4414.955850441486, 4445.26653102241, 5889.734961926681, 5899.115132730082, 5911.852203694899, 5918.260217472816, 5952.58331916766, 5527.640703354269, 5555.527780138693, 5567.554595632339, 5612.971935140339, 5618.757837832411, 6431.903521447182, 6438.903416448757, 6484.351564843525, 6501.577397469149, 6517.869642607168, 4850.248211527219, 4850.684705494132, 4873.512648735134, 4882.145624515695, 4887.0, 6757.70238119037, 6775.525713200078, 6825.726970921157, 6868.347506986828, 6872.793816185523, 4921.630877684188, 4925.0, 4930.580900623416, 4930.605551555867, 4944.653874228769, 4950.579200767975, 4963.429205641398, 4983.526564976321, 4985.825496107619, 5012.724300163453, 5556.693972001574, 5561.416051314634, 5599.524040456607, 5610.186522954149, 5614.820887613647, 6423.389777971085, 6469.805905822833, 6479.153441269215, 6531.608103513804, 6543.905950096018, 1719.733441316598, 1775.9644807104044, 1776.7956684981134, 1782.616737401465, 1787.1600347836495, 1117.7261570915016, 1124.7019539821954, 1215.866254711981, 1223.6818427208989, 1230.267990545624, 5467.343918729778, 5473.726313684379, 5498.890022199534, 5546.750396232179, 5690.345610254791, 6523.315051919575, 6569.80290591283, 6580.407763301326, 6587.703553340111, 6639.43564796988, 5634.915476267859, 5635.69003704792, 5692.601517893708, 5704.89083449521, 5711.143328500675, 3452.654734526527, 3502.7022703070525, 3509.666581674737, 3545.3441113394106, 3563.55455568054, 6270.617165477181, 6422.165118534561, 6447.451966582799, 6478.805635830932, 6492.642904640195, 6679.165104361955, 6706.396424321834, 6724.193096828314, 6761.4590832733265, 6806.8298292542095, 6340.207474065742, 6365.427111559982, 6382.170317858649, 6431.324710905287, 6450.2259728831905, 6520.510961677798, 6547.345265473415, 6549.24683661385, 6581.407673309425, 6604.570702904296, 6557.475401967736, 6572.638504882278, 6595.274519802914, 6629.7348106075215, 6668.266490685924, 6431.874421976229, 6433.420992110732, 6450.967745161244, 6464.870702586016, 6468.0, 4893.266010098514, 4940.827071052496, 4965.975170124127, 4984.252362145708, 4989.401271847401, 6684.799456016327, 6685.565438246498, 6710.228323742832, 6753.86492270142, 6756.29058948823, 6348.873022539616, 6377.660691254889, 6400.263969643551, 6453.580517266362, 6457.0, 6372.267189273293, 6438.871222575616, 6447.161868957006, 6466.902996455151, 6481.189851268591, 6298.08677741734, 6368.5860419072615, 6406.13517175194, 6406.423421892052, 6444.420002199825, 6442.324995501297, 6509.967450162909, 6576.572522786004, 6591.604503729792, 6593.901091483727, 5949.940500595112, 6065.3934606539, 6209.0, 6215.440610345091, 6236.937630623817], "value": 4976.036722304459, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [911.1253196930942, 922.1055576091189, 925.3846192282133, 937.6671281694998, 950.8145911547247, 18648.347307844244, 18748.718769218456, 18995.0, 19012.0, 19099.140538675758, 17421.651566968652, 19757.802421975775, 19777.505562360948, 19821.108050137744, 20142.093605787737, 1003.1642094966231, 1038.9896101039005, 1042.0152955457097, 1042.9113525350317, 1044.2377064742743, 1074.2211896375104, 1076.252004856625, 1076.5532304093792, 1076.6608518316743, 1077.348204336377, 792.2117493094379, 1116.4752566293828, 1119.9608013719521, 1128.661401579527, 1132.9037031852301, 810.2140923304415, 973.6008236622986, 1101.9559217631286, 1105.8230683090667, 1108.4346983038627, 803.8271771569141, 805.0862271322034, 806.5967016491754, 807.8142027333687, 808.3775492870516, 18587.44237672872, 19404.320848770367, 19516.70724939127, 19704.605907881763, 19777.604447911104, 20380.0, 20444.080016399297, 20660.79339206619, 20761.377158685264, 20876.686849697267, 15471.5358539244, 15662.530124096294, 15900.363985440568, 15957.84042159575, 16066.196690165561, 3545.911352216215, 3561.786292822413, 3561.9109522261892, 3564.6791788739138, 3569.5716514018486, 101835.99999999926, 103089.0, 106570.0, 106720.46639766752, 112186.0, 16050.197490125447, 16185.0, 16620.085895275875, 16639.084850333347, 16653.250603722863, 27208.863955680492, 28375.432491350057, 28934.131976040753, 28945.276368090967, 29110.563341549892, 8865.556722163867, 8947.552622368985, 8978.371513993958, 9002.189802917768, 9007.324450666227, 4043.757374557536, 4072.735272207297, 4093.692973027035, 4097.569755175723, 4202.768847713344, 4988.6009119270375, 5099.923501147486, 5103.209002604528, 5116.872078198, 5145.048166089286, 1024.073213741565, 1032.667858462575, 1062.7343164208949, 1068.604616291977, 1070.1920050362082, 648.2318452633644, 660.8050625065617, 669.3674477618702, 686.5674624986227, 690.8998195261659, 11254.43727813606, 11309.60416385439, 11845.940770296265, 13452.798208026887, 13769.449222031208, 675.3078094952713, 693.7779910428615, 709.2198581560242, 712.7826013065961, 720.3228964773097, 5218.530332270114, 5227.843164705065, 5240.3973543042275, 5468.972655136698, 5504.80733174337, 88828.5558572203, 92228.0, 94709.0, 95239.0, 99981.50009249907, 87172.56413718018, 87935.0, 88321.55839220891, 88660.5566972161, 89798.0, 72928.63535682288, 75447.24552754402, 75856.24143758602, 75866.0, 77532.83700744493, 10805.891941080488, 11016.449177540931, 11401.258918170292, 12288.463942007249, 12302.938485307515, 34713.511033449024, 34817.0, 35575.93272201734, 35854.46218306779, 36256.818715907306, 60052.699736502786, 61678.0, 62696.37303627088, 63263.0, 66179.33820661924, 16341.754873677142, 16356.345746170497, 16370.263338150051, 16495.83504164943, 18621.90689046546, 19559.21763129516, 20136.295229666892, 20258.696119557924, 20420.489487762923, 20506.89746551258, 17154.0, 18302.633947321247, 18388.172532235814, 19021.04894755229, 20325.695114573587, 16248.0, 16967.91516042412, 16987.40544080951, 17008.149592520076, 17120.914395427943, 17618.471445856645, 18983.620327593646, 19200.0, 19395.8060419394, 19444.0, 13713.794293085812, 13862.65343366424, 13889.652758681113, 14065.367058482598, 14148.22184779847, 14330.49843255481, 14445.133292002514, 14486.710265794836, 14536.127832330094, 14730.26348682583], "value": 8898.849203867745, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1536.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 108.0, 110.0, 108.0, 109.0, 109.0, 111.0, 107.0, 108.0, 111.0], "value": 108.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 122.0, 151.0, 179.0, 122.0, 145.0, 152.0, 123.0, 174.0, 124.0], "value": 144.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 167.0, 163.0, 164.0, 163.0, 169.0, 164.0, 163.0, 163.0, 164.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 163.0, 75.0, 76.0, 76.0, 76.0, 92.0, 74.0], "value": 85.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 136.0, 81.0, 81.0, 82.0, 133.0, 81.0, 81.0, 132.0], "value": 97.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 115.0, 114.0, 114.0, 114.0, 113.0, 115.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 150.0, 150.0, 150.0, 152.0, 149.0, 150.0, 149.0, 149.0], "value": 149.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 56.0, 55.0, 55.0, 54.0, 55.0, 56.0, 60.0, 55.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 55.0, 55.0, 54.0, 55.0, 55.0, 54.0, 54.0], "value": 54.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 77.0, 77.0, 77.0, 87.0, 77.0, 77.0, 76.0, 75.0], "value": 78.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 132.0, 130.0, 139.0, 135.0, 127.0, 126.0, 127.0, 127.0, 148.0], "value": 132.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 195.0, 183.0, 184.0, 188.0, 186.0, 187.0, 181.0, 189.0, 186.0], "value": 186.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 70.0, 69.0, 68.0, 79.0, 69.0, 70.0, 69.0, 67.0, 71.0], "value": 70.6, "unit": "score"}]}]} 18:49:33 INFO - Return code: 0 18:49:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:49:33 INFO - # TBPL SUCCESS # 18:49:33 INFO - Running post-action listener: _package_coverage_data 18:49:33 INFO - Running post-action listener: _resource_record_post_action 18:49:33 INFO - [mozharness: 2017-07-02 01:49:33.202197Z] Finished run-tests step (success) 18:49:33 INFO - Running post-run listener: _resource_record_post_run 18:49:33 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 5636096; Write bytes: 447045632; Read time: 2232; Write time: 490484 18:49:33 INFO - TinderboxPrint: CPU usage
13.1% 18:49:33 INFO - TinderboxPrint: I/O read bytes / time
5,636,096 / 2,232 18:49:33 INFO - TinderboxPrint: I/O write bytes / time
447,045,632 / 490,484 18:49:33 INFO - TinderboxPrint: CPU idle
8,282.8 (86.8%) 18:49:33 INFO - TinderboxPrint: CPU user
1,201.4 (12.6%) 18:49:33 INFO - TinderboxPrint: Swap in / out
0 / 0 18:49:33 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 116658176; Read time: 84; Write time: 121636 18:49:33 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:49:33 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 3264512; Write bytes: 330387456; Read time: 1472; Write time: 368848 18:49:33 INFO - Running post-run listener: _upload_blobber_files 18:49:33 INFO - Blob upload gear active. 18:49:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:49:33 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 18:49:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:49:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:49:34 INFO - (blobuploader) - INFO - Open directory for files ... 18:49:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:49:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:49:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:49:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:49:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:49:35 INFO - (blobuploader) - INFO - Done attempting. 18:49:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:49:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:49:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:49:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:49:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:49:35 INFO - (blobuploader) - INFO - Done attempting. 18:49:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:49:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:49:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:49:36 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:49:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:49:36 INFO - (blobuploader) - INFO - Done attempting. 18:49:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:49:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:49:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:49:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:49:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:49:39 INFO - (blobuploader) - INFO - Done attempting. 18:49:39 INFO - (blobuploader) - INFO - Iteration through files over. 18:49:39 INFO - Return code: 0 18:49:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:49:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:49:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32c6b10c6d2fe485d1497796e3ab29e84fbadc392f77bc8d3b89e1efac71c0f88884296d795948ae8fffc3a59245b7c04c1d72cda0c1daa0b31b40006ff3f46c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3597298892f7f7c74a4dd2696caf7dd34aafdf1b0394c41493a754d8a788fbe36fb270999399b4eab4f9f678e0368b8d3ca4032d05b4248ca665968e17843eb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2191cf952b174ef72b864857b09bc19e54505f9b8a7f1cdb5f6e0bac29da7ef79ce90174796b0f50fd71038335862f02fa4e1dfedc247c65530a3ecf8189dd53", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e61d9f99affd073b4a599ee24f0f9ba329c5ae50f75a745e72d85d677cdefe24dc9d1680d30f54406752a43e45b9b86783a1b284faf5629500b8a667259be82f"} 18:49:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:49:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:49:39 INFO - Contents: 18:49:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32c6b10c6d2fe485d1497796e3ab29e84fbadc392f77bc8d3b89e1efac71c0f88884296d795948ae8fffc3a59245b7c04c1d72cda0c1daa0b31b40006ff3f46c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3597298892f7f7c74a4dd2696caf7dd34aafdf1b0394c41493a754d8a788fbe36fb270999399b4eab4f9f678e0368b8d3ca4032d05b4248ca665968e17843eb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2191cf952b174ef72b864857b09bc19e54505f9b8a7f1cdb5f6e0bac29da7ef79ce90174796b0f50fd71038335862f02fa4e1dfedc247c65530a3ecf8189dd53", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e61d9f99affd073b4a599ee24f0f9ba329c5ae50f75a745e72d85d677cdefe24dc9d1680d30f54406752a43e45b9b86783a1b284faf5629500b8a667259be82f"} 18:49:39 INFO - Running post-run listener: copy_logs_to_upload_dir 18:49:39 INFO - Copying logs to upload dir... 18:49:39 INFO - mkdir: /builds/slave/test/build/upload/logs 18:49:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.724005 ========= master_lag: -0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-07-01 18:49:39.230552) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-01 18:49:39.237700) ========= 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=db7e7c15f3ca076d53731445000001ba-1498946375.671674-1308135519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32c6b10c6d2fe485d1497796e3ab29e84fbadc392f77bc8d3b89e1efac71c0f88884296d795948ae8fffc3a59245b7c04c1d72cda0c1daa0b31b40006ff3f46c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3597298892f7f7c74a4dd2696caf7dd34aafdf1b0394c41493a754d8a788fbe36fb270999399b4eab4f9f678e0368b8d3ca4032d05b4248ca665968e17843eb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2191cf952b174ef72b864857b09bc19e54505f9b8a7f1cdb5f6e0bac29da7ef79ce90174796b0f50fd71038335862f02fa4e1dfedc247c65530a3ecf8189dd53", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e61d9f99affd073b4a599ee24f0f9ba329c5ae50f75a745e72d85d677cdefe24dc9d1680d30f54406752a43e45b9b86783a1b284faf5629500b8a667259be82f"} build_url:https://queue.taskcluster.net/v1/task/am1KHi4NTKavzzas9GpRJQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011078 build_url: 'https://queue.taskcluster.net/v1/task/am1KHi4NTKavzzas9GpRJQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32c6b10c6d2fe485d1497796e3ab29e84fbadc392f77bc8d3b89e1efac71c0f88884296d795948ae8fffc3a59245b7c04c1d72cda0c1daa0b31b40006ff3f46c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3597298892f7f7c74a4dd2696caf7dd34aafdf1b0394c41493a754d8a788fbe36fb270999399b4eab4f9f678e0368b8d3ca4032d05b4248ca665968e17843eb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2191cf952b174ef72b864857b09bc19e54505f9b8a7f1cdb5f6e0bac29da7ef79ce90174796b0f50fd71038335862f02fa4e1dfedc247c65530a3ecf8189dd53", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e61d9f99affd073b4a599ee24f0f9ba329c5ae50f75a745e72d85d677cdefe24dc9d1680d30f54406752a43e45b9b86783a1b284faf5629500b8a667259be82f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-01 18:49:39.264091) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-01 18:49:39.264433) ========= 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=db7e7c15f3ca076d53731445000001ba-1498946375.671674-1308135519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004380 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-01 18:49:39.345092) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-01 18:49:39.348413) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-01 18:49:39.348694) ========= ========= Total master_lag: 0.08 =========