builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-072 starttime: 1496367086.98 results: success (0) revision: 877c3da58fa35bf4e58f2ac0cbcf59840702cc6e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-01 18:31:26.975414) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-01 18:31:26.976065) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-01 18:31:26.976375) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-01 18:31:27.023779) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 18:31:27.024054) ========= 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=199fb4c72b90437b990b419b000001c5-1496366785.521909-1063444403 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-01 18:31:28-- 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% 226M=0s 2017-06-01 18:31:28 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124463 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 18:31:27.171675) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 18:31:27.172143) ========= 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=199fb4c72b90437b990b419b000001c5-1496366785.521909-1063444403 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014113 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 18:31:27.222466) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 18:31:27.222816) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 877c3da58fa35bf4e58f2ac0cbcf59840702cc6e --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 877c3da58fa35bf4e58f2ac0cbcf59840702cc6e --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=199fb4c72b90437b990b419b000001c5-1496366785.521909-1063444403 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-01 18:31:28,356 truncating revision to first 12 chars 2017-06-01 18:31:28,356 Setting DEBUG logging. 2017-06-01 18:31:28,356 attempt 1/10 2017-06-01 18:31:28,356 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/877c3da58fa3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-01 18:31:28,674 unpacking tar archive at: mozilla-central-877c3da58fa3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.628532 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 18:31:27.863901) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-01 18:31:27.864268) ========= script_repo_revision: 877c3da58fa35bf4e58f2ac0cbcf59840702cc6e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-01 18:31:27.864689) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-01 18:31:27.864957) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-01 18:31:27.875202) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 2 secs) (at 2017-06-01 18:31:27.875642) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=199fb4c72b90437b990b419b000001c5-1496366785.521909-1063444403 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:31:29 INFO - MultiFileLogger online at 20170601 18:31:29 in /builds/slave/test 18:31:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 18:31:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:31:29 INFO - {'append_to_log': False, 18:31:29 INFO - 'base_work_dir': '/builds/slave/test', 18:31:29 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 18:31:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:31:29 INFO - 'branch': 'Firefox-Non-PGO', 18:31:29 INFO - 'buildbot_json_path': 'buildprops.json', 18:31:29 INFO - 'config_files': ('talos/linux_config.py',), 18:31:29 INFO - 'default_actions': ('clobber', 18:31:29 INFO - 'read-buildbot-config', 18:31:29 INFO - 'download-and-extract', 18:31:29 INFO - 'populate-webroot', 18:31:29 INFO - 'create-virtualenv', 18:31:29 INFO - 'install', 18:31:29 INFO - 'setup-mitmproxy', 18:31:29 INFO - 'run-tests'), 18:31:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:31:29 INFO - 'download_minidump_stackwalk': True, 18:31:29 INFO - 'download_symbols': 'ondemand', 18:31:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:31:29 INFO - 'tooltool.py': '/tools/tooltool.py', 18:31:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:31:29 INFO - '/tools/misc-python/virtualenv.py')}, 18:31:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:31:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:31:29 INFO - 'gecko_profile': False, 18:31:29 INFO - 'gecko_profile_interval': 0, 18:31:29 INFO - 'installer_path': 'installer.exe', 18:31:29 INFO - 'log_level': 'info', 18:31:29 INFO - 'log_name': 'talos', 18:31:29 INFO - 'log_to_console': True, 18:31:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:31:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:31:29 INFO - 'opt_config_files': (), 18:31:29 INFO - 'pip_index': False, 18:31:29 INFO - 'suite': 'dromaeojs-e10s', 18:31:29 INFO - 'system_bits': '32', 18:31:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:31:29 INFO - 'title': 'talos-linux64-ix-072', 18:31:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:31:29 INFO - 'use_talos_json': True, 18:31:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:31:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:31:29 INFO - 'work_dir': 'build'} 18:31:29 INFO - [mozharness: 2017-06-02 01:31:29.106401Z] Running clobber step. 18:31:29 INFO - Running pre-action listener: _resource_record_pre_action 18:31:29 INFO - Running main action method: clobber 18:31:29 INFO - rmtree: /builds/slave/test/build 18:31:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:31:30 INFO - Running post-action listener: _resource_record_post_action 18:31:30 INFO - [mozharness: 2017-06-02 01:31:30.647325Z] Finished clobber step (success) 18:31:30 INFO - [mozharness: 2017-06-02 01:31:30.647424Z] Running read-buildbot-config step. 18:31:30 INFO - Running pre-action listener: _resource_record_pre_action 18:31:30 INFO - Running main action method: read_buildbot_config 18:31:30 INFO - Using buildbot properties: 18:31:30 INFO - { 18:31:30 INFO - "project": "", 18:31:30 INFO - "product": "firefox", 18:31:30 INFO - "who": "ffxbld@noreply.mozilla.org", 18:31:30 INFO - "installer_path": "public/build/target.tar.bz2", 18:31:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 18:31:30 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 18:31:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 18:31:30 INFO - "stage_platform": "linux64", 18:31:30 INFO - "basedir": "/builds/slave/test", 18:31:30 INFO - "buildnumber": 924, 18:31:30 INFO - "platform": "ubuntu64_hw", 18:31:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:31:30 INFO - "slavebuilddir": "test", 18:31:30 INFO - "taskId": "SF4_jIWoRB-HeBQQlF1u-Q", 18:31:30 INFO - "branch": "mozilla-central", 18:31:30 INFO - "script_repo_revision": "production", 18:31:30 INFO - "revision": "877c3da58fa35bf4e58f2ac0cbcf59840702cc6e", 18:31:30 INFO - "slavename": "talos-linux64-ix-072", 18:31:30 INFO - "repo_path": "mozilla-central" 18:31:30 INFO - } 18:31:30 INFO - Finding installer, test and symbols from parent task. 18:31:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SF4_jIWoRB-HeBQQlF1u-Q'}, attempt #1 18:31:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SF4_jIWoRB-HeBQQlF1u-Q'}, attempt #1 18:31:31 INFO - Task dependencies: YLNT0xWBSUODdvhLoNhLBw 18:31:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YLNT0xWBSUODdvhLoNhLBw'}, attempt #1 18:31:32 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/YLNT0xWBSUODdvhLoNhLBw/artifacts/public/build/target.tar.bz2 18:31:32 INFO - Set test_url: https://queue.taskcluster.net/v1/task/YLNT0xWBSUODdvhLoNhLBw/artifacts/public/build/test_packages.json 18:31:32 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/YLNT0xWBSUODdvhLoNhLBw/artifacts/public/build/target.crashreporter-symbols.zip 18:31:32 INFO - Running post-action listener: _resource_record_post_action 18:31:32 INFO - [mozharness: 2017-06-02 01:31:32.036267Z] Finished read-buildbot-config step (success) 18:31:32 INFO - [mozharness: 2017-06-02 01:31:32.036486Z] Running download-and-extract step. 18:31:32 INFO - Running pre-action listener: _resource_record_pre_action 18:31:32 INFO - Running main action method: download_and_extract 18:31:32 INFO - mkdir: /builds/slave/test/build/tests 18:31:32 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:31:32 INFO - trying https://queue.taskcluster.net/v1/task/YLNT0xWBSUODdvhLoNhLBw/artifacts/public/build/target.test_packages.json 18:31:32 INFO - Downloading https://queue.taskcluster.net/v1/task/YLNT0xWBSUODdvhLoNhLBw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:31:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YLNT0xWBSUODdvhLoNhLBw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:31:32 INFO - Downloaded 986 bytes. 18:31:32 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:31:32 INFO - Using the following test package requirements: 18:31:32 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:31:32 INFO - u'common': [u'target.common.tests.zip'], 18:31:32 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:31:32 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:31:32 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:31:32 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:31:32 INFO - u'mozbase': [u'target.common.tests.zip'], 18:31:32 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:31:32 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:31:32 INFO - u'web-platform': [u'target.common.tests.zip', 18:31:32 INFO - u'target.web-platform.tests.zip'], 18:31:32 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:31:32 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:31:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YLNT0xWBSUODdvhLoNhLBw/artifacts/public/build/target.common.tests.zip 18:31:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YLNT0xWBSUODdvhLoNhLBw/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:31:32 INFO - Fetch https://queue.taskcluster.net/v1/task/YLNT0xWBSUODdvhLoNhLBw/artifacts/public/build/target.common.tests.zip into memory 18:31:35 INFO - Content-Length response header: 63530683 18:31:35 INFO - Bytes received: 63530683 18:31:46 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:31:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YLNT0xWBSUODdvhLoNhLBw/artifacts/public/build/target.common.tests.zip 18:31:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YLNT0xWBSUODdvhLoNhLBw/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:31:46 INFO - Fetch https://queue.taskcluster.net/v1/task/YLNT0xWBSUODdvhLoNhLBw/artifacts/public/build/target.common.tests.zip into memory 18:31:47 INFO - Content-Length response header: 63530683 18:31:47 INFO - Bytes received: 63530683 18:31:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YLNT0xWBSUODdvhLoNhLBw/artifacts/public/build/target.talos.tests.zip 18:31:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YLNT0xWBSUODdvhLoNhLBw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:31:59 INFO - Fetch https://queue.taskcluster.net/v1/task/YLNT0xWBSUODdvhLoNhLBw/artifacts/public/build/target.talos.tests.zip into memory 18:32:01 INFO - Content-Length response header: 14447425 18:32:01 INFO - Bytes received: 14447425 18:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:32:01 INFO - trying https://queue.taskcluster.net/v1/task/YLNT0xWBSUODdvhLoNhLBw/artifacts/public/build/target.tar.bz2 18:32:01 INFO - Downloading https://queue.taskcluster.net/v1/task/YLNT0xWBSUODdvhLoNhLBw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:32:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YLNT0xWBSUODdvhLoNhLBw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:32:04 INFO - Downloaded 54127447 bytes. 18:32:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YLNT0xWBSUODdvhLoNhLBw/artifacts/public/build/target.tar.bz2 18:32:04 INFO - mkdir: /builds/slave/test/properties 18:32:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:32:04 INFO - Writing to file /builds/slave/test/properties/build_url 18:32:04 INFO - Contents: 18:32:04 INFO - build_url:https://queue.taskcluster.net/v1/task/YLNT0xWBSUODdvhLoNhLBw/artifacts/public/build/target.tar.bz2 18:32:04 INFO - Running post-action listener: _resource_record_post_action 18:32:04 INFO - Running post-action listener: set_extra_try_arguments 18:32:04 INFO - [mozharness: 2017-06-02 01:32:04.810619Z] Finished download-and-extract step (success) 18:32:04 INFO - [mozharness: 2017-06-02 01:32:04.810845Z] Running populate-webroot step. 18:32:04 INFO - Running pre-action listener: _resource_record_pre_action 18:32:04 INFO - Running main action method: populate_webroot 18:32:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:32:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:32:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:32:04 INFO - '--tppagecycles', 18:32:04 INFO - '7'], 18:32:04 INFO - 'tests': ['tsvgm']}}, 18:32:04 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:32:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:32:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:32:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:32:04 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:32:04 INFO - 'talos_options': ['--disable-e10s'], 18:32:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:32:04 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:32:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:32:04 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:32:04 INFO - 'talos_options': ['--disable-e10s'], 18:32:04 INFO - 'tests': ['damp', 'tps']}, 18:32:04 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:32:04 INFO - 'tests': ['damp', 'tps']}, 18:32:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:32:04 INFO - 'tests': ['dromaeo_dom']}, 18:32:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:32:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:32:04 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 18:32:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:32:04 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:32:04 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:32:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:32:04 INFO - 'tests': ['a11yr', 18:32:04 INFO - 'ts_paint', 18:32:04 INFO - 'tpaint', 18:32:04 INFO - 'sessionrestore', 18:32:04 INFO - 'sessionrestore_no_auto_restore', 18:32:04 INFO - 'tabpaint']}, 18:32:04 INFO - 'other-e10s': {'tests': ['a11yr', 18:32:04 INFO - 'ts_paint', 18:32:04 INFO - 'tpaint', 18:32:04 INFO - 'sessionrestore', 18:32:04 INFO - 'sessionrestore_no_auto_restore', 18:32:04 INFO - 'tabpaint']}, 18:32:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:32:04 INFO - 'ts_paint', 18:32:04 INFO - 'tpaint', 18:32:04 INFO - 'sessionrestore', 18:32:04 INFO - 'sessionrestore_no_auto_restore', 18:32:04 INFO - 'tabpaint']}, 18:32:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:32:04 INFO - 'ts_paint', 18:32:04 INFO - 'tpaint', 18:32:04 INFO - 'sessionrestore', 18:32:04 INFO - 'sessionrestore_no_auto_restore', 18:32:04 INFO - 'tabpaint']}, 18:32:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:32:04 INFO - 'tests': ['a11yr', 18:32:04 INFO - 'ts_paint', 18:32:04 INFO - 'tpaint', 18:32:04 INFO - 'sessionrestore', 18:32:04 INFO - 'sessionrestore_no_auto_restore', 18:32:04 INFO - 'tabpaint']}, 18:32:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:32:04 INFO - 'tests': ['a11yr', 18:32:04 INFO - 'ts_paint', 18:32:04 INFO - 'tpaint', 18:32:04 INFO - 'sessionrestore', 18:32:04 INFO - 'sessionrestore_no_auto_restore', 18:32:04 INFO - 'tabpaint']}, 18:32:04 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 18:32:04 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 18:32:04 INFO - 'bloom_basic_ref']}, 18:32:04 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 18:32:04 INFO - 'talos_options': ['--mitmproxy', 18:32:04 INFO - 'mitmproxy-recording-1.mp', 18:32:04 INFO - '--firstNonBlankPaint'], 18:32:04 INFO - 'tests': ['Quantum_1']}, 18:32:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:32:04 INFO - 'tests': ['tsvgx', 18:32:04 INFO - 'tsvgr_opacity', 18:32:04 INFO - 'tart', 18:32:04 INFO - 'tscrollx', 18:32:04 INFO - 'cart', 18:32:04 INFO - 'tsvg_static']}, 18:32:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:32:04 INFO - 'tsvgr_opacity', 18:32:04 INFO - 'tart', 18:32:04 INFO - 'tscrollx', 18:32:04 INFO - 'cart', 18:32:04 INFO - 'tsvg_static']}, 18:32:04 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:32:04 INFO - 'talos_options': ['--disable-e10s'], 18:32:04 INFO - 'tests': ['tp5o']}, 18:32:04 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:32:04 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:32:04 INFO - 'talos_options': ['--disable-e10s', 18:32:04 INFO - '--xperf_path', 18:32:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:32:04 INFO - 'tests': ['tp5n']}, 18:32:04 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:32:04 INFO - 'talos_options': ['--xperf_path', 18:32:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:32:04 INFO - 'tests': ['tp5n']}}, 18:32:04 INFO - 'talos.zip': {'path': '', 18:32:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:32:04 INFO - Running post-action listener: _resource_record_post_action 18:32:04 INFO - [mozharness: 2017-06-02 01:32:04.834335Z] Finished populate-webroot step (success) 18:32:04 INFO - [mozharness: 2017-06-02 01:32:04.834430Z] Running create-virtualenv step. 18:32:04 INFO - Running pre-action listener: _resource_record_pre_action 18:32:04 INFO - Running main action method: create_virtualenv 18:32:04 INFO - Creating virtualenv /builds/slave/test/build/venv 18:32:04 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:32:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:32:04 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:32:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:32:04 INFO - Using real prefix '/usr' 18:32:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:32:05 INFO - Installing distribute.............................................................................................................................................................................................done. 18:32:07 INFO - Installing pip.................done. 18:32:07 INFO - Return code: 0 18:32:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:32:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:32:07 INFO - Reading from file tmpfile_stdout 18:32:07 INFO - Output received: 18:32:07 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:32:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:32:07 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:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:32:07 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:32:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:32:07 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 0x284e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bccdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc9840>, '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 0x2bca740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcabd0>, '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': '199fb4c72b90437b990b419b000001c5-1496366785.521909-1063444403', '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:32:07 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:32:07 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:32:07 INFO - Using env: {'DISPLAY': ':0', 18:32:07 INFO - 'HOME': '/home/cltbld', 18:32:07 INFO - 'LANG': 'en_US.UTF-8', 18:32:07 INFO - 'LANGUAGE': 'en_US:en', 18:32:07 INFO - 'LOGNAME': 'cltbld', 18:32:07 INFO - 'MAIL': '/var/mail/cltbld', 18:32:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:07 INFO - 'MOZ_NO_REMOTE': '1', 18:32:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:32:07 INFO - 'NO_EM_RESTART': '1', 18:32:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:32:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:07 INFO - 'PWD': '/builds/slave/test', 18:32:07 INFO - 'SHELL': '/bin/bash', 18:32:07 INFO - 'SHLVL': '1', 18:32:07 INFO - 'TERM': 'linux', 18:32:07 INFO - 'TMOUT': '86400', 18:32:07 INFO - 'USER': 'cltbld', 18:32:07 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1496366785.521909-1063444403', 18:32:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:07 INFO - '_': '/tools/buildbot/bin/python'} 18:32:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:32:07 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:32:07 INFO - Cleaning up... 18:32:07 INFO - Return code: 0 18:32:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:32:07 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:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:32:07 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:32:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:32:07 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 0x284e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bccdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc9840>, '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 0x2bca740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcabd0>, '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': '199fb4c72b90437b990b419b000001c5-1496366785.521909-1063444403', '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:32:07 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:32:07 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:32:07 INFO - Using env: {'DISPLAY': ':0', 18:32:07 INFO - 'HOME': '/home/cltbld', 18:32:07 INFO - 'LANG': 'en_US.UTF-8', 18:32:07 INFO - 'LANGUAGE': 'en_US:en', 18:32:07 INFO - 'LOGNAME': 'cltbld', 18:32:07 INFO - 'MAIL': '/var/mail/cltbld', 18:32:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:07 INFO - 'MOZ_NO_REMOTE': '1', 18:32:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:32:07 INFO - 'NO_EM_RESTART': '1', 18:32:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:32:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:07 INFO - 'PWD': '/builds/slave/test', 18:32:07 INFO - 'SHELL': '/bin/bash', 18:32:07 INFO - 'SHLVL': '1', 18:32:07 INFO - 'TERM': 'linux', 18:32:07 INFO - 'TMOUT': '86400', 18:32:07 INFO - 'USER': 'cltbld', 18:32:07 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1496366785.521909-1063444403', 18:32:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:07 INFO - '_': '/tools/buildbot/bin/python'} 18:32:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:32:08 INFO - Downloading/unpacking psutil>=3.1.1 18:32:08 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:32:08 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:32:08 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:32:08 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:32:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:32:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:32:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:32:09 INFO - Installing collected packages: psutil 18:32:09 INFO - Running setup.py install for psutil 18:32:09 INFO - building 'psutil._psutil_linux' extension 18:32:09 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:32:09 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:32:09 INFO - building 'psutil._psutil_posix' extension 18:32:09 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:32:09 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:32:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:32:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:32:09 INFO - Successfully installed psutil 18:32:09 INFO - Cleaning up... 18:32:09 INFO - Return code: 0 18:32:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:32:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:32:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:32:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:32:09 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 0x284e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bccdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc9840>, '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 0x2bca740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcabd0>, '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': '199fb4c72b90437b990b419b000001c5-1496366785.521909-1063444403', '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:32:09 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:32:09 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:32:09 INFO - Using env: {'DISPLAY': ':0', 18:32:09 INFO - 'HOME': '/home/cltbld', 18:32:09 INFO - 'LANG': 'en_US.UTF-8', 18:32:09 INFO - 'LANGUAGE': 'en_US:en', 18:32:09 INFO - 'LOGNAME': 'cltbld', 18:32:09 INFO - 'MAIL': '/var/mail/cltbld', 18:32:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:09 INFO - 'MOZ_NO_REMOTE': '1', 18:32:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:32:09 INFO - 'NO_EM_RESTART': '1', 18:32:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:32:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:09 INFO - 'PWD': '/builds/slave/test', 18:32:09 INFO - 'SHELL': '/bin/bash', 18:32:09 INFO - 'SHLVL': '1', 18:32:09 INFO - 'TERM': 'linux', 18:32:09 INFO - 'TMOUT': '86400', 18:32:09 INFO - 'USER': 'cltbld', 18:32:09 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1496366785.521909-1063444403', 18:32:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:09 INFO - '_': '/tools/buildbot/bin/python'} 18:32:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:32:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:32:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:32:11 INFO - Installing collected packages: mozsystemmonitor 18:32:11 INFO - Running setup.py install for mozsystemmonitor 18:32:11 INFO - Successfully installed mozsystemmonitor 18:32:11 INFO - Cleaning up... 18:32:11 INFO - Return code: 0 18:32:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:32:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:32:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:32:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:32:11 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 0x284e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bccdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc9840>, '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 0x2bca740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcabd0>, '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': '199fb4c72b90437b990b419b000001c5-1496366785.521909-1063444403', '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:32:11 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:32:11 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:32:11 INFO - Using env: {'DISPLAY': ':0', 18:32:11 INFO - 'HOME': '/home/cltbld', 18:32:11 INFO - 'LANG': 'en_US.UTF-8', 18:32:11 INFO - 'LANGUAGE': 'en_US:en', 18:32:11 INFO - 'LOGNAME': 'cltbld', 18:32:11 INFO - 'MAIL': '/var/mail/cltbld', 18:32:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:11 INFO - 'MOZ_NO_REMOTE': '1', 18:32:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:32:11 INFO - 'NO_EM_RESTART': '1', 18:32:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:32:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:11 INFO - 'PWD': '/builds/slave/test', 18:32:11 INFO - 'SHELL': '/bin/bash', 18:32:11 INFO - 'SHLVL': '1', 18:32:11 INFO - 'TERM': 'linux', 18:32:11 INFO - 'TMOUT': '86400', 18:32:11 INFO - 'USER': 'cltbld', 18:32:11 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1496366785.521909-1063444403', 18:32:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:11 INFO - '_': '/tools/buildbot/bin/python'} 18:32:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:32:11 INFO - Downloading/unpacking jsonschema==2.5.1 18:32:11 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:32:11 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:32:11 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:32:11 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:32:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:32:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:12 INFO - Downloading functools32-3.2.3-2.tar.gz 18:32:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:32:12 INFO - warning: no files found matching '*.txt' 18:32:12 INFO - no previously-included directories found matching 'build' 18:32:12 INFO - no previously-included directories found matching 'dist' 18:32:12 INFO - no previously-included directories found matching '.git*' 18:32:12 INFO - Installing collected packages: jsonschema, functools32 18:32:12 INFO - Running setup.py install for functools32 18:32:12 INFO - warning: no files found matching '*.txt' 18:32:12 INFO - no previously-included directories found matching 'build' 18:32:12 INFO - no previously-included directories found matching 'dist' 18:32:12 INFO - no previously-included directories found matching '.git*' 18:32:12 INFO - Successfully installed jsonschema functools32 18:32:12 INFO - Cleaning up... 18:32:12 INFO - Return code: 0 18:32:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:32:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:32:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:32:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:32:12 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 0x284e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bccdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc9840>, '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 0x2bca740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcabd0>, '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': '199fb4c72b90437b990b419b000001c5-1496366785.521909-1063444403', '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:32:12 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:32:12 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:32:12 INFO - Using env: {'DISPLAY': ':0', 18:32:12 INFO - 'HOME': '/home/cltbld', 18:32:12 INFO - 'LANG': 'en_US.UTF-8', 18:32:12 INFO - 'LANGUAGE': 'en_US:en', 18:32:12 INFO - 'LOGNAME': 'cltbld', 18:32:12 INFO - 'MAIL': '/var/mail/cltbld', 18:32:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:12 INFO - 'MOZ_NO_REMOTE': '1', 18:32:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:32:12 INFO - 'NO_EM_RESTART': '1', 18:32:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:32:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:12 INFO - 'PWD': '/builds/slave/test', 18:32:12 INFO - 'SHELL': '/bin/bash', 18:32:12 INFO - 'SHLVL': '1', 18:32:12 INFO - 'TERM': 'linux', 18:32:12 INFO - 'TMOUT': '86400', 18:32:12 INFO - 'USER': 'cltbld', 18:32:12 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1496366785.521909-1063444403', 18:32:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:12 INFO - '_': '/tools/buildbot/bin/python'} 18:32:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:32:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:32:13 INFO - Cleaning up... 18:32:13 INFO - Return code: 0 18:32:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:32: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:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:32: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:32:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:32:13 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 0x284e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bccdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc9840>, '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 0x2bca740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcabd0>, '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': '199fb4c72b90437b990b419b000001c5-1496366785.521909-1063444403', '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:32:13 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:32:13 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:32:13 INFO - Using env: {'DISPLAY': ':0', 18:32:13 INFO - 'HOME': '/home/cltbld', 18:32:13 INFO - 'LANG': 'en_US.UTF-8', 18:32:13 INFO - 'LANGUAGE': 'en_US:en', 18:32:13 INFO - 'LOGNAME': 'cltbld', 18:32:13 INFO - 'MAIL': '/var/mail/cltbld', 18:32:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:13 INFO - 'MOZ_NO_REMOTE': '1', 18:32:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:32:13 INFO - 'NO_EM_RESTART': '1', 18:32:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:32:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:13 INFO - 'PWD': '/builds/slave/test', 18:32:13 INFO - 'SHELL': '/bin/bash', 18:32:13 INFO - 'SHLVL': '1', 18:32:13 INFO - 'TERM': 'linux', 18:32:13 INFO - 'TMOUT': '86400', 18:32:13 INFO - 'USER': 'cltbld', 18:32:13 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1496366785.521909-1063444403', 18:32:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:13 INFO - '_': '/tools/buildbot/bin/python'} 18:32:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:32:13 INFO - Downloading/unpacking blobuploader==1.2.4 18:32:13 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:32:13 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:32:13 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:32:13 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:32:14 INFO - Downloading blobuploader-1.2.4.tar.gz 18:32:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:32:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:32:14 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:32:14 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:32:14 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:32:14 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:32:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:32:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:32:14 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:32:14 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:32:14 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:32:14 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:32:14 INFO - Downloading docopt-0.6.1.tar.gz 18:32:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:32:15 INFO - Installing collected packages: blobuploader, requests, docopt 18:32:15 INFO - Running setup.py install for blobuploader 18:32:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:32:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:32:15 INFO - Running setup.py install for requests 18:32:15 INFO - Running setup.py install for docopt 18:32:15 INFO - Successfully installed blobuploader requests docopt 18:32:15 INFO - Cleaning up... 18:32:15 INFO - Return code: 0 18:32:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:32:15 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:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:32:15 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:32:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:32:15 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 0x284e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bccdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc9840>, '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 0x2bca740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcabd0>, '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': '199fb4c72b90437b990b419b000001c5-1496366785.521909-1063444403', '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:32:15 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:32:15 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:32:15 INFO - Using env: {'DISPLAY': ':0', 18:32:15 INFO - 'HOME': '/home/cltbld', 18:32:15 INFO - 'LANG': 'en_US.UTF-8', 18:32:15 INFO - 'LANGUAGE': 'en_US:en', 18:32:15 INFO - 'LOGNAME': 'cltbld', 18:32:15 INFO - 'MAIL': '/var/mail/cltbld', 18:32:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:15 INFO - 'MOZ_NO_REMOTE': '1', 18:32:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:32:15 INFO - 'NO_EM_RESTART': '1', 18:32:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:32:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:15 INFO - 'PWD': '/builds/slave/test', 18:32:15 INFO - 'SHELL': '/bin/bash', 18:32:15 INFO - 'SHLVL': '1', 18:32:15 INFO - 'TERM': 'linux', 18:32:15 INFO - 'TMOUT': '86400', 18:32:15 INFO - 'USER': 'cltbld', 18:32:15 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1496366785.521909-1063444403', 18:32:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:15 INFO - '_': '/tools/buildbot/bin/python'} 18:32:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:32:15 INFO - Running setup.py (path:/tmp/pip-vRH1Qc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:32:15 INFO - Running setup.py (path:/tmp/pip-p4WD1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:32:15 INFO - Running setup.py (path:/tmp/pip-doRg_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:32:16 INFO - Running setup.py (path:/tmp/pip-F_R8MS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:32:16 INFO - Running setup.py (path:/tmp/pip-aRv1Fy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:32:16 INFO - Running setup.py (path:/tmp/pip-AbT85L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:32:16 INFO - Running setup.py (path:/tmp/pip-Aij4v1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:32:16 INFO - Running setup.py (path:/tmp/pip-NgzPst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:32:16 INFO - Running setup.py (path:/tmp/pip-Zdn9dc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:32:16 INFO - Running setup.py (path:/tmp/pip-kFFNvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:32:16 INFO - Running setup.py (path:/tmp/pip-oxWpVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:32:16 INFO - Running setup.py (path:/tmp/pip-SugLN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:32:16 INFO - Running setup.py (path:/tmp/pip-9b6jUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:32:16 INFO - Running setup.py (path:/tmp/pip-_bkIi5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:32:16 INFO - Running setup.py (path:/tmp/pip-hjI8Si-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:32:16 INFO - Running setup.py (path:/tmp/pip-hSem9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:32:16 INFO - Running setup.py (path:/tmp/pip-oqH7c9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:32:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:32:17 INFO - Running setup.py install for manifestparser 18:32:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:32:17 INFO - Running setup.py install for mozcrash 18:32:17 INFO - Running setup.py install for mozdebug 18:32:17 INFO - Running setup.py install for mozdevice 18:32:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:32:17 INFO - Running setup.py install for mozfile 18:32:17 INFO - Running setup.py install for mozhttpd 18:32:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:32:17 INFO - Running setup.py install for mozinfo 18:32:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:32:17 INFO - Running setup.py install for mozInstall 18:32:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:32:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:32:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:32:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:32:17 INFO - Running setup.py install for mozleak 18:32:17 INFO - Running setup.py install for mozlog 18:32:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:32:18 INFO - Running setup.py install for moznetwork 18:32:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:32:18 INFO - Running setup.py install for mozprocess 18:32:18 INFO - Running setup.py install for mozprofile 18:32:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:32:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:32:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:32:18 INFO - Running setup.py install for mozrunner 18:32:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:32:18 INFO - Running setup.py install for mozscreenshot 18:32:18 INFO - Running setup.py install for moztest 18:32:18 INFO - Running setup.py install for mozversion 18:32:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:32:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:32:18 INFO - Cleaning up... 18:32:18 INFO - Return code: 0 18:32:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:32:18 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:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:32:18 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:32:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:32:18 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 0x284e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bccdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc9840>, '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 0x2bca740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcabd0>, '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': '199fb4c72b90437b990b419b000001c5-1496366785.521909-1063444403', '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:32:18 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:32:18 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:32:18 INFO - Using env: {'DISPLAY': ':0', 18:32:18 INFO - 'HOME': '/home/cltbld', 18:32:18 INFO - 'LANG': 'en_US.UTF-8', 18:32:18 INFO - 'LANGUAGE': 'en_US:en', 18:32:18 INFO - 'LOGNAME': 'cltbld', 18:32:18 INFO - 'MAIL': '/var/mail/cltbld', 18:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:18 INFO - 'MOZ_NO_REMOTE': '1', 18:32:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:32:18 INFO - 'NO_EM_RESTART': '1', 18:32:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:18 INFO - 'PWD': '/builds/slave/test', 18:32:18 INFO - 'SHELL': '/bin/bash', 18:32:18 INFO - 'SHLVL': '1', 18:32:18 INFO - 'TERM': 'linux', 18:32:18 INFO - 'TMOUT': '86400', 18:32:18 INFO - 'USER': 'cltbld', 18:32:18 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1496366785.521909-1063444403', 18:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:18 INFO - '_': '/tools/buildbot/bin/python'} 18:32:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:32:19 INFO - Running setup.py (path:/tmp/pip-LtZ8gQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:32:19 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:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:32:19 INFO - Running setup.py (path:/tmp/pip-iTUSgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:32:19 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:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:32:19 INFO - Running setup.py (path:/tmp/pip-UCl9II-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:32:19 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:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:32:19 INFO - Running setup.py (path:/tmp/pip-ERiPzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:32:19 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:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:32:19 INFO - Running setup.py (path:/tmp/pip-ezs7xx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:32:19 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:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:32:19 INFO - Running setup.py (path:/tmp/pip-3725DA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:32:19 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:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:32:19 INFO - Running setup.py (path:/tmp/pip-q12nPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:32:19 INFO - Running setup.py (path:/tmp/pip-MFoMqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 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:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:32:19 INFO - Running setup.py (path:/tmp/pip-r0Azvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:32:19 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:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:32:19 INFO - Running setup.py (path:/tmp/pip-8UneFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:32:19 INFO - Running setup.py (path:/tmp/pip-BpSVqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:32:19 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:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:32:19 INFO - Running setup.py (path:/tmp/pip-b02Dzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:32:19 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:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:32:19 INFO - Running setup.py (path:/tmp/pip-fSreC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:32:20 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:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:32:20 INFO - Running setup.py (path:/tmp/pip-Zy4j3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:32:20 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:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:32:20 INFO - Running setup.py (path:/tmp/pip-UgKrAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:32:20 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:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:32:20 INFO - Running setup.py (path:/tmp/pip-GCYtlX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:32:20 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:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:32:20 INFO - Running setup.py (path:/tmp/pip-SuOx1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:32:20 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:32:20 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:32:20 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:32:20 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:32:20 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:32:20 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:32:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:32:20 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:32:20 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:32:20 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:32:20 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:32:21 INFO - Downloading blessings-1.6.tar.gz 18:32:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:32:21 INFO - Installing collected packages: blessings 18:32:21 INFO - Running setup.py install for blessings 18:32:21 INFO - Successfully installed blessings 18:32:21 INFO - Cleaning up... 18:32:21 INFO - Return code: 0 18:32:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:32:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:32:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:32:21 INFO - Reading from file tmpfile_stdout 18:32:21 INFO - Current package versions: 18:32:21 INFO - argparse == 1.2.1 18:32:21 INFO - blessings == 1.6 18:32:21 INFO - blobuploader == 1.2.4 18:32:21 INFO - docopt == 0.6.1 18:32:21 INFO - functools32 == 3.2.3-2 18:32:21 INFO - jsonschema == 2.5.1 18:32:21 INFO - manifestparser == 1.1 18:32:21 INFO - mozInstall == 1.12 18:32:21 INFO - mozcrash == 1.0 18:32:21 INFO - mozdebug == 0.1 18:32:21 INFO - mozdevice == 0.51 18:32:21 INFO - mozfile == 1.2 18:32:21 INFO - mozhttpd == 0.7 18:32:21 INFO - mozinfo == 0.9 18:32:21 INFO - mozleak == 0.1 18:32:21 INFO - mozlog == 3.4 18:32:21 INFO - moznetwork == 0.27 18:32:21 INFO - mozprocess == 0.25 18:32:21 INFO - mozprofile == 0.28 18:32:21 INFO - mozrunner == 6.13 18:32:21 INFO - mozscreenshot == 0.1 18:32:21 INFO - mozsystemmonitor == 0.3 18:32:21 INFO - moztest == 0.8 18:32:21 INFO - mozversion == 1.4 18:32:21 INFO - psutil == 3.1.1 18:32:21 INFO - requests == 1.2.3 18:32:21 INFO - wsgiref == 0.1.2 18:32:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:32:21 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:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:32:21 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:32:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:32:21 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 0x284e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bccdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc9840>, '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 0x2bca740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcabd0>, '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': '199fb4c72b90437b990b419b000001c5-1496366785.521909-1063444403', '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:32:21 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:32:21 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:32:21 INFO - Using env: {'DISPLAY': ':0', 18:32:21 INFO - 'HOME': '/home/cltbld', 18:32:21 INFO - 'LANG': 'en_US.UTF-8', 18:32:21 INFO - 'LANGUAGE': 'en_US:en', 18:32:21 INFO - 'LOGNAME': 'cltbld', 18:32:21 INFO - 'MAIL': '/var/mail/cltbld', 18:32:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:21 INFO - 'MOZ_NO_REMOTE': '1', 18:32:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:32:21 INFO - 'NO_EM_RESTART': '1', 18:32:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:32:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:21 INFO - 'PWD': '/builds/slave/test', 18:32:21 INFO - 'SHELL': '/bin/bash', 18:32:21 INFO - 'SHLVL': '1', 18:32:21 INFO - 'TERM': 'linux', 18:32:21 INFO - 'TMOUT': '86400', 18:32:21 INFO - 'USER': 'cltbld', 18:32:21 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1496366785.521909-1063444403', 18:32:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:21 INFO - '_': '/tools/buildbot/bin/python'} 18:32:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:32:22 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:32:22 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:32:22 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:32:22 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:32:22 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:32:22 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:32:22 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:32:22 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:32:22 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:32:22 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:32: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:32: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:32: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:32: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:32:23 INFO - Downloading marionette_driver-1.4.0.tar.gz 18:32:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 18:32:23 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:32:23 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:32:23 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:32:23 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:32:23 INFO - Installing collected packages: marionette-driver 18:32:23 INFO - Running setup.py install for marionette-driver 18:32:23 INFO - Successfully installed marionette-driver 18:32:23 INFO - Cleaning up... 18:32:23 INFO - Return code: 0 18:32:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:32:23 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:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:32:23 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:32:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:32:23 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 0x284e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bccdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc9840>, '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 0x2bca740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcabd0>, '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': '199fb4c72b90437b990b419b000001c5-1496366785.521909-1063444403', '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:32:23 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:32:23 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:32:23 INFO - Using env: {'DISPLAY': ':0', 18:32:23 INFO - 'HOME': '/home/cltbld', 18:32:23 INFO - 'LANG': 'en_US.UTF-8', 18:32:23 INFO - 'LANGUAGE': 'en_US:en', 18:32:23 INFO - 'LOGNAME': 'cltbld', 18:32:23 INFO - 'MAIL': '/var/mail/cltbld', 18:32:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:23 INFO - 'MOZ_NO_REMOTE': '1', 18:32:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:32:23 INFO - 'NO_EM_RESTART': '1', 18:32:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:32:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:23 INFO - 'PWD': '/builds/slave/test', 18:32:23 INFO - 'SHELL': '/bin/bash', 18:32:23 INFO - 'SHLVL': '1', 18:32:23 INFO - 'TERM': 'linux', 18:32:23 INFO - 'TMOUT': '86400', 18:32:23 INFO - 'USER': 'cltbld', 18:32:23 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1496366785.521909-1063444403', 18:32:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:23 INFO - '_': '/tools/buildbot/bin/python'} 18:32:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:32:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:32:23 INFO - Cleaning up... 18:32:23 INFO - Return code: 0 18:32:23 INFO - Running post-action listener: _resource_record_post_action 18:32:23 INFO - Running post-action listener: _start_resource_monitoring 18:32:23 INFO - Starting resource monitoring. 18:32:23 INFO - [mozharness: 2017-06-02 01:32:23.634902Z] Finished create-virtualenv step (success) 18:32:23 INFO - [mozharness: 2017-06-02 01:32:23.635367Z] Running install step. 18:32:23 INFO - Running pre-action listener: _resource_record_pre_action 18:32:23 INFO - Running main action method: install 18:32:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:32:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:32:23 INFO - Reading from file tmpfile_stdout 18:32:23 INFO - Detecting whether we're running mozinstall >=1.0... 18:32:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:32:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:32:23 INFO - Reading from file tmpfile_stdout 18:32:23 INFO - Output received: 18:32:23 INFO - Usage: mozinstall [options] installer 18:32:23 INFO - Options: 18:32:23 INFO - -h, --help show this help message and exit 18:32:23 INFO - -d DEST, --destination=DEST 18:32:23 INFO - Directory to install application into. [default: 18:32:23 INFO - "/builds/slave/test"] 18:32:23 INFO - --app=APP Application being installed. [default: firefox] 18:32:23 INFO - mkdir: /builds/slave/test/build/application 18:32:23 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:32:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:32:39 INFO - Reading from file tmpfile_stdout 18:32:39 INFO - Output received: 18:32:39 INFO - /builds/slave/test/build/application/firefox/firefox 18:32:39 INFO - Running post-action listener: _resource_record_post_action 18:32:39 INFO - [mozharness: 2017-06-02 01:32:39.465702Z] Finished install step (success) 18:32:39 INFO - [mozharness: 2017-06-02 01:32:39.466001Z] Running setup-mitmproxy step. 18:32:39 INFO - Running pre-action listener: _resource_record_pre_action 18:32:39 INFO - Running main action method: setup_mitmproxy 18:32:39 INFO - Skipping: mitmproxy is not required 18:32:39 INFO - Running post-action listener: _resource_record_post_action 18:32:39 INFO - [mozharness: 2017-06-02 01:32:39.467133Z] Finished setup-mitmproxy step (success) 18:32:39 INFO - [mozharness: 2017-06-02 01:32:39.467354Z] Running run-tests step. 18:32:39 INFO - Running pre-action listener: _resource_record_pre_action 18:32:39 INFO - Running main action method: run_tests 18:32:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:32:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:32:39 INFO - Python 2.7.3 18:32:39 INFO - Return code: 0 18:32:39 INFO - grabbing minidump binary from tooltool 18:32:39 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:32:39 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 0x2bc9840>, '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 0x2bca740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bcabd0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:32:39 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:32:39 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:32:39 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:32:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:32:39 INFO - Return code: 0 18:32:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:32:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:32:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:32:39 INFO - ENV: RUST_BACKTRACE is now 1 18:32:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:32:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:32:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YLNT0xWBSUODdvhLoNhLBw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-072', '--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:32:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YLNT0xWBSUODdvhLoNhLBw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-072 --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:32:39 INFO - Using env: {'DISPLAY': ':0', 18:32:39 INFO - 'HOME': '/home/cltbld', 18:32:39 INFO - 'LANG': 'en_US.UTF-8', 18:32:39 INFO - 'LANGUAGE': 'en_US:en', 18:32:39 INFO - 'LOGNAME': 'cltbld', 18:32:39 INFO - 'MAIL': '/var/mail/cltbld', 18:32:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:32:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:32:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:39 INFO - 'MOZ_NO_REMOTE': '1', 18:32:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:32:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:32:39 INFO - 'NO_EM_RESTART': '1', 18:32:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:32:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:39 INFO - 'PWD': '/builds/slave/test', 18:32:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:32:39 INFO - 'RUST_BACKTRACE': '1', 18:32:39 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:32:39 INFO - 'SHELL': '/bin/bash', 18:32:39 INFO - 'SHLVL': '1', 18:32:39 INFO - 'TERM': 'linux', 18:32:39 INFO - 'TMOUT': '86400', 18:32:39 INFO - 'USER': 'cltbld', 18:32:39 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1496366785.521909-1063444403', 18:32:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:39 INFO - '_': '/tools/buildbot/bin/python'} 18:32:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YLNT0xWBSUODdvhLoNhLBw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-072', '--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:32:39 INFO - mozversion application_buildid: 20170602010042 18:32:39 INFO - mozversion application_changeset: 877c3da58fa35bf4e58f2ac0cbcf59840702cc6e 18:32:39 INFO - mozversion application_display_name: Nightly 18:32:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:32:39 INFO - mozversion application_name: Firefox 18:32:39 INFO - mozversion application_remotingname: firefox 18:32:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:32:39 INFO - mozversion application_vendor: Mozilla 18:32:39 INFO - mozversion application_version: 55.0a1 18:32:39 INFO - mozversion platform_buildid: 20170602010042 18:32:39 INFO - mozversion platform_changeset: 877c3da58fa35bf4e58f2ac0cbcf59840702cc6e 18:32:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:32:39 INFO - mozversion platform_version: 55.0a1 18:32:39 INFO - using testdate: 1496367159 18:32:39 INFO - actual date: 1496367159 18:32:39 INFO - starting webserver on 'localhost:49593' 18:32:39 INFO - SUITE-START | Running 2 tests 18:32:39 INFO - TEST-START | dromaeo_css 18:32:39 INFO - operating with platform_type : linux_ 18:32:39 INFO - Initialising browser for dromaeo_css test... 18:32:39 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49593/getInfo.html -profile /tmp/tmp3DNLYP/profile 18:32:39 INFO - TEST-INFO | started process 27576 (/builds/slave/test/build/application/firefox/firefox http://localhost:49593/getInfo.html) 18:33:15 INFO - TEST-INFO | 27576: killed by SIGTERM 18:33:15 INFO - Browser initialized. 18:33:15 INFO - Running cycle 1/1 for dromaeo_css test... 18:33:15 INFO - TEST-INFO | started process 27781 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3DNLYP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:33:27 INFO - PID 27781 | RSS: Main: 184078336 18:33:27 INFO - PID 27781 | 18:36:31 INFO - PID 27781 | Cycle 1(1): loaded http://localhost:49593/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49593/tests/dromaeo/cssquery-ext.html) 18:36:33 INFO - PID 27781 | RSS: Main: 178163712 18:36:33 INFO - PID 27781 | 18:39:35 INFO - PID 27781 | Cycle 1(1): loaded http://localhost:49593/tests/dromaeo/cssquery-ext.html (next: http://localhost:49593/tests/dromaeo/cssquery-jquery.html) 18:39:35 INFO - PID 27781 | RSS: Main: 185552896 18:39:35 INFO - PID 27781 | 18:42:37 INFO - PID 27781 | Cycle 1(1): loaded http://localhost:49593/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49593/tests/dromaeo/cssquery-mootools.html) 18:42:38 INFO - PID 27781 | RSS: Main: 182493184 18:42:38 INFO - PID 27781 | 18:45:40 INFO - PID 27781 | Cycle 1(1): loaded http://localhost:49593/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49593/tests/dromaeo/cssquery-prototype.html) 18:45:40 INFO - PID 27781 | RSS: Main: 186970112 18:45:40 INFO - PID 27781 | 18:48:43 INFO - PID 27781 | Cycle 1(1): loaded http://localhost:49593/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49593/tests/dromaeo/cssquery-yui.html) 18:48:44 INFO - PID 27781 | RSS: Main: 185065472 18:48:44 INFO - PID 27781 | 18:51:46 INFO - PID 27781 | Cycle 1(1): loaded http://localhost:49593/tests/dromaeo/cssquery-yui.html (next: http://localhost:49593/tests/dromaeo/cssquery-dojo.html) 18:51:46 INFO - PID 27781 | RSS: Main: 182784000 18:51:46 INFO - PID 27781 | 18:51:46 INFO - PID 27781 | __start_tp_report 18:51:46 INFO - PID 27781 | _x_x_mozilla_page_load 18:51:46 INFO - PID 27781 | _x_x_mozilla_page_load_details 18:51:46 INFO - PID 27781 | |i|pagename|runs| 18:51:46 INFO - PID 27781 | |0;dojo.html;2722.768564672003;2725.359540507981;2746.1075150576057;2762.116122840692;2767.41884204317;5206.609504287184;5237.685738855671;5247.606429517792;5257.737113144337;5279.472052794718;5181.274621552976;5218.21726740989;5268.762905669245;5275.155975043994;5322.840314790553;4473.681662842592;4622.352870598119;4649;4655.13879932212;4656.441227052758;4685.742284174369;4708.105459962596;4714.599259062984;4718.740469274188;4726.267428548564;4587.8623641290815;4669.322948172496;4679.625629949596;4680.64895132863;4763.190257656207;4640.930386044212;4641.0949864776385;4643.953560464386;4667.696599721041;4676.392069031038;4556.498785133633;4600.838970636045;4620.353150558924;4621.8151273949;4647.488776234612;5206.427292997767;5217.921731174036;5244.318238628954;5252.395974462947;5326;5656.151577263443;5747.6551406915305;5751.079827227623;5751.166080918285;5761.567882408836;5716.885662286731;5720.771169153229;5725.1698503716725;5734.4265573442735;5740.655560666373;5296.735163241861;5303.390110137307;5308.018016666929;5310.681359118388;5346.171343441695;5794.913076303858;5896.734646940898;5902.380250073767;5987.43119403656;5994.430529099728;5539.944600554023;5545.390007099216;5553;5592.636478628876;5599.720013999284;5539.639923404966;5632.436756324417;5642.971785141048;5648.4633959773755;5648.6893220872425;5614.438556144434;5630.971845140748;5631.465010823965;5661.49046585801;5736.741846616912;5572.164175373727;5634.408387119375;5660.26416565852;5663.150527420919;5673.773049078073;4732.195526760459;4741.620670346433;4745.572898439157;4751.3348131261655;4790.880227994258;4063.329550624114;4064.4919385076864;4066.877993660195;4082.040720430696;4114.6091121343425;4748.596369308579;4822.204336284544;4834.685745426536;4866.732329721828;4906.411230652345;5694.4590263924865;5703.258576385127;5704.429557044263;5728.48443640066;5769.105788602773;4781.139394908881;4791.520847915251;4796.496367881392;4813.687110337887;4844.806207751651;4985.750712464363;5023.572996295356;5046.545810876965;5051.747412629354;5133.204353325241;5286.97356513215;5315.441878602691;5325.09473389517;5328.094223981855;5340.679559226303;5661.377248502579;5663.122216056518;5761.5102716269585;5796.739146738491;5849.473547380756;5216.791328346975;5230.398504172069;5305.283786688748;5321.627486075938;5322.068637988414;5643.294588176478;5652.463016013472;5664.518515926193;5673.205751194753;5705.771769129188;5761.049426844691;5764.07774756037;5791.189233507396;5865.061590145556;5899.262592175978;5501.394846566955;5522.66863988162;5559.138333558305;5566.4990150885;5586.692731899622;5475.151351540518;5475.780968761364;5476.507114359727;5481.205225242238;5503.091989821634;5380.865478363072;5390.703511306916;5432.18517222404;5441.129419293053;5486.588505861996;5523.364813046551;5570.44295570456;5626.2685850839125;5636.436356364331;5666.801661941812;5340.092184328596;5356.330458692663;5357.517823395913;5375.3012108425655;5378.058839703114 18:51:46 INFO - PID 27781 | |1;ext.html;679.1510611735331;738.420340033074;755.4522970846137;1096.4079397125552;1105.303658695022;33563.16092097699;34581.30837383251;34668.82665586669;34696.13259668506;34763.826180869124;34875;34976.475352869726;35101.82449087751;35194;35213.119672008215;6711.597304161742;6811.352921472452;6842.315768423167;6982.162140543117;6988.371046605805;6776.15298087739;6853.485988550854;6854.485913556478;6855.58866468011;6859.897101543456;6805.6597170141295;6885.690143943534;6900.930990690104;6904.654767261642;6904.827379315507;6815.045893574904;6845.657717114124;6857.691403886787;6865.313468653145;6876.209235937881;6738.22510411304;6771.424428923548;6772.8984065239065;6794.286599907037;6796.864062718718;32846;32861.50707739386;32870.34259314824;32903.83548082244;32959.340813183844;2994.31130839908;3026.455238057149;3026.757859371245;3028.5911401960675;3034.150437877398;25203.369915752068;25317.113901013377;25431.745682543307;25492.490150197078;25539.872300638563;2493.4888347888823;2532.493501299729;2538.1624064058815;2540.314115188907;2543.682039745032;143505;143753;157818;162633.18683406626;164393;40327;40756.59243407587;40790.18419631591;40796;40826;42202.788986054875;42279.577204227564;42451;42462;42506;12482.50069997208;12578.245305281713;12606.621801345975;12621.24272543632;12650.240985540897;10032.69901902944;10066;10090.293679442368;10119.494025298705;10124.240681948737;12917.741645167043;12942.352882355844;12986;12991.155574887602;13092.607221783363;5476.644018138888;5557.360903496069;5563.193336966117;5569.721513924287;5586.469285417878;855.6705668317743;886.9778255543663;903.5437104262305;925.6482536636036;928.6517555916531;20841.79158208429;21381.893090534446;21699.78300217009;21732.565348692937;21932.45168870791;972.2222222222194;979.8579206015088;980.2305190425482;991.9206463482905;1007.4408703169664;10986.176036797273;11347.489362978686;11376.374299413612;11379.032782213604;11561.537538498365;186614;187421;188554;188766;188915;41709.58290417057;42037.36943945843;42172.789136054125;42193.36709949353;42206;1209.7520008398258;1229.557359350633;1235.9814602780966;1239.293602646483;1251.6620512461584;19340;19793.109310080792;20075;20877.89561052185;21315.46711332229;29908.252293692833;29952.70047299499;30028.849855751454;30086.398272034876;30141.246468838453;152360;152994;153056;153218;153905;29344;29524.557131642614;30133.547996779627;31275.53086703747;31476.842615786776;36480.81759591185;37031.62968370282;37081.81459092687;37310.81344593368;37394.25211495809;26711.866440667673;27435;27602.723972760014;27835.304117397227;28358.14925552154;26675.19974400771;27874.721252788026;28628.713712862605;28678.569821452278;28734;32521.837390812896;32554.348913021135;32568.348633026733;32598.51102233516;32633.34733305368;26655.866720666272;26700.332491687088;26857.597136043365;27959.440811183256;28114.2971425716;21712.67430988505;22593;22748.545029099656;22777.772222277566;22942.311730648107 18:51:46 INFO - PID 27781 | |2;jquery.html;393.78735482839267;418.0451274355514;428.8434721326715;435.2426777407311;444.488837836488;16785.49643510695;17329.740053899186;17339.30642774289;18321;19928.202871885143;19241.711374329396;19655.410337689857;19688.803111968875;19831.305904293353;19862.304819331326;5506.972465137679;5642.492175704186;5657.519110875581;5667.688277144755;5670.518005969498;4904.558589726924;4960.23116416956;4965.503449655023;4978.5562186965735;5659.745311460973;4923.950760492385;4961.032598643266;4965.975170124144;4966.9751651241695;4968.329275547809;4870.0746858096845;4894.437139728905;4919.13915064864;4927.679700819471;4944.901101977958;4489.820407183742;4517;4518.864434066983;4520.570545798144;4523.095380923795;23848.880755596285;24084.157054503183;24104.517909641883;24169.637455438184;24209.878950605133;1592.9681406371808;1646.2509558151012;1652.512508809904;1652.6116362654766;1656.7183578791635;15660.451884183998;15870.603234919105;15884;15902.204889755581;15987;2074.6991686205415;2083.4687154775434;2106.304919376602;2121.755998060212;2158.9784102158933;103448;105692.47153764259;106130.99999999923;106174.46912765464;106683;11039.503222355013;11370;11396.316221026766;11526.942365288287;11598.478068486938;16299.103549304902;16349.264283107288;16382.344706211856;16416.4254251103;16427.096509691844;7839.216078392115;7980.640871160812;8082.070561885458;8151.062627797879;8212.753617391489;6568.441682457044;7290.5625662460425;7303.123625165014;7426.9257307427315;7474.364679002346;7283.313247933137;7366.815829604303;7373;7404.556111558194;7461.1419686735635;2076.709260703503;2103.24283258027;2108.483421561727;2128.095559387254;2259.096361455398;783.6238605469407;850.9574521274035;856.3406177243488;875.92992560595;877.7279043496536;17371;17746;17936.282548698167;18125.63748725018;18495.722564161548;861.1216559109798;876.4872549558452;877.8463768840427;880.190224993008;896.9596368163449;9674.419534827934;9912.851307230398;9939.900600994042;9949.801003980025;10105.090541851268;379422;385196;386424;387818;390414;87564.56217718998;87891.56054219688;89042.97919780746;89073;89281;1033.2715435617872;1038.6364772329775;1058.5448257249457;1063.7712891728315;1065.3607835298758;15284.847151528342;15404.38382464689;15804.68390632204;16060.35758569691;16508.092054937093;42798.78600606977;43709.56290437182;43839.22666494223;43968;46175.76912115552;53520.464795351545;54263.18605220846;54553.45446545484;54594;54674;7979.680812767424;9066.682666106655;9730;9777.21782257432;9788.804223915624;14424.927875360556;14450.0377422626;14526.128432294096;15744.772321674258;16705.582360441087;13886.305684715926;13982.790258146339;14007.509737159151;14037;14189.645258868612;12248.326342050916;12253.877461225631;12565.748685026065;13180.693378658889;13346.599602011955;13843.861561384258;13892.374843132286;14122.082064665763;14210.715785684435;14264.572062838131;9534.475603841578;9571.37786043905;9585.376950498196;9618.278629102706;9620.855687164838;13269.40287687037;13398.732025359634;13404.865951340751;13431.529896453969;13441.663958401119 18:51:46 INFO - PID 27781 | |3;mootools.html;1230.7230873053563;1249.244207254611;1263.3809433377637;1280.8270883430735;1292.734989327188;9856.655017074403;10217.540210690519;10365.689029329124;10365.792684146321;10563.630272940449;10252.948735256314;10346.793064138712;10362.740931476697;10419.114375278092;10462.790744185131;2087.1755656515707;2119.07820098257;2131.1794958940764;2139.711138996239;2140.8715477071346;1924.7594050743658;1969.7340858984069;1979.6535606268844;1984.3848406993877;1993.6012797440496;1921.8174273444001;1939.4666466721624;1951.6096780643857;1958.8334991525737;1965.9803401966012;1794.7935987361425;1803.9368622098164;1804.1520485371855;1804.49474147239;1813.945581632553;1920.0591710062108;1949.3567122849568;1962.1464662871697;1996.9201231950703;2001.1295086637215;9717.805643887154;9803.509824508747;9804.705858824176;9808.264380171444;9813.607455701764;5500.559955203614;5688;5692.37383887772;5703.116017017369;5718.885622287573;3101.875924962999;3180.7296379807744;3273.06717585487;3276.6723327667282;3280.9671903281137;1027.398971601614;1033.1424917318682;1043.3218408034763;1054.9630762923261;1055.6252530351692;14019;14040.85959140416;14058.789118163133;14067.788983165261;14429.134251944812;4624.907501849944;4682;4787.329773831666;4824.204006338915;4837.4920633333695;11135.498902549405;11215.04672102864;11224.326540407601;11260.718482037852;11276.436178191057;5369.838904832861;5473.589480788877;5490.258815059916;5505.504504594605;5517.531009864207;5013.749312534359;5054.721990290495;5073.492650734971;5077.060743762416;5086.72023038729;3830.138218900725;3833.3674943633987;3875.5736868944396;3930.76415415076;3957.8614748483665;1143.845580846575;1150.666306771027;1162.3781277016756;1178.4402408855724;1184.040926849255;606.1998162425556;646.4602057282128;647.8186107889799;648.144449326884;650.890232154176;5294.788208471695;5342.465753424626;5966.522678185735;6005.249343832021;6093.390660933871;832.24681663095;839.8194388206565;847.5719761520393;852.5438890193717;863.1239292118505;3491.528643633128;3560.3769340365334;3607.2785442911522;3702.074481379655;3772.358699021173;12439.315837629018;12855.742885142245;12906.548270810665;12912.16070955385;13377;13331.866681333062;13586.252756098509;13596.25220612856;13600.31998400076;13603;6912.585244885323;7109.289071092952;7220.494565380373;7495.925040749523;7636.618169091523;5837.883242335045;5889.823305300848;5924.881502369843;5993.1720825147;6155.815325540241;12148.453319600463;12259.693507662023;12421.875781242072;12570.685732856386;12687.175333603287;12008.279503229835;12116.091293152873;12239.87760122423;12241.632751017483;12313.507459701512;9358.11097945694;9655.613775448903;9656.855147172939;9660.661876834278;9674.467904265333;9319.068093190626;9349.813003739751;9442.008589098046;9471.66849160276;9484.430934143973;7714.652840622073;7877.330426913776;7881.330086942674;7929.484583502054;8109.635066422144;8094.51432914027;8109.1890810920795;8172.427930045078;8288.378371622273;8317.293030092509;7064.116985376828;7189.640517974185;7189.964050179925;7190.856182876418;7193.460490463341;4887.34020907173;4989.790899742228;5039.067772462106;5154.587632989427;5241.528262456397;5013.197888337849;5037.57180639635;5099.69401835891;5148.279240906351;5177.456367081402 18:51:46 INFO - PID 27781 | |4;prototype.html;334.85935906919093;357.94451859961714;358.5410674336848;372.0568359209404;375.2008222486104;5515.365732940713;5610.803621873235;5643.746031428585;5667.518260947819;5670.1778242154915;5401.729913504329;5471.562275017999;5475.822698119903;5479.862853487143;5504;4146.3158578834455;4163.7501749894955;4164.687648426365;4166.812493437795;4174.08170202555;4154.459920210368;4179.770112643803;4180.602842729936;4185.539590645027;4189.685773566979;4134.297169481196;4135.152293779768;4154.086101057763;4162.959260184954;4169.937450938239;4139.337705967046;4151.024509240327;4155.545559054307;4172.207280616688;4179.331306990867;3644.963550364489;3651.233241019389;3654.634536546324;3656.049427148934;3657.9634203658156;5393.325834270716;5439.564834813205;5441.564674826004;5451.291332126838;5480.7533660984955;4951.430585482643;4955.603551715854;4963.280324352949;4965.081459929925;4992.201247800371;5879.235699359098;5906.700525884342;5917.408259174092;5922.4077592240865;5925.081612350093;4126.638209390894;4129.091599848029;4134.069834287291;4141.565135660742;4151.584841515854;5832.854178645525;6211.596246244025;6258.311585725566;6291.1506946562085;6298.811035668891;4186.372044193396;4204.201201771653;4238.300680387763;4251.893702657459;4261.914761704748;4287.742735435884;4288.078063216423;4296.119295544406;4302.720323179046;4305.590968857953;4768.260919557474;4907.631927605444;4923.458419573844;4925.802967881316;4940.357753492095;5828.863371642489;5832.475077243069;5842.328132264759;5844.678542680108;5856.619319744203;1448.7540714985105;1477.017783174177;1478.4381934864682;1478.475141324814;1483.243545791654;945.1493655709916;972.5040229482873;982.7739619887466;983.5426526665135;984.7144328144901;5032.949670503322;5085.364329458817;5100.1074811907765;5102.591792656579;5116.872078198;6049;6055.485283750842;6063.818085457443;6072.848178795565;6095.146679464879;5044.142495775727;5047.217681259411;5053.700566242351;5058.54473097423;5067.847964561069;3184.996726031293;3218.903432897017;3227.6288226854213;3240.930492937325;3261.918452038718;5634.267545219177;5635.126555383922;5641.548676105902;5647.858803529944;5668.971655141698;6127.785527506516;6211.59624624407;6242.469390101802;6292.874142517124;6313.285287326494;5616.915746263728;5625.549956003591;5636.85907852307;5649.943500565024;5653.802116925888;6026.969865150646;6030.547708921761;6060.818175454743;6077.24034495688;6097.664628445478;5880.382559831327;5995.370486098896;5996.280446346466;5997.730102145327;6013.939860601513;5356.812511562077;5582.916256256078;5602.971985140048;5606.635568688022;5661.688607126647;4168.24971505132;4184.539700632867;4199.643030342333;4203.180379825904;4203.180379825904;6042.879142417215;6067.666278354733;6068.9655172413795;6109.75560977556;6122.969385153046;5649.322081350264;5811.360750317377;5845.18167456548;5870.9412905872105;5888.234529511307;5851.444112809277;5873.530117590668;5887.911681324698;5894.174815525744;5897.3807750187325;5754.683492407958;5774.0761478163295;5783.132530120515;5833.066709326487;5840.970795146167;5951.583389162717;5960.701964901651;5967.1944287522365;5982.192404025575;5986.760529578768;5721.512406774185;5761.91357129635;5765.365809761007;5783.161441590862;5787.36339002701 18:51:46 INFO - PID 27781 | |5;yui.html;729.0449511140403;740.3595889555536;747.7158679701713;759.3773106053038;772.8956590860234;13104.737905241902;13722.519711810077;13770.586882393533;14083.436662533511;15498.61253468664;15615.687686246269;15714.135722535257;15746;15746.527604171864;15809.841901580981;891.7770557360643;898.3397203055749;899.1547944931776;901.058393978291;901.3330135699567;825.4510750351039;907.0249481807084;910;912.192709452133;916.2624087609472;969.1471505075559;970.1801977329145;970.5098925042879;971.4414211828228;971.8639390485338;966.8308046091905;967.6516454076527;969.1955676788284;970.5632465390603;970.6505657963128;710.9608971506565;711.2318695808515;712.6650474277081;712.994677504721;713.3829237709344;13205.735885282336;13259;13303.135296205812;13346.466141354334;13392.665183370396;15398.230088495531;15870.444534441354;15901.045937243687;15901.999999999884;15987.200639967956;12479;12720.427580758887;12721.745565088646;12923.741525169538;12943.093983421164;3064.7548196144253;3084.21352555097;3084.2135255509925;3093.1957691000503;3098.1170366445454;83431;83524;85122;85204.57397713033;85711.14288857095;12857.54998575064;12911.450625924948;12968.221906685629;13002.219866808022;13144.342782860818;23786.286411407684;24155.879220603783;24210.152644657705;24323.148689795773;24376.87811560931;5695.857603559944;5765.990951583456;5835.533157347402;5852.239208902815;5875.706214689249;2746.986265068662;2804.340979869729;2820.309024289021;2827.1377229945065;2833.1783782703196;4133.441985331941;4347.652187824967;4390.517043125254;4399.6920215584605;4425.5574442556135;734.9228331025272;758.5941521286086;765.3456294867808;775.0544335910181;775.6083177995189;551.8344496650989;568.6275489554348;579.342446323426;610.3592073282889;621.4158690830604;9690.273229507815;10045.748856278651;10148.949255253676;10564.313319634199;11017.779644407066;585.6632436349116;587.2864469669372;592.7303077099909;594.180031556458;610.697704636208;4651.581357677757;4774.259989701602;4833.347498087784;4880.951190488121;4997;85621.14378856131;87135.56432217926;88003;90552.5472372647;92408.53795730979;77985;79303;79802;81596.59201703954;81949;67770.66114669494;68037.3196268031;68047.19528047254;68121;71876.64061679658;9547.045295470398;9562.091601297865;9751.561179746786;9795.412275263507;9973.102420782165;28567.571486427303;28636;28697.42605147927;28906.27734306659;29403.264918377212;36985.52753268221;37239.6276037247;37323.44014839834;37988.81005594954;38474;12088.637340879788;12147.817782733442;12219.572314968933;12242.387880606113;12353.197042192229;13809;13938.790918136034;13948.930255348658;14030.649233769238;14204.857951420354;12285.57000504978;14131.64670883236;14179.22014289224;14415.044915792028;14607.488737894122;14101.929490352482;14479.20364379927;14548.563543093724;14585.854141458874;14860.108393496424;14100;14189.787153192918;14239.288035598385;14343.426262949783;14417.918656100625;9551.188149007412;9786.363886347364;9882.901170988485;10023.097921187129;10057.145142662663;10096.545655445669;10119.645812396826;10282.126019288444;10467.895321046997;10633.20250981195 18:51:46 INFO - PID 27781 | __end_tp_report 18:51:46 INFO - PID 27781 | __start_cc_report 18:51:46 INFO - PID 27781 | _x_x_mozilla_cycle_collect,400 18:51:46 INFO - PID 27781 | __end_cc_report 18:51:46 INFO - PID 27781 | __startTimestamp1496368306254__endTimestamp 18:51:46 INFO - PID 27781 | 18:51:46 INFO - PID 27781 | ------- Summary: start ------- 18:51:46 INFO - PID 27781 | Number of tests: 6 18:51:46 INFO - PID 27781 | 18:51:46 INFO - PID 27781 | [#0] dojo.html Cycles:165 Average:5194.53 Median:5328.09 stddev:624.54 (11.7%) stddev-sans-first:595.59 18:51:46 INFO - PID 27781 | Values: 2722.8 2725.4 2746.1 2762.1 2767.4 5206.6 5237.7 5247.6 5257.7 5279.5 5181.3 5218.2 5268.8 5275.2 5322.8 4473.7 4622.4 4649.0 4655.1 4656.4 4685.7 4708.1 4714.6 4718.7 4726.3 4587.9 4669.3 4679.6 4680.6 4763.2 4640.9 4641.1 4644.0 4667.7 4676.4 4556.5 4600.8 4620.4 4621.8 4647.5 5206.4 5217.9 5244.3 5252.4 5326.0 5656.2 5747.7 5751.1 5751.2 5761.6 5716.9 5720.8 5725.2 5734.4 5740.7 5296.7 5303.4 5308.0 5310.7 5346.2 5794.9 5896.7 5902.4 5987.4 5994.4 5539.9 5545.4 5553.0 5592.6 5599.7 5539.6 5632.4 5643.0 5648.5 5648.7 5614.4 5631.0 5631.5 5661.5 5736.7 5572.2 5634.4 5660.3 5663.2 5673.8 4732.2 4741.6 4745.6 4751.3 4790.9 4063.3 4064.5 4066.9 4082.0 4114.6 4748.6 4822.2 4834.7 4866.7 4906.4 5694.5 5703.3 5704.4 5728.5 5769.1 4781.1 4791.5 4796.5 4813.7 4844.8 4985.8 5023.6 5046.5 5051.7 5133.2 5287.0 5315.4 5325.1 5328.1 5340.7 5661.4 5663.1 5761.5 5796.7 5849.5 5216.8 5230.4 5305.3 5321.6 5322.1 5643.3 5652.5 5664.5 5673.2 5705.8 5761.0 5764.1 5791.2 5865.1 5899.3 5501.4 5522.7 5559.1 5566.5 5586.7 5475.2 5475.8 5476.5 5481.2 5503.1 5380.9 5390.7 5432.2 5441.1 5486.6 5523.4 5570.4 5626.3 5636.4 5666.8 5340.1 5356.3 5357.5 5375.3 5378.1 18:51:46 INFO - PID 27781 | 18:51:46 INFO - PID 27781 | [#1] ext.html Cycles:180 Average:31171.23 Median:30137.40 stddev:42904.83 (142.4%) stddev-sans-first:42964.09 18:51:46 INFO - PID 27781 | Values: 679.2 738.4 755.5 1096.4 1105.3 33563.2 34581.3 34668.8 34696.1 34763.8 34875.0 34976.5 35101.8 35194.0 35213.1 6711.6 6811.4 6842.3 6982.2 6988.4 6776.2 6853.5 6854.5 6855.6 6859.9 6805.7 6885.7 6900.9 6904.7 6904.8 6815.0 6845.7 6857.7 6865.3 6876.2 6738.2 6771.4 6772.9 6794.3 6796.9 32846.0 32861.5 32870.3 32903.8 32959.3 2994.3 3026.5 3026.8 3028.6 3034.2 25203.4 25317.1 25431.7 25492.5 25539.9 2493.5 2532.5 2538.2 2540.3 2543.7 143505.0 143753.0 157818.0 162633.2 164393.0 40327.0 40756.6 40790.2 40796.0 40826.0 42202.8 42279.6 42451.0 42462.0 42506.0 12482.5 12578.2 12606.6 12621.2 12650.2 10032.7 10066.0 10090.3 10119.5 10124.2 12917.7 12942.4 12986.0 12991.2 13092.6 5476.6 5557.4 5563.2 5569.7 5586.5 855.7 887.0 903.5 925.6 928.7 20841.8 21381.9 21699.8 21732.6 21932.5 972.2 979.9 980.2 991.9 1007.4 10986.2 11347.5 11376.4 11379.0 11561.5 186614.0 187421.0 188554.0 188766.0 188915.0 41709.6 42037.4 42172.8 42193.4 42206.0 1209.8 1229.6 1236.0 1239.3 1251.7 19340.0 19793.1 20075.0 20877.9 21315.5 29908.3 29952.7 30028.8 30086.4 30141.2 152360.0 152994.0 153056.0 153218.0 153905.0 29344.0 29524.6 30133.5 31275.5 31476.8 36480.8 37031.6 37081.8 37310.8 37394.3 26711.9 27435.0 27602.7 27835.3 28358.1 26675.2 27874.7 28628.7 28678.6 28734.0 32521.8 32554.3 32568.3 32598.5 32633.3 26655.9 26700.3 26857.6 27959.4 28114.3 21712.7 22593.0 22748.5 22777.8 22942.3 18:51:46 INFO - PID 27781 | 18:51:46 INFO - PID 27781 | [#2] jquery.html Cycles:180 Average:27013.70 Median:201815.94 stddev:64857.79 (32.1%) stddev-sans-first:65008.94 18:51:46 INFO - PID 27781 | Values: 393.8 418.0 428.8 435.2 444.5 16785.5 17329.7 17339.3 18321.0 19928.2 19241.7 19655.4 19688.8 19831.3 19862.3 5507.0 5642.5 5657.5 5667.7 5670.5 4904.6 4960.2 4965.5 4978.6 5659.7 4924.0 4961.0 4966.0 4967.0 4968.3 4870.1 4894.4 4919.1 4927.7 4944.9 4489.8 4517.0 4518.9 4520.6 4523.1 23848.9 24084.2 24104.5 24169.6 24209.9 1593.0 1646.3 1652.5 1652.6 1656.7 15660.5 15870.6 15884.0 15902.2 15987.0 2074.7 2083.5 2106.3 2121.8 2159.0 103448.0 105692.5 106131.0 106174.5 106683.0 11039.5 11370.0 11396.3 11526.9 11598.5 16299.1 16349.3 16382.3 16416.4 16427.1 7839.2 7980.6 8082.1 8151.1 8212.8 6568.4 7290.6 7303.1 7426.9 7474.4 7283.3 7366.8 7373.0 7404.6 7461.1 2076.7 2103.2 2108.5 2128.1 2259.1 783.6 851.0 856.3 875.9 877.7 17371.0 17746.0 17936.3 18125.6 18495.7 861.1 876.5 877.8 880.2 897.0 9674.4 9912.9 9939.9 9949.8 10105.1 379422.0 385196.0 386424.0 387818.0 390414.0 87564.6 87891.6 89043.0 89073.0 89281.0 1033.3 1038.6 1058.5 1063.8 1065.4 15284.8 15404.4 15804.7 16060.4 16508.1 42798.8 43709.6 43839.2 43968.0 46175.8 53520.5 54263.2 54553.5 54594.0 54674.0 7979.7 9066.7 9730.0 9777.2 9788.8 14424.9 14450.0 14526.1 15744.8 16705.6 13886.3 13982.8 14007.5 14037.0 14189.6 12248.3 12253.9 12565.7 13180.7 13346.6 13843.9 13892.4 14122.1 14210.7 14264.6 9534.5 9571.4 9585.4 9618.3 9620.9 13269.4 13398.7 13404.9 13431.5 13441.7 18:51:46 INFO - PID 27781 | 18:51:46 INFO - PID 27781 | [#3] mootools.html Cycles:180 Average:6241.15 Median:3854.47 stddev:4070.08 (105.6%) stddev-sans-first:4064.09 18:51:46 INFO - PID 27781 | Values: 1230.7 1249.2 1263.4 1280.8 1292.7 9856.7 10217.5 10365.7 10365.8 10563.6 10252.9 10346.8 10362.7 10419.1 10462.8 2087.2 2119.1 2131.2 2139.7 2140.9 1924.8 1969.7 1979.7 1984.4 1993.6 1921.8 1939.5 1951.6 1958.8 1966.0 1794.8 1803.9 1804.2 1804.5 1813.9 1920.1 1949.4 1962.1 1996.9 2001.1 9717.8 9803.5 9804.7 9808.3 9813.6 5500.6 5688.0 5692.4 5703.1 5718.9 3101.9 3180.7 3273.1 3276.7 3281.0 1027.4 1033.1 1043.3 1055.0 1055.6 14019.0 14040.9 14058.8 14067.8 14429.1 4624.9 4682.0 4787.3 4824.2 4837.5 11135.5 11215.0 11224.3 11260.7 11276.4 5369.8 5473.6 5490.3 5505.5 5517.5 5013.7 5054.7 5073.5 5077.1 5086.7 3830.1 3833.4 3875.6 3930.8 3957.9 1143.8 1150.7 1162.4 1178.4 1184.0 606.2 646.5 647.8 648.1 650.9 5294.8 5342.5 5966.5 6005.2 6093.4 832.2 839.8 847.6 852.5 863.1 3491.5 3560.4 3607.3 3702.1 3772.4 12439.3 12855.7 12906.5 12912.2 13377.0 13331.9 13586.3 13596.3 13600.3 13603.0 6912.6 7109.3 7220.5 7495.9 7636.6 5837.9 5889.8 5924.9 5993.2 6155.8 12148.5 12259.7 12421.9 12570.7 12687.2 12008.3 12116.1 12239.9 12241.6 12313.5 9358.1 9655.6 9656.9 9660.7 9674.5 9319.1 9349.8 9442.0 9471.7 9484.4 7714.7 7877.3 7881.3 7929.5 8109.6 8094.5 8109.2 8172.4 8288.4 8317.3 7064.1 7189.6 7190.0 7190.9 7193.5 4887.3 4989.8 5039.1 5154.6 5241.5 5013.2 5037.6 5099.7 5148.3 5177.5 18:51:46 INFO - PID 27781 | 18:51:46 INFO - PID 27781 | [#4] prototype.html Cycles:180 Average:4837.30 Median:5509.68 stddev:1437.25 (26.1%) stddev-sans-first:1400.99 18:51:46 INFO - PID 27781 | Values: 334.9 357.9 358.5 372.1 375.2 5515.4 5610.8 5643.7 5667.5 5670.2 5401.7 5471.6 5475.8 5479.9 5504.0 4146.3 4163.8 4164.7 4166.8 4174.1 4154.5 4179.8 4180.6 4185.5 4189.7 4134.3 4135.2 4154.1 4163.0 4169.9 4139.3 4151.0 4155.5 4172.2 4179.3 3645.0 3651.2 3654.6 3656.0 3658.0 5393.3 5439.6 5441.6 5451.3 5480.8 4951.4 4955.6 4963.3 4965.1 4992.2 5879.2 5906.7 5917.4 5922.4 5925.1 4126.6 4129.1 4134.1 4141.6 4151.6 5832.9 6211.6 6258.3 6291.2 6298.8 4186.4 4204.2 4238.3 4251.9 4261.9 4287.7 4288.1 4296.1 4302.7 4305.6 4768.3 4907.6 4923.5 4925.8 4940.4 5828.9 5832.5 5842.3 5844.7 5856.6 1448.8 1477.0 1478.4 1478.5 1483.2 945.1 972.5 982.8 983.5 984.7 5032.9 5085.4 5100.1 5102.6 5116.9 6049.0 6055.5 6063.8 6072.8 6095.1 5044.1 5047.2 5053.7 5058.5 5067.8 3185.0 3218.9 3227.6 3240.9 3261.9 5634.3 5635.1 5641.5 5647.9 5669.0 6127.8 6211.6 6242.5 6292.9 6313.3 5616.9 5625.5 5636.9 5649.9 5653.8 6027.0 6030.5 6060.8 6077.2 6097.7 5880.4 5995.4 5996.3 5997.7 6013.9 5356.8 5582.9 5603.0 5606.6 5661.7 4168.2 4184.5 4199.6 4203.2 4203.2 6042.9 6067.7 6069.0 6109.8 6123.0 5649.3 5811.4 5845.2 5870.9 5888.2 5851.4 5873.5 5887.9 5894.2 5897.4 5754.7 5774.1 5783.1 5833.1 5841.0 5951.6 5960.7 5967.2 5982.2 5986.8 5721.5 5761.9 5765.4 5783.2 5787.4 18:51:46 INFO - PID 27781 | 18:51:46 INFO - PID 27781 | [#5] yui.html Cycles:180 Average:17626.61 Median:21303.72 stddev:23929.07 (112.3%) stddev-sans-first:23962.56 18:51:46 INFO - PID 27781 | Values: 729.0 740.4 747.7 759.4 772.9 13104.7 13722.5 13770.6 14083.4 15498.6 15615.7 15714.1 15746.0 15746.5 15809.8 891.8 898.3 899.2 901.1 901.3 825.5 907.0 910.0 912.2 916.3 969.1 970.2 970.5 971.4 971.9 966.8 967.7 969.2 970.6 970.7 711.0 711.2 712.7 713.0 713.4 13205.7 13259.0 13303.1 13346.5 13392.7 15398.2 15870.4 15901.0 15902.0 15987.2 12479.0 12720.4 12721.7 12923.7 12943.1 3064.8 3084.2 3084.2 3093.2 3098.1 83431.0 83524.0 85122.0 85204.6 85711.1 12857.5 12911.5 12968.2 13002.2 13144.3 23786.3 24155.9 24210.2 24323.1 24376.9 5695.9 5766.0 5835.5 5852.2 5875.7 2747.0 2804.3 2820.3 2827.1 2833.2 4133.4 4347.7 4390.5 4399.7 4425.6 734.9 758.6 765.3 775.1 775.6 551.8 568.6 579.3 610.4 621.4 9690.3 10045.7 10148.9 10564.3 11017.8 585.7 587.3 592.7 594.2 610.7 4651.6 4774.3 4833.3 4881.0 4997.0 85621.1 87135.6 88003.0 90552.5 92408.5 77985.0 79303.0 79802.0 81596.6 81949.0 67770.7 68037.3 68047.2 68121.0 71876.6 9547.0 9562.1 9751.6 9795.4 9973.1 28567.6 28636.0 28697.4 28906.3 29403.3 36985.5 37239.6 37323.4 37988.8 38474.0 12088.6 12147.8 12219.6 12242.4 12353.2 13809.0 13938.8 13948.9 14030.6 14204.9 12285.6 14131.6 14179.2 14415.0 14607.5 14101.9 14479.2 14548.6 14585.9 14860.1 14100.0 14189.8 14239.3 14343.4 14417.9 9551.2 9786.4 9882.9 10023.1 10057.1 10096.5 10119.6 10282.1 10467.9 10633.2 18:51:46 INFO - PID 27781 | -------- Summary: end -------- 18:51:46 INFO - PID 27781 | 18:51:47 INFO - TEST-INFO | 27781: exit 0 18:51:47 INFO - TEST-OK | dromaeo_css | took 1147423ms 18:51:47 INFO - TEST-START | kraken 18:51:47 INFO - operating with platform_type : linux_ 18:51:47 INFO - Initialising browser for kraken test... 18:51:47 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49593/getInfo.html -profile /tmp/tmp9YytcH/profile 18:51:47 INFO - TEST-INFO | started process 28181 (/builds/slave/test/build/application/firefox/firefox http://localhost:49593/getInfo.html) 18:52:22 INFO - TEST-INFO | 28181: killed by SIGTERM 18:52:22 INFO - Browser initialized. 18:52:22 INFO - Running cycle 1/1 for kraken test... 18:52:22 INFO - TEST-INFO | started process 28388 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9YytcH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:52:34 INFO - PID 28388 | RSS: Main: 184053760 18:52:34 INFO - PID 28388 | 18:52:36 INFO - PID 28388 | Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49593/tests/kraken/driver.html?testName=audio-beat-detection) 18:52:37 INFO - PID 28388 | RSS: Main: 187604992 18:52:37 INFO - PID 28388 | 18:52:40 INFO - PID 28388 | Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49593/tests/kraken/driver.html?testName=audio-dft) 18:52:41 INFO - PID 28388 | RSS: Main: 186028032 18:52:41 INFO - PID 28388 | 18:52:44 INFO - PID 28388 | Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49593/tests/kraken/driver.html?testName=audio-fft) 18:52:44 INFO - PID 28388 | RSS: Main: 181153792 18:52:44 INFO - PID 28388 | 18:52:46 INFO - PID 28388 | Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49593/tests/kraken/driver.html?testName=audio-oscillator) 18:52:47 INFO - PID 28388 | RSS: Main: 182042624 18:52:47 INFO - PID 28388 | 18:52:49 INFO - PID 28388 | Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49593/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:52:50 INFO - PID 28388 | RSS: Main: 182333440 18:52:50 INFO - PID 28388 | 18:52:53 INFO - PID 28388 | Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49593/tests/kraken/driver.html?testName=imaging-darkroom) 18:52:54 INFO - PID 28388 | RSS: Main: 183341056 18:52:54 INFO - PID 28388 | 18:52:57 INFO - PID 28388 | Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49593/tests/kraken/driver.html?testName=imaging-desaturate) 18:52:58 INFO - PID 28388 | RSS: Main: 182239232 18:52:58 INFO - PID 28388 | 18:53:01 INFO - PID 28388 | Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49593/tests/kraken/driver.html?testName=json-parse-financial) 18:53:01 INFO - PID 28388 | RSS: Main: 183046144 18:53:01 INFO - PID 28388 | 18:53:03 INFO - PID 28388 | Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49593/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:53:03 INFO - PID 28388 | RSS: Main: 183599104 18:53:03 INFO - PID 28388 | 18:53:05 INFO - PID 28388 | Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49593/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:53:06 INFO - PID 28388 | RSS: Main: 183508992 18:53:06 INFO - PID 28388 | 18:53:08 INFO - PID 28388 | Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49593/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:53:09 INFO - PID 28388 | RSS: Main: 183480320 18:53:09 INFO - PID 28388 | 18:53:12 INFO - PID 28388 | Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49593/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:53:12 INFO - PID 28388 | RSS: Main: 183500800 18:53:12 INFO - PID 28388 | 18:53:15 INFO - PID 28388 | Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49593/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:53:16 INFO - PID 28388 | RSS: Main: 183332864 18:53:16 INFO - PID 28388 | 18:53:18 INFO - PID 28388 | Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49593/tests/kraken/driver.html?testName=ai-astar) 18:53:18 INFO - PID 28388 | RSS: Main: 184922112 18:53:18 INFO - PID 28388 | 18:53:18 INFO - PID 28388 | __start_tp_report 18:53:18 INFO - PID 28388 | _x_x_mozilla_page_load 18:53:18 INFO - PID 28388 | _x_x_mozilla_page_load_details 18:53:18 INFO - PID 28388 | |i|pagename|runs| 18:53:18 INFO - PID 28388 | |0;ai-astar;102;110;109;110;109;111;109;109;110;110 18:53:18 INFO - PID 28388 | |1;audio-beat-detection;153;125;128;172;123;122;123;122;149;129 18:53:18 INFO - PID 28388 | |2;audio-dft;164;164;163;163;167;167;167;169;163;164 18:53:18 INFO - PID 28388 | |3;audio-fft;74;75;74;110;74;76;74;73;96;74 18:53:18 INFO - PID 28388 | |4;audio-oscillator;85;83;105;85;84;83;99;83;83;105 18:53:18 INFO - PID 28388 | |5;imaging-gaussian-blur;118;115;114;114;114;113;117;116;121;114 18:53:18 INFO - PID 28388 | |6;imaging-darkroom;153;150;150;152;150;152;150;150;151;151 18:53:18 INFO - PID 28388 | |7;imaging-desaturate;94;94;95;94;94;94;94;95;95;94 18:53:18 INFO - PID 28388 | |8;json-parse-financial;56;57;57;55;55;54;56;64;56;55 18:53:18 INFO - PID 28388 | |9;json-stringify-tinderbox;56;55;59;55;56;56;56;56;59;56 18:53:18 INFO - PID 28388 | |10;stanford-crypto-aes;101;87;93;86;87;88;87;87;123;90 18:53:18 INFO - PID 28388 | |11;stanford-crypto-ccm;131;133;133;139;129;141;128;142;134;152 18:53:18 INFO - PID 28388 | |12;stanford-crypto-pbkdf2;190;195;191;191;197;194;199;189;200;191 18:53:18 INFO - PID 28388 | |13;stanford-crypto-sha256-iterative;70;71;70;82;71;75;76;71;72;73 18:53:18 INFO - PID 28388 | __end_tp_report 18:53:18 INFO - PID 28388 | __start_cc_report 18:53:18 INFO - PID 28388 | _x_x_mozilla_cycle_collect,1060 18:53:18 INFO - PID 28388 | __end_cc_report 18:53:18 INFO - PID 28388 | __startTimestamp1496368398646__endTimestamp 18:53:18 INFO - PID 28388 | 18:53:18 INFO - PID 28388 | ------- Summary: start ------- 18:53:18 INFO - PID 28388 | Number of tests: 14 18:53:18 INFO - PID 28388 | 18:53:18 INFO - PID 28388 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.00 stddev:2.51 (2.3%) stddev-sans-first:0.71 18:53:18 INFO - PID 28388 | Values: 102.0 110.0 109.0 110.0 109.0 111.0 109.0 109.0 110.0 110.0 18:53:18 INFO - PID 28388 | 18:53:18 INFO - PID 28388 | [#1] audio-beat-detection Cycles:10 Average:134.60 Median:128.50 stddev:17.32 (13.5%) stddev-sans-first:17.04 18:53:18 INFO - PID 28388 | Values: 153.0 125.0 128.0 172.0 123.0 122.0 123.0 122.0 149.0 129.0 18:53:18 INFO - PID 28388 | 18:53:18 INFO - PID 28388 | [#2] audio-dft Cycles:10 Average:165.10 Median:165.50 stddev:2.18 (1.3%) stddev-sans-first:2.28 18:53:18 INFO - PID 28388 | Values: 164.0 164.0 163.0 163.0 167.0 167.0 167.0 169.0 163.0 164.0 18:53:18 INFO - PID 28388 | 18:53:18 INFO - PID 28388 | [#3] audio-fft Cycles:10 Average:80.00 Median:74.00 stddev:12.59 (17.0%) stddev-sans-first:13.16 18:53:18 INFO - PID 28388 | Values: 74.0 75.0 74.0 110.0 74.0 76.0 74.0 73.0 96.0 74.0 18:53:18 INFO - PID 28388 | 18:53:18 INFO - PID 28388 | [#4] audio-oscillator Cycles:10 Average:89.50 Median:83.50 stddev:9.49 (11.4%) stddev-sans-first:9.92 18:53:18 INFO - PID 28388 | Values: 85.0 83.0 105.0 85.0 84.0 83.0 99.0 83.0 83.0 105.0 18:53:18 INFO - PID 28388 | 18:53:18 INFO - PID 28388 | [#5] imaging-gaussian-blur Cycles:10 Average:115.60 Median:115.50 stddev:2.46 (2.1%) stddev-sans-first:2.45 18:53:18 INFO - PID 28388 | Values: 118.0 115.0 114.0 114.0 114.0 113.0 117.0 116.0 121.0 114.0 18:53:18 INFO - PID 28388 | 18:53:18 INFO - PID 28388 | [#6] imaging-darkroom Cycles:10 Average:150.90 Median:151.00 stddev:1.10 (0.7%) stddev-sans-first:0.87 18:53:18 INFO - PID 28388 | Values: 153.0 150.0 150.0 152.0 150.0 152.0 150.0 150.0 151.0 151.0 18:53:18 INFO - PID 28388 | 18:53:18 INFO - PID 28388 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 18:53:18 INFO - PID 28388 | Values: 94.0 94.0 95.0 94.0 94.0 94.0 94.0 95.0 95.0 94.0 18:53:18 INFO - PID 28388 | 18:53:18 INFO - PID 28388 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:56.00 stddev:2.80 (5.0%) stddev-sans-first:2.96 18:53:18 INFO - PID 28388 | Values: 56.0 57.0 57.0 55.0 55.0 54.0 56.0 64.0 56.0 55.0 18:53:18 INFO - PID 28388 | 18:53:18 INFO - PID 28388 | [#9] json-stringify-tinderbox Cycles:10 Average:56.40 Median:56.00 stddev:1.43 (2.6%) stddev-sans-first:1.51 18:53:18 INFO - PID 28388 | Values: 56.0 55.0 59.0 55.0 56.0 56.0 56.0 56.0 59.0 56.0 18:53:18 INFO - PID 28388 | 18:53:18 INFO - PID 28388 | [#10] stanford-crypto-aes Cycles:10 Average:92.90 Median:87.00 stddev:11.50 (13.2%) stddev-sans-first:11.82 18:53:18 INFO - PID 28388 | Values: 101.0 87.0 93.0 86.0 87.0 88.0 87.0 87.0 123.0 90.0 18:53:18 INFO - PID 28388 | 18:53:18 INFO - PID 28388 | [#11] stanford-crypto-ccm Cycles:10 Average:136.20 Median:136.50 stddev:7.35 (5.4%) stddev-sans-first:7.55 18:53:18 INFO - PID 28388 | Values: 131.0 133.0 133.0 139.0 129.0 141.0 128.0 142.0 134.0 152.0 18:53:18 INFO - PID 28388 | 18:53:18 INFO - PID 28388 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.70 Median:194.50 stddev:3.92 (2.0%) stddev-sans-first:3.92 18:53:18 INFO - PID 28388 | Values: 190.0 195.0 191.0 191.0 197.0 194.0 199.0 189.0 200.0 191.0 18:53:18 INFO - PID 28388 | 18:53:18 INFO - PID 28388 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.10 Median:72.50 stddev:3.73 (5.1%) stddev-sans-first:3.78 18:53:18 INFO - PID 28388 | Values: 70.0 71.0 70.0 82.0 71.0 75.0 76.0 71.0 72.0 73.0 18:53:18 INFO - PID 28388 | -------- Summary: end -------- 18:53:18 INFO - PID 28388 | 18:53:19 INFO - TEST-INFO | 28388: exit 0 18:53:19 INFO - TEST-OK | kraken | took 92704ms 18:53:19 INFO - SUITE-END | took 1240s 18:53:20 INFO - Completed test suite (00:20:40) 18:53:20 INFO - javascript benchmark 18:53:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6833.933336005667, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2722.768564672003, 2725.359540507981, 2746.1075150576057, 2762.116122840692, 2767.41884204317, 5206.609504287184, 5237.685738855671, 5247.606429517792, 5257.737113144337, 5279.472052794718, 5181.274621552976, 5218.21726740989, 5268.762905669245, 5275.155975043994, 5322.840314790553, 4473.681662842592, 4622.352870598119, 4649.0, 4655.13879932212, 4656.441227052758, 4685.742284174369, 4708.105459962596, 4714.599259062984, 4718.740469274188, 4726.267428548564, 4587.8623641290815, 4669.322948172496, 4679.625629949596, 4680.64895132863, 4763.190257656207, 4640.930386044212, 4641.0949864776385, 4643.953560464386, 4667.696599721041, 4676.392069031038, 4556.498785133633, 4600.838970636045, 4620.353150558924, 4621.8151273949, 4647.488776234612, 5206.427292997767, 5217.921731174036, 5244.318238628954, 5252.395974462947, 5326.0, 5656.151577263443, 5747.6551406915305, 5751.079827227623, 5751.166080918285, 5761.567882408836, 5716.885662286731, 5720.771169153229, 5725.1698503716725, 5734.4265573442735, 5740.655560666373, 5296.735163241861, 5303.390110137307, 5308.018016666929, 5310.681359118388, 5346.171343441695, 5794.913076303858, 5896.734646940898, 5902.380250073767, 5987.43119403656, 5994.430529099728, 5539.944600554023, 5545.390007099216, 5553.0, 5592.636478628876, 5599.720013999284, 5539.639923404966, 5632.436756324417, 5642.971785141048, 5648.4633959773755, 5648.6893220872425, 5614.438556144434, 5630.971845140748, 5631.465010823965, 5661.49046585801, 5736.741846616912, 5572.164175373727, 5634.408387119375, 5660.26416565852, 5663.150527420919, 5673.773049078073, 4732.195526760459, 4741.620670346433, 4745.572898439157, 4751.3348131261655, 4790.880227994258, 4063.329550624114, 4064.4919385076864, 4066.877993660195, 4082.040720430696, 4114.6091121343425, 4748.596369308579, 4822.204336284544, 4834.685745426536, 4866.732329721828, 4906.411230652345, 5694.4590263924865, 5703.258576385127, 5704.429557044263, 5728.48443640066, 5769.105788602773, 4781.139394908881, 4791.520847915251, 4796.496367881392, 4813.687110337887, 4844.806207751651, 4985.750712464363, 5023.572996295356, 5046.545810876965, 5051.747412629354, 5133.204353325241, 5286.97356513215, 5315.441878602691, 5325.09473389517, 5328.094223981855, 5340.679559226303, 5661.377248502579, 5663.122216056518, 5761.5102716269585, 5796.739146738491, 5849.473547380756, 5216.791328346975, 5230.398504172069, 5305.283786688748, 5321.627486075938, 5322.068637988414, 5643.294588176478, 5652.463016013472, 5664.518515926193, 5673.205751194753, 5705.771769129188, 5761.049426844691, 5764.07774756037, 5791.189233507396, 5865.061590145556, 5899.262592175978, 5501.394846566955, 5522.66863988162, 5559.138333558305, 5566.4990150885, 5586.692731899622, 5475.151351540518, 5475.780968761364, 5476.507114359727, 5481.205225242238, 5503.091989821634, 5380.865478363072, 5390.703511306916, 5432.18517222404, 5441.129419293053, 5486.588505861996, 5523.364813046551, 5570.44295570456, 5626.2685850839125, 5636.436356364331, 5666.801661941812, 5340.092184328596, 5356.330458692663, 5357.517823395913, 5375.3012108425655, 5378.058839703114], "value": 5148.503480504518, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.1510611735331, 738.420340033074, 755.4522970846137, 1096.4079397125552, 1105.303658695022, 33563.16092097699, 34581.30837383251, 34668.82665586669, 34696.13259668506, 34763.826180869124, 34875.0, 34976.475352869726, 35101.82449087751, 35194.0, 35213.119672008215, 6711.597304161742, 6811.352921472452, 6842.315768423167, 6982.162140543117, 6988.371046605805, 6776.15298087739, 6853.485988550854, 6854.485913556478, 6855.58866468011, 6859.897101543456, 6805.6597170141295, 6885.690143943534, 6900.930990690104, 6904.654767261642, 6904.827379315507, 6815.045893574904, 6845.657717114124, 6857.691403886787, 6865.313468653145, 6876.209235937881, 6738.22510411304, 6771.424428923548, 6772.8984065239065, 6794.286599907037, 6796.864062718718, 32846.0, 32861.50707739386, 32870.34259314824, 32903.83548082244, 32959.340813183844, 2994.31130839908, 3026.455238057149, 3026.757859371245, 3028.5911401960675, 3034.150437877398, 25203.369915752068, 25317.113901013377, 25431.745682543307, 25492.490150197078, 25539.872300638563, 2493.4888347888823, 2532.493501299729, 2538.1624064058815, 2540.314115188907, 2543.682039745032, 143505.0, 143753.0, 157818.0, 162633.18683406626, 164393.0, 40327.0, 40756.59243407587, 40790.18419631591, 40796.0, 40826.0, 42202.788986054875, 42279.577204227564, 42451.0, 42462.0, 42506.0, 12482.50069997208, 12578.245305281713, 12606.621801345975, 12621.24272543632, 12650.240985540897, 10032.69901902944, 10066.0, 10090.293679442368, 10119.494025298705, 10124.240681948737, 12917.741645167043, 12942.352882355844, 12986.0, 12991.155574887602, 13092.607221783363, 5476.644018138888, 5557.360903496069, 5563.193336966117, 5569.721513924287, 5586.469285417878, 855.6705668317743, 886.9778255543663, 903.5437104262305, 925.6482536636036, 928.6517555916531, 20841.79158208429, 21381.893090534446, 21699.78300217009, 21732.565348692937, 21932.45168870791, 972.2222222222194, 979.8579206015088, 980.2305190425482, 991.9206463482905, 1007.4408703169664, 10986.176036797273, 11347.489362978686, 11376.374299413612, 11379.032782213604, 11561.537538498365, 186614.0, 187421.0, 188554.0, 188766.0, 188915.0, 41709.58290417057, 42037.36943945843, 42172.789136054125, 42193.36709949353, 42206.0, 1209.7520008398258, 1229.557359350633, 1235.9814602780966, 1239.293602646483, 1251.6620512461584, 19340.0, 19793.109310080792, 20075.0, 20877.89561052185, 21315.46711332229, 29908.252293692833, 29952.70047299499, 30028.849855751454, 30086.398272034876, 30141.246468838453, 152360.0, 152994.0, 153056.0, 153218.0, 153905.0, 29344.0, 29524.557131642614, 30133.547996779627, 31275.53086703747, 31476.842615786776, 36480.81759591185, 37031.62968370282, 37081.81459092687, 37310.81344593368, 37394.25211495809, 26711.866440667673, 27435.0, 27602.723972760014, 27835.304117397227, 28358.14925552154, 26675.19974400771, 27874.721252788026, 28628.713712862605, 28678.569821452278, 28734.0, 32521.837390812896, 32554.348913021135, 32568.348633026733, 32598.51102233516, 32633.34733305368, 26655.866720666272, 26700.332491687088, 26857.597136043365, 27959.440811183256, 28114.2971425716, 21712.67430988505, 22593.0, 22748.545029099656, 22777.772222277566, 22942.311730648107], "value": 14613.194224760346, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.78735482839267, 418.0451274355514, 428.8434721326715, 435.2426777407311, 444.488837836488, 16785.49643510695, 17329.740053899186, 17339.30642774289, 18321.0, 19928.202871885143, 19241.711374329396, 19655.410337689857, 19688.803111968875, 19831.305904293353, 19862.304819331326, 5506.972465137679, 5642.492175704186, 5657.519110875581, 5667.688277144755, 5670.518005969498, 4904.558589726924, 4960.23116416956, 4965.503449655023, 4978.5562186965735, 5659.745311460973, 4923.950760492385, 4961.032598643266, 4965.975170124144, 4966.9751651241695, 4968.329275547809, 4870.0746858096845, 4894.437139728905, 4919.13915064864, 4927.679700819471, 4944.901101977958, 4489.820407183742, 4517.0, 4518.864434066983, 4520.570545798144, 4523.095380923795, 23848.880755596285, 24084.157054503183, 24104.517909641883, 24169.637455438184, 24209.878950605133, 1592.9681406371808, 1646.2509558151012, 1652.512508809904, 1652.6116362654766, 1656.7183578791635, 15660.451884183998, 15870.603234919105, 15884.0, 15902.204889755581, 15987.0, 2074.6991686205415, 2083.4687154775434, 2106.304919376602, 2121.755998060212, 2158.9784102158933, 103448.0, 105692.47153764259, 106130.99999999923, 106174.46912765464, 106683.0, 11039.503222355013, 11370.0, 11396.316221026766, 11526.942365288287, 11598.478068486938, 16299.103549304902, 16349.264283107288, 16382.344706211856, 16416.4254251103, 16427.096509691844, 7839.216078392115, 7980.640871160812, 8082.070561885458, 8151.062627797879, 8212.753617391489, 6568.441682457044, 7290.5625662460425, 7303.123625165014, 7426.9257307427315, 7474.364679002346, 7283.313247933137, 7366.815829604303, 7373.0, 7404.556111558194, 7461.1419686735635, 2076.709260703503, 2103.24283258027, 2108.483421561727, 2128.095559387254, 2259.096361455398, 783.6238605469407, 850.9574521274035, 856.3406177243488, 875.92992560595, 877.7279043496536, 17371.0, 17746.0, 17936.282548698167, 18125.63748725018, 18495.722564161548, 861.1216559109798, 876.4872549558452, 877.8463768840427, 880.190224993008, 896.9596368163449, 9674.419534827934, 9912.851307230398, 9939.900600994042, 9949.801003980025, 10105.090541851268, 379422.0, 385196.0, 386424.0, 387818.0, 390414.0, 87564.56217718998, 87891.56054219688, 89042.97919780746, 89073.0, 89281.0, 1033.2715435617872, 1038.6364772329775, 1058.5448257249457, 1063.7712891728315, 1065.3607835298758, 15284.847151528342, 15404.38382464689, 15804.68390632204, 16060.35758569691, 16508.092054937093, 42798.78600606977, 43709.56290437182, 43839.22666494223, 43968.0, 46175.76912115552, 53520.464795351545, 54263.18605220846, 54553.45446545484, 54594.0, 54674.0, 7979.680812767424, 9066.682666106655, 9730.0, 9777.21782257432, 9788.804223915624, 14424.927875360556, 14450.0377422626, 14526.128432294096, 15744.772321674258, 16705.582360441087, 13886.305684715926, 13982.790258146339, 14007.509737159151, 14037.0, 14189.645258868612, 12248.326342050916, 12253.877461225631, 12565.748685026065, 13180.693378658889, 13346.599602011955, 13843.861561384258, 13892.374843132286, 14122.082064665763, 14210.715785684435, 14264.572062838131, 9534.475603841578, 9571.37786043905, 9585.376950498196, 9618.278629102706, 9620.855687164838, 13269.40287687037, 13398.732025359634, 13404.865951340751, 13431.529896453969, 13441.663958401119], "value": 9359.53482672957, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1230.7230873053563, 1249.244207254611, 1263.3809433377637, 1280.8270883430735, 1292.734989327188, 9856.655017074403, 10217.540210690519, 10365.689029329124, 10365.792684146321, 10563.630272940449, 10252.948735256314, 10346.793064138712, 10362.740931476697, 10419.114375278092, 10462.790744185131, 2087.1755656515707, 2119.07820098257, 2131.1794958940764, 2139.711138996239, 2140.8715477071346, 1924.7594050743658, 1969.7340858984069, 1979.6535606268844, 1984.3848406993877, 1993.6012797440496, 1921.8174273444001, 1939.4666466721624, 1951.6096780643857, 1958.8334991525737, 1965.9803401966012, 1794.7935987361425, 1803.9368622098164, 1804.1520485371855, 1804.49474147239, 1813.945581632553, 1920.0591710062108, 1949.3567122849568, 1962.1464662871697, 1996.9201231950703, 2001.1295086637215, 9717.805643887154, 9803.509824508747, 9804.705858824176, 9808.264380171444, 9813.607455701764, 5500.559955203614, 5688.0, 5692.37383887772, 5703.116017017369, 5718.885622287573, 3101.875924962999, 3180.7296379807744, 3273.06717585487, 3276.6723327667282, 3280.9671903281137, 1027.398971601614, 1033.1424917318682, 1043.3218408034763, 1054.9630762923261, 1055.6252530351692, 14019.0, 14040.85959140416, 14058.789118163133, 14067.788983165261, 14429.134251944812, 4624.907501849944, 4682.0, 4787.329773831666, 4824.204006338915, 4837.4920633333695, 11135.498902549405, 11215.04672102864, 11224.326540407601, 11260.718482037852, 11276.436178191057, 5369.838904832861, 5473.589480788877, 5490.258815059916, 5505.504504594605, 5517.531009864207, 5013.749312534359, 5054.721990290495, 5073.492650734971, 5077.060743762416, 5086.72023038729, 3830.138218900725, 3833.3674943633987, 3875.5736868944396, 3930.76415415076, 3957.8614748483665, 1143.845580846575, 1150.666306771027, 1162.3781277016756, 1178.4402408855724, 1184.040926849255, 606.1998162425556, 646.4602057282128, 647.8186107889799, 648.144449326884, 650.890232154176, 5294.788208471695, 5342.465753424626, 5966.522678185735, 6005.249343832021, 6093.390660933871, 832.24681663095, 839.8194388206565, 847.5719761520393, 852.5438890193717, 863.1239292118505, 3491.528643633128, 3560.3769340365334, 3607.2785442911522, 3702.074481379655, 3772.358699021173, 12439.315837629018, 12855.742885142245, 12906.548270810665, 12912.16070955385, 13377.0, 13331.866681333062, 13586.252756098509, 13596.25220612856, 13600.31998400076, 13603.0, 6912.585244885323, 7109.289071092952, 7220.494565380373, 7495.925040749523, 7636.618169091523, 5837.883242335045, 5889.823305300848, 5924.881502369843, 5993.1720825147, 6155.815325540241, 12148.453319600463, 12259.693507662023, 12421.875781242072, 12570.685732856386, 12687.175333603287, 12008.279503229835, 12116.091293152873, 12239.87760122423, 12241.632751017483, 12313.507459701512, 9358.11097945694, 9655.613775448903, 9656.855147172939, 9660.661876834278, 9674.467904265333, 9319.068093190626, 9349.813003739751, 9442.008589098046, 9471.66849160276, 9484.430934143973, 7714.652840622073, 7877.330426913776, 7881.330086942674, 7929.484583502054, 8109.635066422144, 8094.51432914027, 8109.1890810920795, 8172.427930045078, 8288.378371622273, 8317.293030092509, 7064.116985376828, 7189.640517974185, 7189.964050179925, 7190.856182876418, 7193.460490463341, 4887.34020907173, 4989.790899742228, 5039.067772462106, 5154.587632989427, 5241.528262456397, 5013.197888337849, 5037.57180639635, 5099.69401835891, 5148.279240906351, 5177.456367081402], "value": 4636.315555175245, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.85935906919093, 357.94451859961714, 358.5410674336848, 372.0568359209404, 375.2008222486104, 5515.365732940713, 5610.803621873235, 5643.746031428585, 5667.518260947819, 5670.1778242154915, 5401.729913504329, 5471.562275017999, 5475.822698119903, 5479.862853487143, 5504.0, 4146.3158578834455, 4163.7501749894955, 4164.687648426365, 4166.812493437795, 4174.08170202555, 4154.459920210368, 4179.770112643803, 4180.602842729936, 4185.539590645027, 4189.685773566979, 4134.297169481196, 4135.152293779768, 4154.086101057763, 4162.959260184954, 4169.937450938239, 4139.337705967046, 4151.024509240327, 4155.545559054307, 4172.207280616688, 4179.331306990867, 3644.963550364489, 3651.233241019389, 3654.634536546324, 3656.049427148934, 3657.9634203658156, 5393.325834270716, 5439.564834813205, 5441.564674826004, 5451.291332126838, 5480.7533660984955, 4951.430585482643, 4955.603551715854, 4963.280324352949, 4965.081459929925, 4992.201247800371, 5879.235699359098, 5906.700525884342, 5917.408259174092, 5922.4077592240865, 5925.081612350093, 4126.638209390894, 4129.091599848029, 4134.069834287291, 4141.565135660742, 4151.584841515854, 5832.854178645525, 6211.596246244025, 6258.311585725566, 6291.1506946562085, 6298.811035668891, 4186.372044193396, 4204.201201771653, 4238.300680387763, 4251.893702657459, 4261.914761704748, 4287.742735435884, 4288.078063216423, 4296.119295544406, 4302.720323179046, 4305.590968857953, 4768.260919557474, 4907.631927605444, 4923.458419573844, 4925.802967881316, 4940.357753492095, 5828.863371642489, 5832.475077243069, 5842.328132264759, 5844.678542680108, 5856.619319744203, 1448.7540714985105, 1477.017783174177, 1478.4381934864682, 1478.475141324814, 1483.243545791654, 945.1493655709916, 972.5040229482873, 982.7739619887466, 983.5426526665135, 984.7144328144901, 5032.949670503322, 5085.364329458817, 5100.1074811907765, 5102.591792656579, 5116.872078198, 6049.0, 6055.485283750842, 6063.818085457443, 6072.848178795565, 6095.146679464879, 5044.142495775727, 5047.217681259411, 5053.700566242351, 5058.54473097423, 5067.847964561069, 3184.996726031293, 3218.903432897017, 3227.6288226854213, 3240.930492937325, 3261.918452038718, 5634.267545219177, 5635.126555383922, 5641.548676105902, 5647.858803529944, 5668.971655141698, 6127.785527506516, 6211.59624624407, 6242.469390101802, 6292.874142517124, 6313.285287326494, 5616.915746263728, 5625.549956003591, 5636.85907852307, 5649.943500565024, 5653.802116925888, 6026.969865150646, 6030.547708921761, 6060.818175454743, 6077.24034495688, 6097.664628445478, 5880.382559831327, 5995.370486098896, 5996.280446346466, 5997.730102145327, 6013.939860601513, 5356.812511562077, 5582.916256256078, 5602.971985140048, 5606.635568688022, 5661.688607126647, 4168.24971505132, 4184.539700632867, 4199.643030342333, 4203.180379825904, 4203.180379825904, 6042.879142417215, 6067.666278354733, 6068.9655172413795, 6109.75560977556, 6122.969385153046, 5649.322081350264, 5811.360750317377, 5845.18167456548, 5870.9412905872105, 5888.234529511307, 5851.444112809277, 5873.530117590668, 5887.911681324698, 5894.174815525744, 5897.3807750187325, 5754.683492407958, 5774.0761478163295, 5783.132530120515, 5833.066709326487, 5840.970795146167, 5951.583389162717, 5960.701964901651, 5967.1944287522365, 5982.192404025575, 5986.760529578768, 5721.512406774185, 5761.91357129635, 5765.365809761007, 5783.161441590862, 5787.36339002701], "value": 4385.257374728901, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [729.0449511140403, 740.3595889555536, 747.7158679701713, 759.3773106053038, 772.8956590860234, 13104.737905241902, 13722.519711810077, 13770.586882393533, 14083.436662533511, 15498.61253468664, 15615.687686246269, 15714.135722535257, 15746.0, 15746.527604171864, 15809.841901580981, 891.7770557360643, 898.3397203055749, 899.1547944931776, 901.058393978291, 901.3330135699567, 825.4510750351039, 907.0249481807084, 910.0, 912.192709452133, 916.2624087609472, 969.1471505075559, 970.1801977329145, 970.5098925042879, 971.4414211828228, 971.8639390485338, 966.8308046091905, 967.6516454076527, 969.1955676788284, 970.5632465390603, 970.6505657963128, 710.9608971506565, 711.2318695808515, 712.6650474277081, 712.994677504721, 713.3829237709344, 13205.735885282336, 13259.0, 13303.135296205812, 13346.466141354334, 13392.665183370396, 15398.230088495531, 15870.444534441354, 15901.045937243687, 15901.999999999884, 15987.200639967956, 12479.0, 12720.427580758887, 12721.745565088646, 12923.741525169538, 12943.093983421164, 3064.7548196144253, 3084.21352555097, 3084.2135255509925, 3093.1957691000503, 3098.1170366445454, 83431.0, 83524.0, 85122.0, 85204.57397713033, 85711.14288857095, 12857.54998575064, 12911.450625924948, 12968.221906685629, 13002.219866808022, 13144.342782860818, 23786.286411407684, 24155.879220603783, 24210.152644657705, 24323.148689795773, 24376.87811560931, 5695.857603559944, 5765.990951583456, 5835.533157347402, 5852.239208902815, 5875.706214689249, 2746.986265068662, 2804.340979869729, 2820.309024289021, 2827.1377229945065, 2833.1783782703196, 4133.441985331941, 4347.652187824967, 4390.517043125254, 4399.6920215584605, 4425.5574442556135, 734.9228331025272, 758.5941521286086, 765.3456294867808, 775.0544335910181, 775.6083177995189, 551.8344496650989, 568.6275489554348, 579.342446323426, 610.3592073282889, 621.4158690830604, 9690.273229507815, 10045.748856278651, 10148.949255253676, 10564.313319634199, 11017.779644407066, 585.6632436349116, 587.2864469669372, 592.7303077099909, 594.180031556458, 610.697704636208, 4651.581357677757, 4774.259989701602, 4833.347498087784, 4880.951190488121, 4997.0, 85621.14378856131, 87135.56432217926, 88003.0, 90552.5472372647, 92408.53795730979, 77985.0, 79303.0, 79802.0, 81596.59201703954, 81949.0, 67770.66114669494, 68037.3196268031, 68047.19528047254, 68121.0, 71876.64061679658, 9547.045295470398, 9562.091601297865, 9751.561179746786, 9795.412275263507, 9973.102420782165, 28567.571486427303, 28636.0, 28697.42605147927, 28906.27734306659, 29403.264918377212, 36985.52753268221, 37239.6276037247, 37323.44014839834, 37988.81005594954, 38474.0, 12088.637340879788, 12147.817782733442, 12219.572314968933, 12242.387880606113, 12353.197042192229, 13809.0, 13938.790918136034, 13948.930255348658, 14030.649233769238, 14204.857951420354, 12285.57000504978, 14131.64670883236, 14179.22014289224, 14415.044915792028, 14607.488737894122, 14101.929490352482, 14479.20364379927, 14548.563543093724, 14585.854141458874, 14860.108393496424, 14100.0, 14189.787153192918, 14239.288035598385, 14343.426262949783, 14417.918656100625, 9551.188149007412, 9786.363886347364, 9882.901170988485, 10023.097921187129, 10057.145142662663, 10096.545655445669, 10119.645812396826, 10282.126019288444, 10467.895321046997, 10633.20250981195], "value": 7114.4773955423925, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1547.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 109.0, 110.0, 109.0, 111.0, 109.0, 109.0, 110.0, 110.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 125.0, 128.0, 172.0, 123.0, 122.0, 123.0, 122.0, 149.0, 129.0], "value": 134.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 163.0, 163.0, 167.0, 167.0, 167.0, 169.0, 163.0, 164.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 110.0, 74.0, 76.0, 74.0, 73.0, 96.0, 74.0], "value": 80.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 105.0, 85.0, 84.0, 83.0, 99.0, 83.0, 83.0, 105.0], "value": 89.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 115.0, 114.0, 114.0, 114.0, 113.0, 117.0, 116.0, 121.0, 114.0], "value": 115.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 150.0, 150.0, 152.0, 150.0, 152.0, 150.0, 150.0, 151.0, 151.0], "value": 150.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 57.0, 55.0, 55.0, 54.0, 56.0, 64.0, 56.0, 55.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 59.0, 55.0, 56.0, 56.0, 56.0, 56.0, 59.0, 56.0], "value": 56.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 87.0, 93.0, 86.0, 87.0, 88.0, 87.0, 87.0, 123.0, 90.0], "value": 92.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 133.0, 133.0, 139.0, 129.0, 141.0, 128.0, 142.0, 134.0, 152.0], "value": 136.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 195.0, 191.0, 191.0, 197.0, 194.0, 199.0, 189.0, 200.0, 191.0], "value": 193.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 70.0, 82.0, 71.0, 75.0, 76.0, 71.0, 72.0, 73.0], "value": 73.1, "unit": "score"}]}]} 18:53:20 INFO - Return code: 0 18:53:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:53:20 INFO - # TBPL SUCCESS # 18:53:20 INFO - Running post-action listener: _resource_record_post_action 18:53:20 INFO - [mozharness: 2017-06-02 01:53:20.525433Z] Finished run-tests step (success) 18:53:20 INFO - Running post-run listener: _resource_record_post_run 18:53:20 INFO - Total resource usage - Wall time: 1256s; CPU: 13.0%; Read bytes: 4096; Write bytes: 404418560; Read time: 8; Write time: 264276 18:53:20 INFO - TinderboxPrint: CPU usage
12.6% 18:53:20 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 18:53:20 INFO - TinderboxPrint: I/O write bytes / time
404,418,560 / 264,276 18:53:20 INFO - TinderboxPrint: CPU idle
8,757.1 (87.3%) 18:53:20 INFO - TinderboxPrint: CPU user
1,216.5 (12.1%) 18:53:20 INFO - TinderboxPrint: Swap in / out
0 / 0 18:53:20 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 97746944; Read time: 0; Write time: 61300 18:53:20 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:53:20 INFO - run-tests - Wall time: 1241s; CPU: 13.0%; Read bytes: 4096; Write bytes: 306671616; Read time: 8; Write time: 202976 18:53:21 INFO - Running post-run listener: _upload_blobber_files 18:53:21 INFO - Blob upload gear active. 18:53:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:53:21 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:53:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:53:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:53:21 INFO - (blobuploader) - INFO - Open directory for files ... 18:53:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:53:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:53:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:53:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:53:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:53:28 INFO - (blobuploader) - INFO - Done attempting. 18:53:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:53:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:53:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:53:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:53:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:53:29 INFO - (blobuploader) - INFO - Done attempting. 18:53:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:53:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:53:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:53:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:53:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:53:30 INFO - (blobuploader) - INFO - Done attempting. 18:53:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:53:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:53:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:53:31 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:53:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:53:31 INFO - (blobuploader) - INFO - Done attempting. 18:53:31 INFO - (blobuploader) - INFO - Iteration through files over. 18:53:31 INFO - Return code: 0 18:53:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:53:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:53:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9bd1c3bde0af99fd21fc3916916b9390f39c3d9b96d8d0ff2fb7d0355437762654607af2ea0808bfb64e6f8fc8c26b10c2b9528e57f330705f1924e32186366b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a01af6a87e4fc50376fb11a93f6594c701a5bf5696aa3abea7be7146bb4fe1077cbfce54e7daf73724125283fc98d5b8d555635676ae088a6db790e40f4454a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a962d7596a257c0b0af268c00c82f34113ff44c8ba411298880c139b9cedcf30f8567f5480a4b54be213a2ce3521a8487666b8cecfd2d17088e26b43a881da13", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/950d986ac081631cd87443db2d96be07778668b41e56ec7b9b00585adcf7d75694bbd5496031b3840c71a8630d6a3ee144a8e93c873910d7b42ee2aaff8a8d47"} 18:53:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:53:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:53:31 INFO - Contents: 18:53:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9bd1c3bde0af99fd21fc3916916b9390f39c3d9b96d8d0ff2fb7d0355437762654607af2ea0808bfb64e6f8fc8c26b10c2b9528e57f330705f1924e32186366b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a01af6a87e4fc50376fb11a93f6594c701a5bf5696aa3abea7be7146bb4fe1077cbfce54e7daf73724125283fc98d5b8d555635676ae088a6db790e40f4454a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a962d7596a257c0b0af268c00c82f34113ff44c8ba411298880c139b9cedcf30f8567f5480a4b54be213a2ce3521a8487666b8cecfd2d17088e26b43a881da13", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/950d986ac081631cd87443db2d96be07778668b41e56ec7b9b00585adcf7d75694bbd5496031b3840c71a8630d6a3ee144a8e93c873910d7b42ee2aaff8a8d47"} 18:53:31 INFO - Running post-run listener: copy_logs_to_upload_dir 18:53:31 INFO - Copying logs to upload dir... 18:53:31 INFO - mkdir: /builds/slave/test/build/upload/logs 18:53:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1322.686678 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 2 secs) (at 2017-06-01 18:53:30.562940) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-01 18:53:30.566741) ========= 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=199fb4c72b90437b990b419b000001c5-1496366785.521909-1063444403 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-Non-PGO/sha512/9bd1c3bde0af99fd21fc3916916b9390f39c3d9b96d8d0ff2fb7d0355437762654607af2ea0808bfb64e6f8fc8c26b10c2b9528e57f330705f1924e32186366b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a01af6a87e4fc50376fb11a93f6594c701a5bf5696aa3abea7be7146bb4fe1077cbfce54e7daf73724125283fc98d5b8d555635676ae088a6db790e40f4454a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a962d7596a257c0b0af268c00c82f34113ff44c8ba411298880c139b9cedcf30f8567f5480a4b54be213a2ce3521a8487666b8cecfd2d17088e26b43a881da13", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/950d986ac081631cd87443db2d96be07778668b41e56ec7b9b00585adcf7d75694bbd5496031b3840c71a8630d6a3ee144a8e93c873910d7b42ee2aaff8a8d47"} build_url:https://queue.taskcluster.net/v1/task/YLNT0xWBSUODdvhLoNhLBw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011320 build_url: 'https://queue.taskcluster.net/v1/task/YLNT0xWBSUODdvhLoNhLBw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9bd1c3bde0af99fd21fc3916916b9390f39c3d9b96d8d0ff2fb7d0355437762654607af2ea0808bfb64e6f8fc8c26b10c2b9528e57f330705f1924e32186366b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a01af6a87e4fc50376fb11a93f6594c701a5bf5696aa3abea7be7146bb4fe1077cbfce54e7daf73724125283fc98d5b8d555635676ae088a6db790e40f4454a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a962d7596a257c0b0af268c00c82f34113ff44c8ba411298880c139b9cedcf30f8567f5480a4b54be213a2ce3521a8487666b8cecfd2d17088e26b43a881da13", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/950d986ac081631cd87443db2d96be07778668b41e56ec7b9b00585adcf7d75694bbd5496031b3840c71a8630d6a3ee144a8e93c873910d7b42ee2aaff8a8d47"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-01 18:53:30.591453) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 18:53:30.591845) ========= 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=199fb4c72b90437b990b419b000001c5-1496366785.521909-1063444403 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004444 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 18:53:30.675932) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-01 18:53:30.676763) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-01 18:53:30.677385) ========= ========= Total master_lag: 0.17 =========