builder: mozilla-beta_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-086 starttime: 1495492706.25 results: success (0) revision: 16c20bf328da5fcd6060395fd0fb320f3b8a1146 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-22 15:38:26.246037) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-22 15:38:26.246526) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-22 15:38:26.246814) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-22 15:38:26.279974) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-22 15:38:26.280352) ========= 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=438111f3d31ce799eff2119d000001bc-1495491726.669285-1678284415 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-22 15:38:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.3M=0s 2017-05-22 15:38:26 (42.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.166144 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-22 15:38:26.461807) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-22 15:38:26.462088) ========= 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=438111f3d31ce799eff2119d000001bc-1495491726.669285-1678284415 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023237 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-22 15:38:26.514822) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-22 15:38:26.515136) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 16c20bf328da5fcd6060395fd0fb320f3b8a1146 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 16c20bf328da5fcd6060395fd0fb320f3b8a1146 --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=438111f3d31ce799eff2119d000001bc-1495491726.669285-1678284415 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-22 15:38:26,598 truncating revision to first 12 chars 2017-05-22 15:38:26,599 Setting DEBUG logging. 2017-05-22 15:38:26,599 attempt 1/10 2017-05-22 15:38:26,599 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/16c20bf328da?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-22 15:38:26,895 unpacking tar archive at: mozilla-beta-16c20bf328da/testing/mozharness/ program finished with exit code 0 elapsedTime=0.609941 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-22 15:38:27.139864) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-22 15:38:27.140140) ========= script_repo_revision: 16c20bf328da5fcd6060395fd0fb320f3b8a1146 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-22 15:38:27.140510) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-22 15:38:27.140770) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-22 15:38:27.148535) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-05-22 15:38:27.148803) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-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', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-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=438111f3d31ce799eff2119d000001bc-1495491726.669285-1678284415 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:38:27 INFO - MultiFileLogger online at 20170522 15:38:27 in /builds/slave/test 15:38:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 15:38:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:38:27 INFO - {'append_to_log': False, 15:38:27 INFO - 'base_work_dir': '/builds/slave/test', 15:38:27 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 15:38:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:38:27 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 15:38:27 INFO - 'buildbot_json_path': 'buildprops.json', 15:38:27 INFO - 'config_files': ('talos/linux_config.py',), 15:38:27 INFO - 'default_actions': ('clobber', 15:38:27 INFO - 'read-buildbot-config', 15:38:27 INFO - 'download-and-extract', 15:38:27 INFO - 'populate-webroot', 15:38:27 INFO - 'create-virtualenv', 15:38:27 INFO - 'install', 15:38:27 INFO - 'run-tests'), 15:38:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:38:27 INFO - 'download_minidump_stackwalk': True, 15:38:27 INFO - 'download_symbols': 'ondemand', 15:38:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:38:27 INFO - 'tooltool.py': '/tools/tooltool.py', 15:38:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:38:27 INFO - '/tools/misc-python/virtualenv.py')}, 15:38:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:38:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:38:27 INFO - 'gecko_profile': False, 15:38:27 INFO - 'gecko_profile_interval': 0, 15:38:27 INFO - 'installer_path': 'installer.exe', 15:38:27 INFO - 'log_level': 'info', 15:38:27 INFO - 'log_name': 'talos', 15:38:27 INFO - 'log_to_console': True, 15:38:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:38:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:38:27 INFO - 'opt_config_files': (), 15:38:27 INFO - 'pip_index': False, 15:38:27 INFO - 'suite': 'dromaeojs', 15:38:27 INFO - 'system_bits': '32', 15:38:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:38:27 INFO - 'title': 'talos-linux64-ix-086', 15:38:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:38:27 INFO - 'use_talos_json': True, 15:38:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:38:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:38:27 INFO - 'work_dir': 'build'} 15:38:27 INFO - [mozharness: 2017-05-22 22:38:27.325612Z] Running clobber step. 15:38:27 INFO - Running pre-action listener: _resource_record_pre_action 15:38:27 INFO - Running main action method: clobber 15:38:27 INFO - rmtree: /builds/slave/test/build 15:38:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:38:28 INFO - Running post-action listener: _resource_record_post_action 15:38:28 INFO - [mozharness: 2017-05-22 22:38:28.328404Z] Finished clobber step (success) 15:38:28 INFO - [mozharness: 2017-05-22 22:38:28.328503Z] Running read-buildbot-config step. 15:38:28 INFO - Running pre-action listener: _resource_record_pre_action 15:38:28 INFO - Running main action method: read_buildbot_config 15:38:28 INFO - Using buildbot properties: 15:38:28 INFO - { 15:38:28 INFO - "project": "", 15:38:28 INFO - "product": "firefox", 15:38:28 INFO - "who": "pastithas@mozilla.com", 15:38:28 INFO - "installer_path": "public/build/target.tar.bz2", 15:38:28 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 15:38:28 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta/", 15:38:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs", 15:38:28 INFO - "stage_platform": "linux64", 15:38:28 INFO - "basedir": "/builds/slave/test", 15:38:28 INFO - "buildnumber": 53, 15:38:28 INFO - "platform": "ubuntu64_hw", 15:38:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:38:28 INFO - "slavebuilddir": "test", 15:38:28 INFO - "taskId": "MYT1k2ZRRCOqeEQlTPGX-Q", 15:38:28 INFO - "branch": "mozilla-beta", 15:38:28 INFO - "script_repo_revision": "production", 15:38:28 INFO - "revision": "16c20bf328da5fcd6060395fd0fb320f3b8a1146", 15:38:28 INFO - "slavename": "talos-linux64-ix-086", 15:38:28 INFO - "repo_path": "releases/mozilla-beta" 15:38:28 INFO - } 15:38:28 INFO - Finding installer, test and symbols from parent task. 15:38:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MYT1k2ZRRCOqeEQlTPGX-Q'}, attempt #1 15:38:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MYT1k2ZRRCOqeEQlTPGX-Q'}, attempt #1 15:38:29 INFO - Task dependencies: eIW7ogXpSZWlHsQpaOZX0Q 15:38:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eIW7ogXpSZWlHsQpaOZX0Q'}, attempt #1 15:38:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/eIW7ogXpSZWlHsQpaOZX0Q/artifacts/public/build/target.tar.bz2 15:38:29 INFO - Set test_url: https://queue.taskcluster.net/v1/task/eIW7ogXpSZWlHsQpaOZX0Q/artifacts/public/build/test_packages.json 15:38:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/eIW7ogXpSZWlHsQpaOZX0Q/artifacts/public/build/target.crashreporter-symbols.zip 15:38:29 INFO - Running post-action listener: _resource_record_post_action 15:38:29 INFO - [mozharness: 2017-05-22 22:38:29.710795Z] Finished read-buildbot-config step (success) 15:38:29 INFO - [mozharness: 2017-05-22 22:38:29.711012Z] Running download-and-extract step. 15:38:29 INFO - Running pre-action listener: _resource_record_pre_action 15:38:29 INFO - Running main action method: download_and_extract 15:38:29 INFO - mkdir: /builds/slave/test/build/tests 15:38:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:38:29 INFO - trying https://queue.taskcluster.net/v1/task/eIW7ogXpSZWlHsQpaOZX0Q/artifacts/public/build/target.test_packages.json 15:38:29 INFO - Downloading https://queue.taskcluster.net/v1/task/eIW7ogXpSZWlHsQpaOZX0Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:38:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eIW7ogXpSZWlHsQpaOZX0Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:38:30 INFO - Downloaded 986 bytes. 15:38:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:38:30 INFO - Using the following test package requirements: 15:38:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:38:30 INFO - u'common': [u'target.common.tests.zip'], 15:38:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:38:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:38:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:38:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:38:30 INFO - u'mozbase': [u'target.common.tests.zip'], 15:38:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:38:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:38:30 INFO - u'web-platform': [u'target.common.tests.zip', 15:38:30 INFO - u'target.web-platform.tests.zip'], 15:38:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:38:30 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:38:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eIW7ogXpSZWlHsQpaOZX0Q/artifacts/public/build/target.common.tests.zip 15:38:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eIW7ogXpSZWlHsQpaOZX0Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:38:30 INFO - Fetch https://queue.taskcluster.net/v1/task/eIW7ogXpSZWlHsQpaOZX0Q/artifacts/public/build/target.common.tests.zip into memory 15:38:31 INFO - Expected file size: 59713657 15:38:31 INFO - Obtained file size: 59713657 15:38:41 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:38:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eIW7ogXpSZWlHsQpaOZX0Q/artifacts/public/build/target.common.tests.zip 15:38:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eIW7ogXpSZWlHsQpaOZX0Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:38:41 INFO - Fetch https://queue.taskcluster.net/v1/task/eIW7ogXpSZWlHsQpaOZX0Q/artifacts/public/build/target.common.tests.zip into memory 15:38:42 INFO - Expected file size: 59713657 15:38:42 INFO - Obtained file size: 59713657 15:38:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eIW7ogXpSZWlHsQpaOZX0Q/artifacts/public/build/target.talos.tests.zip 15:38:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eIW7ogXpSZWlHsQpaOZX0Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:38:52 INFO - Fetch https://queue.taskcluster.net/v1/task/eIW7ogXpSZWlHsQpaOZX0Q/artifacts/public/build/target.talos.tests.zip into memory 15:38:53 INFO - Expected file size: 14404449 15:38:53 INFO - Obtained file size: 14404449 15:38:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:38:53 INFO - trying https://queue.taskcluster.net/v1/task/eIW7ogXpSZWlHsQpaOZX0Q/artifacts/public/build/target.tar.bz2 15:38:53 INFO - Downloading https://queue.taskcluster.net/v1/task/eIW7ogXpSZWlHsQpaOZX0Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:38:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eIW7ogXpSZWlHsQpaOZX0Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:38:55 INFO - Downloaded 59783855 bytes. 15:38:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eIW7ogXpSZWlHsQpaOZX0Q/artifacts/public/build/target.tar.bz2 15:38:55 INFO - mkdir: /builds/slave/test/properties 15:38:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:38:55 INFO - Writing to file /builds/slave/test/properties/build_url 15:38:55 INFO - Contents: 15:38:55 INFO - build_url:https://queue.taskcluster.net/v1/task/eIW7ogXpSZWlHsQpaOZX0Q/artifacts/public/build/target.tar.bz2 15:38:55 INFO - Running post-action listener: _resource_record_post_action 15:38:55 INFO - Running post-action listener: set_extra_try_arguments 15:38:55 INFO - [mozharness: 2017-05-22 22:38:55.072515Z] Finished download-and-extract step (success) 15:38:55 INFO - [mozharness: 2017-05-22 22:38:55.072611Z] Running populate-webroot step. 15:38:55 INFO - Running pre-action listener: _resource_record_pre_action 15:38:55 INFO - Running main action method: populate_webroot 15:38:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:38:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:38:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:38:55 INFO - '--tppagecycles', 15:38:55 INFO - '7'], 15:38:55 INFO - 'tests': ['tsvgm']}}, 15:38:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:38:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:38:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:38:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:38:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:38:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:38:55 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:38:55 INFO - 'talos_options': ['--disable-e10s'], 15:38:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:38:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:38:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:38:55 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:38:55 INFO - 'talos_options': ['--disable-e10s'], 15:38:55 INFO - 'tests': ['damp', 'tps']}, 15:38:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:38:55 INFO - 'tests': ['damp', 'tps']}, 15:38:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:38:55 INFO - 'tests': ['dromaeo_dom']}, 15:38:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:38:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:38:55 INFO - 'tests': ['basic_compositor_video']}, 15:38:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:38:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:38:55 INFO - 'tests': ['a11yr', 15:38:55 INFO - 'ts_paint', 15:38:55 INFO - 'tpaint', 15:38:55 INFO - 'sessionrestore', 15:38:55 INFO - 'sessionrestore_no_auto_restore', 15:38:55 INFO - 'tabpaint']}, 15:38:55 INFO - 'other-e10s': {'tests': ['a11yr', 15:38:55 INFO - 'ts_paint', 15:38:55 INFO - 'tpaint', 15:38:55 INFO - 'sessionrestore', 15:38:55 INFO - 'sessionrestore_no_auto_restore', 15:38:55 INFO - 'tabpaint']}, 15:38:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:38:55 INFO - 'ts_paint', 15:38:55 INFO - 'tpaint', 15:38:55 INFO - 'sessionrestore', 15:38:55 INFO - 'sessionrestore_no_auto_restore', 15:38:55 INFO - 'tabpaint']}, 15:38:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:38:55 INFO - 'ts_paint', 15:38:55 INFO - 'tpaint', 15:38:55 INFO - 'sessionrestore', 15:38:55 INFO - 'sessionrestore_no_auto_restore', 15:38:55 INFO - 'tabpaint']}, 15:38:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:38:55 INFO - 'tests': ['a11yr', 15:38:55 INFO - 'ts_paint', 15:38:55 INFO - 'tpaint', 15:38:55 INFO - 'sessionrestore', 15:38:55 INFO - 'sessionrestore_no_auto_restore', 15:38:55 INFO - 'tabpaint']}, 15:38:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:38:55 INFO - 'tests': ['a11yr', 15:38:55 INFO - 'ts_paint', 15:38:55 INFO - 'tpaint', 15:38:55 INFO - 'sessionrestore', 15:38:55 INFO - 'sessionrestore_no_auto_restore', 15:38:55 INFO - 'tabpaint']}, 15:38:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:38:55 INFO - 'tests': ['tsvgx', 15:38:55 INFO - 'tsvgr_opacity', 15:38:55 INFO - 'tart', 15:38:55 INFO - 'tscrollx', 15:38:55 INFO - 'cart', 15:38:55 INFO - 'tsvg_static']}, 15:38:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:38:55 INFO - 'tsvgr_opacity', 15:38:55 INFO - 'tart', 15:38:55 INFO - 'tscrollx', 15:38:55 INFO - 'cart', 15:38:55 INFO - 'tsvg_static']}, 15:38:55 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:38:55 INFO - 'talos_options': ['--disable-e10s'], 15:38:55 INFO - 'tests': ['tp5o']}, 15:38:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:38:55 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:38:55 INFO - 'talos_options': ['--disable-e10s', 15:38:55 INFO - '--xperf_path', 15:38:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:38:55 INFO - 'tests': ['tp5n']}, 15:38:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:38:55 INFO - 'talos_options': ['--xperf_path', 15:38:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:38:55 INFO - 'tests': ['tp5n']}}, 15:38:55 INFO - 'talos.zip': {'path': '', 15:38:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:38:55 INFO - Running post-action listener: _resource_record_post_action 15:38:55 INFO - [mozharness: 2017-05-22 22:38:55.085700Z] Finished populate-webroot step (success) 15:38:55 INFO - [mozharness: 2017-05-22 22:38:55.085790Z] Running create-virtualenv step. 15:38:55 INFO - Running pre-action listener: _resource_record_pre_action 15:38:55 INFO - Running main action method: create_virtualenv 15:38:55 INFO - Creating virtualenv /builds/slave/test/build/venv 15:38:55 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 15:38:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:38:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:38:55 INFO - Using real prefix '/usr' 15:38:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:38:55 INFO - Installing distribute.............................................................................................................................................................................................done. 15:38:57 INFO - Installing pip.................done. 15:38:57 INFO - Return code: 0 15:38:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:38:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:38:57 INFO - Reading from file tmpfile_stdout 15:38:57 INFO - Output received: 15:38:57 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) 15:38:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:38:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:38:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:57 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 0xd651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1003310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1000400>, '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 0x10013b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1001840>, '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': '438111f3d31ce799eff2119d000001bc-1495491726.669285-1678284415', '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 15:38:57 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 15:38:57 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 15:38:57 INFO - Using env: {'DISPLAY': ':0', 15:38:57 INFO - 'HOME': '/home/cltbld', 15:38:57 INFO - 'LANG': 'en_US.UTF-8', 15:38:57 INFO - 'LANGUAGE': 'en_US:en', 15:38:57 INFO - 'LOGNAME': 'cltbld', 15:38:57 INFO - 'MAIL': '/var/mail/cltbld', 15:38:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:57 INFO - 'MOZ_NO_REMOTE': '1', 15:38:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:38:57 INFO - 'NO_EM_RESTART': '1', 15:38:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:38:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:57 INFO - 'PWD': '/builds/slave/test', 15:38:57 INFO - 'SHELL': '/bin/bash', 15:38:57 INFO - 'SHLVL': '1', 15:38:57 INFO - 'TERM': 'linux', 15:38:57 INFO - 'TMOUT': '86400', 15:38:57 INFO - 'USER': 'cltbld', 15:38:57 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1495491726.669285-1678284415', 15:38:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:57 INFO - '_': '/tools/buildbot/bin/python'} 15:38:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:58 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 15:38:58 INFO - Cleaning up... 15:38:58 INFO - Return code: 0 15:38:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:38:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:38:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1003310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1000400>, '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 0x10013b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1001840>, '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': '438111f3d31ce799eff2119d000001bc-1495491726.669285-1678284415', '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 15:38:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:38:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:38:58 INFO - Using env: {'DISPLAY': ':0', 15:38:58 INFO - 'HOME': '/home/cltbld', 15:38:58 INFO - 'LANG': 'en_US.UTF-8', 15:38:58 INFO - 'LANGUAGE': 'en_US:en', 15:38:58 INFO - 'LOGNAME': 'cltbld', 15:38:58 INFO - 'MAIL': '/var/mail/cltbld', 15:38:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:58 INFO - 'MOZ_NO_REMOTE': '1', 15:38:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:38:58 INFO - 'NO_EM_RESTART': '1', 15:38:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:38:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:58 INFO - 'PWD': '/builds/slave/test', 15:38:58 INFO - 'SHELL': '/bin/bash', 15:38:58 INFO - 'SHLVL': '1', 15:38:58 INFO - 'TERM': 'linux', 15:38:58 INFO - 'TMOUT': '86400', 15:38:58 INFO - 'USER': 'cltbld', 15:38:58 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1495491726.669285-1678284415', 15:38:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:58 INFO - '_': '/tools/buildbot/bin/python'} 15:38:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:58 INFO - Downloading/unpacking psutil>=3.1.1 15:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:38:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:38:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:38:59 INFO - Installing collected packages: psutil 15:38:59 INFO - Running setup.py install for psutil 15:38:59 INFO - building 'psutil._psutil_linux' extension 15:38:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:38:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:38:59 INFO - building 'psutil._psutil_posix' extension 15:38:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:38:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:38:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:38:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:39:00 INFO - Successfully installed psutil 15:39:00 INFO - Cleaning up... 15:39:00 INFO - Return code: 0 15:39:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:39:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1003310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1000400>, '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 0x10013b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1001840>, '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': '438111f3d31ce799eff2119d000001bc-1495491726.669285-1678284415', '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 15:39:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:39:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:39:00 INFO - Using env: {'DISPLAY': ':0', 15:39:00 INFO - 'HOME': '/home/cltbld', 15:39:00 INFO - 'LANG': 'en_US.UTF-8', 15:39:00 INFO - 'LANGUAGE': 'en_US:en', 15:39:00 INFO - 'LOGNAME': 'cltbld', 15:39:00 INFO - 'MAIL': '/var/mail/cltbld', 15:39:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:00 INFO - 'MOZ_NO_REMOTE': '1', 15:39:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:00 INFO - 'NO_EM_RESTART': '1', 15:39:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:00 INFO - 'PWD': '/builds/slave/test', 15:39:00 INFO - 'SHELL': '/bin/bash', 15:39:00 INFO - 'SHLVL': '1', 15:39:00 INFO - 'TERM': 'linux', 15:39:00 INFO - 'TMOUT': '86400', 15:39:00 INFO - 'USER': 'cltbld', 15:39:00 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1495491726.669285-1678284415', 15:39:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:00 INFO - '_': '/tools/buildbot/bin/python'} 15:39:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:39:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:39:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:39:01 INFO - Installing collected packages: mozsystemmonitor 15:39:01 INFO - Running setup.py install for mozsystemmonitor 15:39:01 INFO - Successfully installed mozsystemmonitor 15:39:01 INFO - Cleaning up... 15:39:01 INFO - Return code: 0 15:39:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:39: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')]} 15:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39: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')]} 15:39:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1003310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1000400>, '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 0x10013b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1001840>, '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': '438111f3d31ce799eff2119d000001bc-1495491726.669285-1678284415', '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 15:39:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:39:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:39:01 INFO - Using env: {'DISPLAY': ':0', 15:39:01 INFO - 'HOME': '/home/cltbld', 15:39:01 INFO - 'LANG': 'en_US.UTF-8', 15:39:01 INFO - 'LANGUAGE': 'en_US:en', 15:39:01 INFO - 'LOGNAME': 'cltbld', 15:39:01 INFO - 'MAIL': '/var/mail/cltbld', 15:39:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:01 INFO - 'MOZ_NO_REMOTE': '1', 15:39:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:01 INFO - 'NO_EM_RESTART': '1', 15:39:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:01 INFO - 'PWD': '/builds/slave/test', 15:39:01 INFO - 'SHELL': '/bin/bash', 15:39:01 INFO - 'SHLVL': '1', 15:39:01 INFO - 'TERM': 'linux', 15:39:01 INFO - 'TMOUT': '86400', 15:39:01 INFO - 'USER': 'cltbld', 15:39:01 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1495491726.669285-1678284415', 15:39:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:01 INFO - '_': '/tools/buildbot/bin/python'} 15:39:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:01 INFO - Downloading/unpacking jsonschema==2.5.1 15:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:39:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:02 INFO - Downloading functools32-3.2.3-2.tar.gz 15:39:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:39:03 INFO - warning: no files found matching '*.txt' 15:39:03 INFO - no previously-included directories found matching 'build' 15:39:03 INFO - no previously-included directories found matching 'dist' 15:39:03 INFO - no previously-included directories found matching '.git*' 15:39:03 INFO - Installing collected packages: jsonschema, functools32 15:39:03 INFO - Running setup.py install for functools32 15:39:03 INFO - warning: no files found matching '*.txt' 15:39:03 INFO - no previously-included directories found matching 'build' 15:39:03 INFO - no previously-included directories found matching 'dist' 15:39:03 INFO - no previously-included directories found matching '.git*' 15:39:03 INFO - Successfully installed jsonschema functools32 15:39:03 INFO - Cleaning up... 15:39:03 INFO - Return code: 0 15:39:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:39:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1003310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1000400>, '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 0x10013b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1001840>, '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': '438111f3d31ce799eff2119d000001bc-1495491726.669285-1678284415', '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 15:39:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:39:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:39:03 INFO - Using env: {'DISPLAY': ':0', 15:39:03 INFO - 'HOME': '/home/cltbld', 15:39:03 INFO - 'LANG': 'en_US.UTF-8', 15:39:03 INFO - 'LANGUAGE': 'en_US:en', 15:39:03 INFO - 'LOGNAME': 'cltbld', 15:39:03 INFO - 'MAIL': '/var/mail/cltbld', 15:39:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:03 INFO - 'MOZ_NO_REMOTE': '1', 15:39:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:03 INFO - 'NO_EM_RESTART': '1', 15:39:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:03 INFO - 'PWD': '/builds/slave/test', 15:39:03 INFO - 'SHELL': '/bin/bash', 15:39:03 INFO - 'SHLVL': '1', 15:39:03 INFO - 'TERM': 'linux', 15:39:03 INFO - 'TMOUT': '86400', 15:39:03 INFO - 'USER': 'cltbld', 15:39:03 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1495491726.669285-1678284415', 15:39:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:03 INFO - '_': '/tools/buildbot/bin/python'} 15:39:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:39:03 INFO - Cleaning up... 15:39:03 INFO - Return code: 0 15:39:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:39:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1003310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1000400>, '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 0x10013b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1001840>, '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': '438111f3d31ce799eff2119d000001bc-1495491726.669285-1678284415', '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 15:39:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:39:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:39:03 INFO - Using env: {'DISPLAY': ':0', 15:39:03 INFO - 'HOME': '/home/cltbld', 15:39:03 INFO - 'LANG': 'en_US.UTF-8', 15:39:03 INFO - 'LANGUAGE': 'en_US:en', 15:39:03 INFO - 'LOGNAME': 'cltbld', 15:39:03 INFO - 'MAIL': '/var/mail/cltbld', 15:39:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:03 INFO - 'MOZ_NO_REMOTE': '1', 15:39:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:03 INFO - 'NO_EM_RESTART': '1', 15:39:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:03 INFO - 'PWD': '/builds/slave/test', 15:39:03 INFO - 'SHELL': '/bin/bash', 15:39:03 INFO - 'SHLVL': '1', 15:39:03 INFO - 'TERM': 'linux', 15:39:03 INFO - 'TMOUT': '86400', 15:39:03 INFO - 'USER': 'cltbld', 15:39:03 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1495491726.669285-1678284415', 15:39:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:03 INFO - '_': '/tools/buildbot/bin/python'} 15:39:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:03 INFO - Downloading/unpacking blobuploader==1.2.4 15:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:04 INFO - Downloading blobuploader-1.2.4.tar.gz 15:39:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:39:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:39:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:05 INFO - Downloading docopt-0.6.1.tar.gz 15:39:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:39:05 INFO - Installing collected packages: blobuploader, requests, docopt 15:39:05 INFO - Running setup.py install for blobuploader 15:39:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:39:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:39:05 INFO - Running setup.py install for requests 15:39:05 INFO - Running setup.py install for docopt 15:39:05 INFO - Successfully installed blobuploader requests docopt 15:39:05 INFO - Cleaning up... 15:39:05 INFO - Return code: 0 15:39:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1003310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1000400>, '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 0x10013b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1001840>, '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': '438111f3d31ce799eff2119d000001bc-1495491726.669285-1678284415', '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 15:39:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:39:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:39:05 INFO - Using env: {'DISPLAY': ':0', 15:39:05 INFO - 'HOME': '/home/cltbld', 15:39:05 INFO - 'LANG': 'en_US.UTF-8', 15:39:05 INFO - 'LANGUAGE': 'en_US:en', 15:39:05 INFO - 'LOGNAME': 'cltbld', 15:39:05 INFO - 'MAIL': '/var/mail/cltbld', 15:39:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:05 INFO - 'MOZ_NO_REMOTE': '1', 15:39:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:05 INFO - 'NO_EM_RESTART': '1', 15:39:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:05 INFO - 'PWD': '/builds/slave/test', 15:39:05 INFO - 'SHELL': '/bin/bash', 15:39:05 INFO - 'SHLVL': '1', 15:39:05 INFO - 'TERM': 'linux', 15:39:05 INFO - 'TMOUT': '86400', 15:39:05 INFO - 'USER': 'cltbld', 15:39:05 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1495491726.669285-1678284415', 15:39:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:05 INFO - '_': '/tools/buildbot/bin/python'} 15:39:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:39:06 INFO - Running setup.py (path:/tmp/pip-n8ho4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:39:06 INFO - Running setup.py (path:/tmp/pip-RRh1F_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:39:06 INFO - Running setup.py (path:/tmp/pip-cIAPXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:39:06 INFO - Running setup.py (path:/tmp/pip-B2DTe6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:39:06 INFO - Running setup.py (path:/tmp/pip-rbx03Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:39:06 INFO - Running setup.py (path:/tmp/pip-egv1Pj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:39:06 INFO - Running setup.py (path:/tmp/pip-YmQEqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:39:06 INFO - Running setup.py (path:/tmp/pip-BHWz1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:39:06 INFO - Running setup.py (path:/tmp/pip-Kf_nZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:39:06 INFO - Running setup.py (path:/tmp/pip-2sWlFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:39:06 INFO - Running setup.py (path:/tmp/pip-ca3Glc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:39:07 INFO - Running setup.py (path:/tmp/pip-OsrW7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:39:07 INFO - Running setup.py (path:/tmp/pip-iAMFnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:39:07 INFO - Running setup.py (path:/tmp/pip-fX0hLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:39:07 INFO - Running setup.py (path:/tmp/pip-Y5gfk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:39:07 INFO - Running setup.py (path:/tmp/pip-DLfd3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:39:07 INFO - Running setup.py (path:/tmp/pip-o0gea4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:39:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:39:07 INFO - Running setup.py install for manifestparser 15:39:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:39:07 INFO - Running setup.py install for mozcrash 15:39:07 INFO - Running setup.py install for mozdebug 15:39:07 INFO - Running setup.py install for mozdevice 15:39:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:39:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:39:07 INFO - Running setup.py install for mozfile 15:39:08 INFO - Running setup.py install for mozhttpd 15:39:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:39:08 INFO - Running setup.py install for mozinfo 15:39:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:39:08 INFO - Running setup.py install for mozInstall 15:39:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:39:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:39:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:39:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:39:08 INFO - Running setup.py install for mozleak 15:39:08 INFO - Running setup.py install for mozlog 15:39:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:39:08 INFO - Running setup.py install for moznetwork 15:39:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:39:08 INFO - Running setup.py install for mozprocess 15:39:08 INFO - Running setup.py install for mozprofile 15:39:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:39:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:39:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:39:08 INFO - Running setup.py install for mozrunner 15:39:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:39:08 INFO - Running setup.py install for mozscreenshot 15:39:09 INFO - Running setup.py install for moztest 15:39:09 INFO - Running setup.py install for mozversion 15:39:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:39:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:39:09 INFO - Cleaning up... 15:39:09 INFO - Return code: 0 15:39:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:39: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')]} 15:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39: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')]} 15:39:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1003310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1000400>, '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 0x10013b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1001840>, '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': '438111f3d31ce799eff2119d000001bc-1495491726.669285-1678284415', '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 15:39:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:39:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:39:09 INFO - Using env: {'DISPLAY': ':0', 15:39:09 INFO - 'HOME': '/home/cltbld', 15:39:09 INFO - 'LANG': 'en_US.UTF-8', 15:39:09 INFO - 'LANGUAGE': 'en_US:en', 15:39:09 INFO - 'LOGNAME': 'cltbld', 15:39:09 INFO - 'MAIL': '/var/mail/cltbld', 15:39:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:09 INFO - 'MOZ_NO_REMOTE': '1', 15:39:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:09 INFO - 'NO_EM_RESTART': '1', 15:39:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:09 INFO - 'PWD': '/builds/slave/test', 15:39:09 INFO - 'SHELL': '/bin/bash', 15:39:09 INFO - 'SHLVL': '1', 15:39:09 INFO - 'TERM': 'linux', 15:39:09 INFO - 'TMOUT': '86400', 15:39:09 INFO - 'USER': 'cltbld', 15:39:09 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1495491726.669285-1678284415', 15:39:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:09 INFO - '_': '/tools/buildbot/bin/python'} 15:39:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:39:09 INFO - Running setup.py (path:/tmp/pip-u8DORV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:39:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:39:09 INFO - Running setup.py (path:/tmp/pip-Mh9w9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:39:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:39:09 INFO - Running setup.py (path:/tmp/pip-nE3UNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:39:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:39:09 INFO - Running setup.py (path:/tmp/pip-HAvHYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:39:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 15:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:39:09 INFO - Running setup.py (path:/tmp/pip-R8Rfl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:39:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:39:09 INFO - Running setup.py (path:/tmp/pip-NA7HIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:39:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:39:09 INFO - Running setup.py (path:/tmp/pip-jxOLTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:39:10 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)) 15:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:39:10 INFO - Running setup.py (path:/tmp/pip-f8lnk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:39:10 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)) 15:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:39:10 INFO - Running setup.py (path:/tmp/pip-Py4ZVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:39:10 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)) 15:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:39:10 INFO - Running setup.py (path:/tmp/pip-MtnOc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:39:10 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)) 15:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:39:10 INFO - Running setup.py (path:/tmp/pip-Z1FW2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:39:10 INFO - Running setup.py (path:/tmp/pip-eQiEPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:39:10 INFO - Running setup.py (path:/tmp/pip-htYraX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:39:10 INFO - Running setup.py (path:/tmp/pip-82Lv3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:39:10 INFO - Running setup.py (path:/tmp/pip-qPCF8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:39:10 INFO - Running setup.py (path:/tmp/pip-X6kNfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:39:10 INFO - Running setup.py (path:/tmp/pip-RGldXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:39:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:11 INFO - Downloading blessings-1.6.tar.gz 15:39:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:39:11 INFO - Installing collected packages: blessings 15:39:11 INFO - Running setup.py install for blessings 15:39:12 INFO - Successfully installed blessings 15:39:12 INFO - Cleaning up... 15:39:12 INFO - Return code: 0 15:39:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:39:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:39:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:39:12 INFO - Reading from file tmpfile_stdout 15:39:12 INFO - Current package versions: 15:39:12 INFO - argparse == 1.2.1 15:39:12 INFO - blessings == 1.6 15:39:12 INFO - blobuploader == 1.2.4 15:39:12 INFO - docopt == 0.6.1 15:39:12 INFO - functools32 == 3.2.3-2 15:39:12 INFO - jsonschema == 2.5.1 15:39:12 INFO - manifestparser == 1.1 15:39:12 INFO - mozInstall == 1.12 15:39:12 INFO - mozcrash == 1.0 15:39:12 INFO - mozdebug == 0.1 15:39:12 INFO - mozdevice == 0.49 15:39:12 INFO - mozfile == 1.2 15:39:12 INFO - mozhttpd == 0.7 15:39:12 INFO - mozinfo == 0.9 15:39:12 INFO - mozleak == 0.1 15:39:12 INFO - mozlog == 3.4 15:39:12 INFO - moznetwork == 0.27 15:39:12 INFO - mozprocess == 0.25 15:39:12 INFO - mozprofile == 0.28 15:39:12 INFO - mozrunner == 6.13 15:39:12 INFO - mozscreenshot == 0.1 15:39:12 INFO - mozsystemmonitor == 0.3 15:39:12 INFO - moztest == 0.8 15:39:12 INFO - mozversion == 1.4 15:39:12 INFO - psutil == 3.1.1 15:39:12 INFO - requests == 1.2.3 15:39:12 INFO - wsgiref == 0.1.2 15:39:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:39: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')]} 15:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39: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')]} 15:39:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1003310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1000400>, '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 0x10013b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1001840>, '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': '438111f3d31ce799eff2119d000001bc-1495491726.669285-1678284415', '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 15:39:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:39:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:39:12 INFO - Using env: {'DISPLAY': ':0', 15:39:12 INFO - 'HOME': '/home/cltbld', 15:39:12 INFO - 'LANG': 'en_US.UTF-8', 15:39:12 INFO - 'LANGUAGE': 'en_US:en', 15:39:12 INFO - 'LOGNAME': 'cltbld', 15:39:12 INFO - 'MAIL': '/var/mail/cltbld', 15:39:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:12 INFO - 'MOZ_NO_REMOTE': '1', 15:39:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:12 INFO - 'NO_EM_RESTART': '1', 15:39:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:12 INFO - 'PWD': '/builds/slave/test', 15:39:12 INFO - 'SHELL': '/bin/bash', 15:39:12 INFO - 'SHLVL': '1', 15:39:12 INFO - 'TERM': 'linux', 15:39:12 INFO - 'TMOUT': '86400', 15:39:12 INFO - 'USER': 'cltbld', 15:39:12 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1495491726.669285-1678284415', 15:39:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:12 INFO - '_': '/tools/buildbot/bin/python'} 15:39:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:39:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:39:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:39:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:39:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:39:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:39:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:39:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:39:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:39:12 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)) 15:39:12 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)) 15:39:12 INFO - Cleaning up... 15:39:12 INFO - Return code: 0 15:39:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:39: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')]} 15:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39: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')]} 15:39:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1003310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1000400>, '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 0x10013b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1001840>, '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': '438111f3d31ce799eff2119d000001bc-1495491726.669285-1678284415', '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 15:39: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', 'jsonschema'] in /builds/slave/test/build 15:39: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 jsonschema 15:39:12 INFO - Using env: {'DISPLAY': ':0', 15:39:12 INFO - 'HOME': '/home/cltbld', 15:39:12 INFO - 'LANG': 'en_US.UTF-8', 15:39:12 INFO - 'LANGUAGE': 'en_US:en', 15:39:12 INFO - 'LOGNAME': 'cltbld', 15:39:12 INFO - 'MAIL': '/var/mail/cltbld', 15:39:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:12 INFO - 'MOZ_NO_REMOTE': '1', 15:39:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:12 INFO - 'NO_EM_RESTART': '1', 15:39:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:12 INFO - 'PWD': '/builds/slave/test', 15:39:12 INFO - 'SHELL': '/bin/bash', 15:39:12 INFO - 'SHLVL': '1', 15:39:12 INFO - 'TERM': 'linux', 15:39:12 INFO - 'TMOUT': '86400', 15:39:12 INFO - 'USER': 'cltbld', 15:39:12 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1495491726.669285-1678284415', 15:39:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:12 INFO - '_': '/tools/buildbot/bin/python'} 15:39:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:39:12 INFO - Cleaning up... 15:39:12 INFO - Return code: 0 15:39:12 INFO - Running post-action listener: _resource_record_post_action 15:39:12 INFO - Running post-action listener: _start_resource_monitoring 15:39:12 INFO - Starting resource monitoring. 15:39:12 INFO - [mozharness: 2017-05-22 22:39:12.792876Z] Finished create-virtualenv step (success) 15:39:12 INFO - [mozharness: 2017-05-22 22:39:12.793424Z] Running install step. 15:39:12 INFO - Running pre-action listener: _resource_record_pre_action 15:39:12 INFO - Running main action method: install 15:39:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:39:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:39:13 INFO - Reading from file tmpfile_stdout 15:39:13 INFO - Detecting whether we're running mozinstall >=1.0... 15:39:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:39:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:39:13 INFO - Reading from file tmpfile_stdout 15:39:13 INFO - Output received: 15:39:13 INFO - Usage: mozinstall [options] installer 15:39:13 INFO - Options: 15:39:13 INFO - -h, --help show this help message and exit 15:39:13 INFO - -d DEST, --destination=DEST 15:39:13 INFO - Directory to install application into. [default: 15:39:13 INFO - "/builds/slave/test"] 15:39:13 INFO - --app=APP Application being installed. [default: firefox] 15:39:13 INFO - mkdir: /builds/slave/test/build/application 15:39:13 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'] 15:39:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:39:27 INFO - Reading from file tmpfile_stdout 15:39:27 INFO - Output received: 15:39:27 INFO - /builds/slave/test/build/application/firefox/firefox 15:39:27 INFO - Running post-action listener: _resource_record_post_action 15:39:27 INFO - [mozharness: 2017-05-22 22:39:27.158932Z] Finished install step (success) 15:39:27 INFO - [mozharness: 2017-05-22 22:39:27.159173Z] Running run-tests step. 15:39:27 INFO - Running pre-action listener: _resource_record_pre_action 15:39:27 INFO - Running main action method: run_tests 15:39:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:39:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:39:27 INFO - Python 2.7.3 15:39:27 INFO - Return code: 0 15:39:27 INFO - grabbing minidump binary from tooltool 15:39:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:27 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 0x1000400>, '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 0x10013b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1001840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:39:27 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 15:39:27 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 15:39:27 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 15:39:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:39:27 INFO - Return code: 0 15:39:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:39:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:39:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:39:27 INFO - ENV: RUST_BACKTRACE is now 1 15:39:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:39:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:39:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eIW7ogXpSZWlHsQpaOZX0Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-086', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:39:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eIW7ogXpSZWlHsQpaOZX0Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-086 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:39:27 INFO - Using env: {'DISPLAY': ':0', 15:39:27 INFO - 'HOME': '/home/cltbld', 15:39:27 INFO - 'LANG': 'en_US.UTF-8', 15:39:27 INFO - 'LANGUAGE': 'en_US:en', 15:39:27 INFO - 'LOGNAME': 'cltbld', 15:39:27 INFO - 'MAIL': '/var/mail/cltbld', 15:39:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:39:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:39:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:27 INFO - 'MOZ_NO_REMOTE': '1', 15:39:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:39:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:27 INFO - 'NO_EM_RESTART': '1', 15:39:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:27 INFO - 'PWD': '/builds/slave/test', 15:39:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:39:27 INFO - 'RUST_BACKTRACE': '1', 15:39:27 INFO - 'SHELL': '/bin/bash', 15:39:27 INFO - 'SHLVL': '1', 15:39:27 INFO - 'TERM': 'linux', 15:39:27 INFO - 'TMOUT': '86400', 15:39:27 INFO - 'USER': 'cltbld', 15:39:27 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1495491726.669285-1678284415', 15:39:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:27 INFO - '_': '/tools/buildbot/bin/python'} 15:39:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eIW7ogXpSZWlHsQpaOZX0Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-086', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:39:27 INFO - mozversion application_buildid: 20170522214748 15:39:27 INFO - mozversion application_changeset: 16c20bf328da5fcd6060395fd0fb320f3b8a1146 15:39:27 INFO - mozversion application_display_name: Firefox 15:39:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:39:27 INFO - mozversion application_name: Firefox 15:39:27 INFO - mozversion application_remotingname: firefox 15:39:27 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:39:27 INFO - mozversion application_vendor: Mozilla 15:39:27 INFO - mozversion application_version: 54.0 15:39:27 INFO - mozversion platform_buildid: 20170522214748 15:39:27 INFO - mozversion platform_changeset: 16c20bf328da5fcd6060395fd0fb320f3b8a1146 15:39:27 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:39:27 INFO - mozversion platform_version: 54.0 15:39:27 INFO - using testdate: 1495492767 15:39:27 INFO - actual date: 1495492767 15:39:27 INFO - starting webserver on 'localhost:47485' 15:39:27 INFO - SUITE-START | Running 2 tests 15:39:27 INFO - TEST-START | dromaeo_css 15:39:27 INFO - operating with platform_type : linux_ 15:39:27 INFO - Initialising browser for dromaeo_css test... 15:39:27 INFO - TEST-INFO | started process 20654 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJGhkSA/profile http://localhost:47485/getInfo.html) 15:39:31 INFO - PROCESS | 20654 | __metrics Screen width/height:1600/1200 15:39:31 INFO - PROCESS | 20654 | colorDepth:24 15:39:31 INFO - PROCESS | 20654 | Browser inner width/height: 1024/697 15:39:31 INFO - PROCESS | 20654 | __metrics 15:39:32 INFO - PROCESS | 20654 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:39:32 INFO - PROCESS | 20654 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:39:32 INFO - PROCESS | 20654 | console.error: PushService: 15:39:32 INFO - PROCESS | 20654 | stateChangeProcessEnqueue: Error transitioning state 15:39:32 INFO - PROCESS | 20654 | UnknownError 15:39:33 INFO - TEST-INFO | 20654: exit 0 15:39:33 INFO - Browser initialized. 15:39:33 INFO - Running cycle 1/1 for dromaeo_css test... 15:39:33 INFO - TEST-INFO | started process 20749 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJGhkSA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:39:44 INFO - PROCESS | 20749 | RSS: Main: 141422592 15:39:44 INFO - PROCESS | 20749 | 15:42:46 INFO - PROCESS | 20749 | Cycle 1(1): loaded http://localhost:47485/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47485/tests/dromaeo/cssquery-ext.html) 15:42:47 INFO - PROCESS | 20749 | RSS: Main: 281944064 15:42:47 INFO - PROCESS | 20749 | 15:45:49 INFO - PROCESS | 20749 | Cycle 1(1): loaded http://localhost:47485/tests/dromaeo/cssquery-ext.html (next: http://localhost:47485/tests/dromaeo/cssquery-jquery.html) 15:45:50 INFO - PROCESS | 20749 | RSS: Main: 227577856 15:45:50 INFO - PROCESS | 20749 | 15:48:52 INFO - PROCESS | 20749 | Cycle 1(1): loaded http://localhost:47485/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47485/tests/dromaeo/cssquery-mootools.html) 15:48:52 INFO - PROCESS | 20749 | RSS: Main: 176533504 15:48:52 INFO - PROCESS | 20749 | 15:51:54 INFO - PROCESS | 20749 | Cycle 1(1): loaded http://localhost:47485/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47485/tests/dromaeo/cssquery-prototype.html) 15:51:55 INFO - PROCESS | 20749 | RSS: Main: 171638784 15:51:55 INFO - PROCESS | 20749 | 15:54:58 INFO - PROCESS | 20749 | Cycle 1(1): loaded http://localhost:47485/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47485/tests/dromaeo/cssquery-yui.html) 15:54:58 INFO - PROCESS | 20749 | RSS: Main: 178257920 15:54:58 INFO - PROCESS | 20749 | 15:58:00 INFO - PROCESS | 20749 | Cycle 1(1): loaded http://localhost:47485/tests/dromaeo/cssquery-yui.html (next: http://localhost:47485/tests/dromaeo/cssquery-dojo.html) 15:58:01 INFO - PROCESS | 20749 | RSS: Main: 259493888 15:58:01 INFO - PROCESS | 20749 | 15:58:01 INFO - PROCESS | 20749 | __start_tp_report 15:58:01 INFO - PROCESS | 20749 | _x_x_mozilla_page_load 15:58:01 INFO - PROCESS | 20749 | _x_x_mozilla_page_load_details 15:58:01 INFO - PROCESS | 20749 | |i|pagename|runs| 15:58:01 INFO - PROCESS | 20749 | |0;dojo.html;3417.487376893466;3458.049036514958;3474.8088855112974;3496.72026237901;3516.9472457913134;5800.825975220745;5860.912086318709;5868.3838196989345;5868.4131586841295;5882.794102206418;5846.415358464152;5910.23166988292;5914.378990206031;5914.497267732238;5915.645061296314;5225.6603320784025;5227.555657769085;5238.371395432553;5261.053010458116;5312.096943519592;5045.192769156935;5067.34124563808;5243.239730239132;5316.946830531684;5337.492938170868;5282.366116066059;5284.524392804647;5321.733913304339;5322.760475778599;5334.493223143814;5312.574994000471;5315.229291752694;5315.441878602768;5319.095753721857;5350.143976963667;4983.451820299764;5061.44324124346;5095.515925987025;5197.948020519784;5200.479952004807;5780.2196703444915;5797.623154494944;5814.592978491507;5832.300123985106;5844.123381492767;6232.439080482733;6273.717682704244;6284.18305620271;6285.59143655661;6286.842828929268;5958.940410595926;5986.760529578812;6302.18071650687;6333.240011198685;6335.936640633581;5779.913301300484;5791.0734282514595;5822.592418530705;5824.708764561798;5832.096025116114;6374.74501019954;6392.232932048184;6393.904091438632;6401.871962560723;6437.485001199892;5947.04847224442;6110.969445152746;6186.938130618726;6187.3503282154725;6188.8762224755255;6136.304638670978;6139.706800529493;6145.525073982212;6168.9691551541955;6174.783882564088;6024.939750602525;6250.531210159256;6255.718492667841;6258.780942666985;6262.436380725757;6110.832160913912;6118.20463339763;6123.234595675541;6130.049842274455;6139.508839292846;4686.789094490756;4715.552022557851;4718.551737584924;4718.740469274154;4753.881152971134;4126.463559737215;4137.069159439162;4172.895677608084;4188.099558594917;4197.748135111903;6019.668918209541;6022.1870047543025;6043.7884674036195;6062.9090563641585;6066.66633335162;6305.244549204504;6318.494520438354;6320.683965801783;6329.873402531924;6331.905021424683;5789.768409263583;6015.248093988252;6023.186869772612;6025.698715064229;6038.728257228435;5252.2384254282915;5263.7104959226845;5297.602679799031;5308.389535203501;5316.069687804618;6540.955801656171;6567.2447668516825;6578.27638959714;6582.670866456754;6583.868322633521;6252.687365631791;6261.968690156702;6290.056491526308;6310.211223597051;6314.400131987454;6249.9062514063235;6301.338359472189;6417.518686098655;6463.935360646334;6473.514486413444;6197.659128747962;6205.22434695663;6210.5652604317265;6214.40963108504;6216.968915155395;6313.463355614824;6318.241810982711;6319.494440444661;6323.873522529616;6339.2392912850755;5830.62100963436;5881.264841894763;6049.304330002106;6063.909041364472;6091.695415229309;6133.509319254538;6147.538934580014;6153.507719382528;6153.815385538441;6165.753369865155;5899.646021238567;6104.489918297086;6137.631742095488;6149.41580549847;6149.723262453111;6021.307549631673;6069.393060693896;6095.878082438415;6119.051547010221;6133.977404287468;5956.731947062306;5964.582479226586;5967.880642387215;5978.910316345346;5997.940020599738 15:58:01 INFO - PROCESS | 20749 | |1;ext.html;734.7612026091522;809.6275713171941;819.5492479136475;921.3550514639754;923.4136323434622;31596.210094747614;43544.34683479751;44607.77696111515;44693;44713;40813.183736325256;41157.58842411575;41196.794016029955;45323.320150197695;45421.77289113558;9223.216026637743;9371.20344770692;9373.906260937372;9375.062493750638;9379.390339627937;7854.175311592287;8050.5974701264995;10666.839997400046;10846.18653600983;10863.45682715861;11082.667519974413;11113.277636953613;11114.444277786119;11118.777624447546;11124.332540047582;10953.507092180831;11037.558497660084;11038.779224415506;11044.558217671283;11051.17116216287;10694.946525267324;10747.623833165802;10748.838767418494;10756;10762.677119686421;42745.786271068755;43318.35022474665;43331.78334108341;43374.78312608448;43448.348274775904;4220.134872351161;4280.464941882265;4304.870853874389;4391.099824535994;4396.912061758747;30079.849600751855;30396.84801575978;30484.54273185904;31077.37845243105;31755.364892702248;4222.78886055696;4281.978590107061;4358.411614432042;4384.780760961971;4470.8658740237515;233466;233714;234370;234786;235572;46246.306305405444;46348.53651463442;46377.30434043492;46501.767491163;46509.76745116253;46929.29606055912;47444.288335674995;47462.76268618704;47528;47589.76205118952;14352.138871667734;14590.343434545472;14686.55940321792;14738.55784326472;14740.484083057256;11087.667369978913;12578.685532861751;12585.748285034248;12586.496540138474;12589.748205035849;11520.654380368602;12290.877091228973;12418.627441176779;12545.184563003375;12589.622311330675;5518.944810551923;5526.253955716007;5536.7785288588;5598.1246282495;5619.494245517923;1025.8409946458312;1027.6762819711766;1031.63377001165;1035.4460363705532;1038.2109596706557;28474.857625712153;28517.429651406856;28755.28111797222;28813.135605931857;29153.271168220963;1096.5339730614617;1101.2786624760795;1101.6144349477618;1105.7987127266517;1134.6879608107672;14728.852711472748;15196.848031519543;15453.613659658373;15464.149471778936;15575.987560808511;356134;356726;357619;358225;358645;56790.432095678516;56920;57279.42720572824;57359;57443;1465.846086160959;1472.1167299620142;1486.8513148685045;1502.4591147187004;1511.4936496273872;27093.59359609568;28399.432011359244;28540.57189142123;28842.27894302659;28918.855405722836;42481.575184249;42719;42741.93145171396;42846.57153428426;42876.57123428726;320376;320625;320981;321136;322219;33384.1653958653;33430.49854252237;33439;34086.31827363389;34142.487862681584;35235.64764352324;36829.26341473102;43417.34873976956;46767.532324676315;48003;34407.655923441445;34553.82723086469;34589.65410345965;34718;34735;34228.657713422544;34480;34661.826690866386;34700.13249668779;34775.65224347825;39623.60376396199;39689.40465893072;40215;40665.796671016455;40857.38713919353;33174.336513270086;33316.50025249672;33316.66683333136;33371.83314083414;33533.32933341368;26742.866285668446;26853.865730671223;27036.72963270342;27108.45783084367;27210.863945680147 15:58:01 INFO - PROCESS | 20749 | |2;jquery.html;453.74590229471477;464.42411409851775;465.5484180345064;469.5023275328151;481.34537029639694;20419.387418377453;21565.24521641743;22387;22485.32544023678;22669.659955100688;19638.509037274074;20096.095675694593;20566.89716551415;21268.57462850742;21364.89317553414;6767.4586033117475;6779.694913728869;6887.7244910203535;6899.965500172517;6967.895481567781;6780.254172041072;6859.039734437158;6886.449084073262;6891.483138764587;7216.278372162794;7614.124375696811;7656.004719386472;7663.118741344733;7664.080310362764;7670.501417407879;6991.7902462926195;7250.2024777274455;7273.418126549864;7286.708531658727;7651.311381975621;7125.572465652078;7257.963710181468;7259.128904531437;7517.323440890346;7590.203028682019;25590.616140757902;25664.358391040372;25769.61345579818;25996.74003259962;26276;3089.6137982752157;3241.4003409369343;3666.156783939709;3676.2647470506004;3735.3276410246144;15615.375384984587;16251.268692908847;16526.421575244927;16586.83413165865;17030.233639486254;2296.873671948059;2347.33101066197;2399.6520504526748;2447.339218411019;2576.9226923192145;115659.42170289095;118475.4076229622;121235.3938230312;126505.36747316297;126774;21852;22027;22144.003519841644;24044.639330410057;24480.877595611906;43475.34786978135;43914.56085439169;43972.56027439749;44007.339889901676;44438.77780611076;11503.597374091867;11683.824742628867;11768.117391195523;11888.524459021715;12092.762838874836;9415.858762118574;9526.571304291323;9536.809263814685;9692.951535242279;9856.950715246378;11099.944500277446;11489.770204595861;11532.192746507832;12041.759164816829;12065.819012714815;3936.980315098406;4034.2854286927936;4120.526139493936;4177.352510360899;4403.14138742942;1182.8166634171716;1199.3343694249775;1200.4057991294192;1222.529326209398;1230.2864338683542;20139.194432222546;20283.79716202819;20345.389638310873;20464.795352046585;20621.89689051545;1170.1984140863535;1179.5281887245171;1182.5388098641536;1186.033382793021;1214.2957084890743;10745.086667633339;11366.318020918772;11411.771764564828;11472.598459053894;11486;673640;673728;679123;679846;691239;115965.4201728986;117701;118742;120474;124249;1281.3657239666425;1299.5191779041816;1320.3134370127673;1343.6573673713335;1344.072589912957;17855.553611159827;18015.099245037956;18063.458096257134;18323.175457104197;18409.447716568524;52429.47570524246;52430.47569524256;52453;53179;54150.18774718461;69313.3068669327;69406;69622.25944351431;70353.64823175852;71293.64353178201;12269.75460490803;12567.93716031414;12709.1739036966;12755.744885102431;12823;13825.377857996615;13863.72272554523;13872.861271387157;14066.859331406964;14291.499797507453;12028.218165819193;12080.39598020078;12433.75132497327;12515.874841251834;12571.057170712416;11062.391568463812;11103.50034248477;11120.388378639253;11120.721981950515;11129.610463633733;12373.814392784296;12479.376031198222;12542.811857822322;12588.181768185039;12627.3686315682;12133;12203;12346.320952347707;12388.938055309665;12635.3682315882;12177.817332740193;12282.990667286573;12284.38578071075;12302.876971230173;12643.620691379274 15:58:01 INFO - PROCESS | 20749 | |3;mootools.html;1426.529245349035;1582.905025698458;1586.9206539673014;1605.6307049378638;1616.442327397048;9391.29565282604;10870.293430926995;11058.944705276483;11096.944515277411;11164.832527512084;11287.604933827317;11352.829707554394;11371.545138194462;11387.544498220082;11403.315801051942;2009.7990200979857;2072.823809976154;2465.728769835312;2495.1641200197955;2502.4119331956977;2480.06997375984;2526.2042456626195;2531.063506502587;2534.42975330551;2541.796656267494;2459.1515927005244;2471.6910386201725;2478.1698131126004;2485.801135909123;2492.53888030714;2464.963025554618;2484.006397441029;2487.9502409951792;2491.476789874129;2493.887775050127;2333.813294936418;2339.099446713011;2355.0815182079004;2361.984346730905;2363.2910126962015;11633.883661163365;11660.883391166064;11741.88258117425;11749.353785541793;11759.764804703944;5695.857603559903;5803.332616749043;5842.941570584282;5854.97072514639;5856.912146317809;3485.2855164691177;3503.789772613651;3561.0385195997196;3619.6199399063244;3666.6699997000132;1375.7454870848826;1401.7757158854533;1407.971840563183;1412.3644360038024;1458.64263255502;17293.04888231147;17624.647507049787;18005.7299140513;18009.459716208534;18242.087895605167;4596.7931443085145;4741.976290118528;4806.44725856524;4824.782884770194;4831.492693267227;13308.134971226838;13350.399232034582;13361.599152025456;13381.598552043455;13387.732245355039;5746.166805813134;5759.625624334405;5760.6543607382855;5760.769569217185;5765.048766953406;5120.48795120485;5187.662801917939;5219.399769026534;5248.685078895279;5322.0952438085615;4107.9178416431505;4173.08192197716;4266.146770645883;4323.718958267703;4327.502337231196;1062.2298833345917;1067.4662668665667;1070.71626019105;1086.9619563315246;1087.6138970665459;1097.540439610513;1111.2499063132354;1117.7149826794116;1121.6354684727496;1158.137187795098;7495.962520187364;7547.886781698279;7583.658735356812;7678.5392876427595;7690.077190737147;1045.325764881647;1050.4033868519807;1062.5484169228048;1070.272214893864;1082.6210826210763;4597.56323149307;4883.8290659826735;4925.630577706686;5006.349174607278;5132.178851383761;15155.621109472131;15659.060456372654;15680.372785088697;15699.136547489998;15700.528984130495;15177.93754437201;15509.612259693598;15531.611709707347;15558.84441155574;15571.29929153168;10783.191260655482;10890.401027943539;10900.945495272632;11013.2841365311;11046.779064418666;7242.927570724225;7347.08161479815;7380.335769780745;7393.223711510429;7508.511946723445;12965.546205882749;13070.346482675637;13118.409671564612;13140.27728474943;13160.210387376788;11351.772964540498;11796.941015295211;13304.800427993394;13439.225354557942;13568.050236483352;9688.41869487833;9805.313628045968;9882.456464894212;9890.85163722559;10019.248556358156;10734.892651073702;10760.408177549996;10809.35143891369;10858.837117443087;10877.728056798644;9142.58858351389;9167.724968250963;9228.492432915986;9245.445273283625;9376.249900008119;8724.956375218084;8809.339299552432;8828.42615230008;8954.955225223832;9162.770930726785;8670.869936950825;8694;8719.52042637661;8788.692395766118;8853.203211710977;6521.478281737354;6622;6661.500387471056;6678.799636010927;6715.832104197434;6419;6439.8068057958335;6517.446017088411;6527.281998980014;6676.766313179015 15:58:01 INFO - PROCESS | 20749 | |4;prototype.html;413.5864135864136;437.4357079367616;437.540582388492;444.22482767570597;445.38536819189534;5252.921206181905;5343.519083282504;5404.405515393303;5405.270288511055;5415.512603865652;4977.502249775021;5214.713190774506;5243.4232234454175;5252.290940723001;5262.315898933133;4256.148575369724;4284.314509678452;4294.935575966363;4299.742015479065;4307.849225277116;4301.225779359714;4307.483102027761;4308.310670292738;4322.243607368698;4400.163968845909;4335.523092459843;4346.195953748566;4349.26062569364;4358.825646974133;4389.23188442023;4177.352510360899;4306.33251845966;4313.762743049131;4317.15815415994;4324.113556720865;4062.6749860011128;4064.7357921734992;4071.7760523171214;4074.653654439376;4135.0902801383645;5065;5071.518205770446;5088.592912566985;5093.522878365269;5107.233914912756;4925.236588328815;4976.975115124437;4996.63126188967;5041.369828771403;5077.5684066854365;5435.456454354572;5471.671699698031;5482.835514934558;5488.259085023511;5566.805161819358;4478.641708663332;4547.772611369418;4550.658700597469;4579.175748365293;4664.906701865943;5553.888922221533;5685.346185188715;5702.258706368146;5726.5705072119345;5803.187553742479;4669.649776266793;4696.600788932979;4717.193270004342;4719.528047195253;4731.858044258678;4670.64970127235;4783.339928769278;4793.832215872428;4832.830850920201;4897.853064408074;5071.39143302806;5076.390833100052;5093.134167191586;5101.132807422747;5122.385313762298;5434.016583946831;5448.536874365644;5530.064477432867;5531.280933478622;5548.4174161713245;1555.1058141568417;1631.9836801632068;1647.9176041197893;1656.6438215783664;1660.8754343424291;1262.0156278103095;1276.704145292529;1292.476546998467;1309.6071178646368;1310.3841194638505;5401.730593310569;5409.323834520685;5419.13040001199;5423.701696406735;5431.728413579305;5563.972180139073;5603.271574695264;5611.915821262684;5620.662760234399;5636.661800291996;5254.343207099113;5313.548348390353;5375.381831089475;5400.432954539717;5408.242846001563;2919.7445098607805;2953.8375389353364;2954.9409011819644;2965.021542890841;2969.539721343195;5754.510866576305;5781.971090144522;5795.217645617872;5796.275465566804;5830.38780928005;5392.352917649907;5523.917141242885;5655.830325090254;5686.317641883001;5738.44639135589;5728.94014607299;5783.277090363705;5787.768489260382;5794.62334948227;5861.531077513703;5555.666660000413;5587.463447551956;5622.662640241599;5632.183333416713;5643.379228284967;5466.863328416822;5484.7806087757635;5493.599132221258;5505.862353441196;5645.266115404971;5793.275840519935;5814.796482123105;5815.3603103657715;5824.970875145597;5863.442972917566;4442.200403927195;4669.39297891272;4679.923617568046;4686.812527498998;4769.117713223065;5564.805231816867;5571.387147413862;5572.944270557405;5590.217369568182;5638.971805140948;5491.258680078298;5495.697736624365;5500.50495455411;5528.944710552843;5540.944590554042;5235.581153507634;5467.6719396836315;5470.288862448016;5471.945280547144;5503.284573005483;5429.294191755047;5437.646552974203;5532.5020748132865;5558.166275058774;5563.443655634404;5571.804986825442;5587.944120558743;5594.356648985418;5613.803516876889;5617.297837770278;5301.920471193012;5310.734463276744;5327.987682340343;5363;5461.743798926349 15:58:01 INFO - PROCESS | 20749 | |5;yui.html;853.543354305446;873.4846440600045;916.5600511754358;923.6890015527104;929.6002718830904;17547.2103755331;19067.713984290247;19102.14040368183;19117.904410477946;19192.136353864076;17274.56813579661;17637.64724705505;17821.82178178221;17835.37576184834;17859.017754023524;899.8155378147496;909.417972497602;919.6551293265026;919.7424721078108;919.908009199078;912.1516989200042;912.9771755706095;914.5244472874101;914.5290175559592;914.6432891172448;948.5399581203111;950.2065775077818;956.1681337236614;957;957.5547370472729;944.5466176235377;945.8202941441104;947.2706016367393;947.3842002698233;954.2699834626447;701.7158050989358;704.4223736536043;709.4501761135161;709.8615769924867;709.8615769924867;15872.285747141406;15972.680546389123;15995.280212390471;16466.588335291595;16923;14824.555263342118;15234.238288085551;15279.312430940634;15384.846151538453;15438.768418473732;12789;12868.420921058574;13027.86972130276;13152.21086734799;13277.402516886763;4006.9198616027516;4030.0730831908827;4039.8508332130295;4055.393164989364;4104.56902025286;48503.514964850256;54431.455685443034;56465.43534564643;70932.2906770936;82697.75953360704;13737.313134343443;13777.242251676054;13993.72012559743;14018.929905350611;14094.365753541115;25127.87436062808;25209.495810083696;25342.87328563382;25429.618555721678;25448;9113;9177.541122943827;9459.432434053979;9487.525623718924;9494.240460763122;5207.92188117171;5317.499488989629;5333.466653334635;5431.131019036935;5453.809116680897;3573.982130089385;3669.064388580895;3676.5955744868043;3692.593814680383;3815.7138214634015;670.3966430212847;671.342084756941;671.5567725301278;684.322520704499;685.7634116229992;831.983360332802;852.1946760311446;852.3224036890687;872.3718922375879;877.4165180155253;11666.824997625043;12251.264924104582;12266.877331226573;12536.36736285372;12814.615561533168;849.5370023337296;859.832332695131;874.7594411536878;878.2578720980761;893.2095095840228;5694.4590263924865;5765.596408251382;5787.305523337142;5896.469317761422;5906.940930590639;84046.15953840506;86303.56848215719;86432.56783716167;87384.56307718548;87463.56268218618;51663.48336516587;56792.71603641955;62993.68503157455;73380.63309683418;75727;56866.715666421405;62662.373376266565;62872;63241.683791581665;63559.36440635627;11263.774724505627;11915.940420297842;12210.938945305572;12401.379931003594;12706.87293127057;41338;41763.373549397395;42319;42619.147617048104;42889.57110428856;49229;49655.503444965085;50662.49337506578;52055;52551.21173182482;13197.736045279233;13276.33618319061;13751.724965500835;14011.166734675744;14045.578632641038;16769.496915092568;16842.915785421486;16938.91530542389;17350.913245434196;17543;15110.924445377703;15407.691846163238;15531.145786981824;16192.947458415165;16728.330866765195;16036;16068.758968615246;16218.67562648764;16418.425355112515;16570.171491425623;15299.61750956235;15467.613309667347;15761.68476630484;15801.525954221392;16486.67026659484;11637.134090886419;11642.79395246664;12096.213746106476;12257.203281786655;12285.692857678272;12649.367531623198;12818.294993775431;12860.871391285968;12990.350482476028;13065.150765200231 15:58:01 INFO - PROCESS | 20749 | __end_tp_report 15:58:01 INFO - PROCESS | 20749 | __start_cc_report 15:58:01 INFO - PROCESS | 20749 | _x_x_mozilla_cycle_collect,1420 15:58:01 INFO - PROCESS | 20749 | __end_cc_report 15:58:01 INFO - PROCESS | 20749 | __startTimestamp1495493881127__endTimestamp 15:58:01 INFO - PROCESS | 20749 | 15:58:01 INFO - PROCESS | 20749 | ------- Summary: start ------- 15:58:01 INFO - PROCESS | 20749 | Number of tests: 6 15:58:01 INFO - PROCESS | 20749 | 15:58:01 INFO - PROCESS | 20749 | [#0] dojo.html Cycles:165 Average:5790.37 Median:6024.94 stddev:672.05 (11.2%) stddev-sans-first:647.81 15:58:01 INFO - PROCESS | 20749 | Values: 3417.5 3458.0 3474.8 3496.7 3516.9 5800.8 5860.9 5868.4 5868.4 5882.8 5846.4 5910.2 5914.4 5914.5 5915.6 5225.7 5227.6 5238.4 5261.1 5312.1 5045.2 5067.3 5243.2 5316.9 5337.5 5282.4 5284.5 5321.7 5322.8 5334.5 5312.6 5315.2 5315.4 5319.1 5350.1 4983.5 5061.4 5095.5 5197.9 5200.5 5780.2 5797.6 5814.6 5832.3 5844.1 6232.4 6273.7 6284.2 6285.6 6286.8 5958.9 5986.8 6302.2 6333.2 6335.9 5779.9 5791.1 5822.6 5824.7 5832.1 6374.7 6392.2 6393.9 6401.9 6437.5 5947.0 6111.0 6186.9 6187.4 6188.9 6136.3 6139.7 6145.5 6169.0 6174.8 6024.9 6250.5 6255.7 6258.8 6262.4 6110.8 6118.2 6123.2 6130.0 6139.5 4686.8 4715.6 4718.6 4718.7 4753.9 4126.5 4137.1 4172.9 4188.1 4197.7 6019.7 6022.2 6043.8 6062.9 6066.7 6305.2 6318.5 6320.7 6329.9 6331.9 5789.8 6015.2 6023.2 6025.7 6038.7 5252.2 5263.7 5297.6 5308.4 5316.1 6541.0 6567.2 6578.3 6582.7 6583.9 6252.7 6262.0 6290.1 6310.2 6314.4 6249.9 6301.3 6417.5 6463.9 6473.5 6197.7 6205.2 6210.6 6214.4 6217.0 6313.5 6318.2 6319.5 6323.9 6339.2 5830.6 5881.3 6049.3 6063.9 6091.7 6133.5 6147.5 6153.5 6153.8 6165.8 5899.6 6104.5 6137.6 6149.4 6149.7 6021.3 6069.4 6095.9 6119.1 6134.0 5956.7 5964.6 5967.9 5978.9 5997.9 15:58:01 INFO - PROCESS | 20749 | 15:58:01 INFO - PROCESS | 20749 | [#1] ext.html Cycles:180 Average:47022.51 Median:33486.16 stddev:80830.53 (241.4%) stddev-sans-first:80982.56 15:58:01 INFO - PROCESS | 20749 | Values: 734.8 809.6 819.5 921.4 923.4 31596.2 43544.3 44607.8 44693.0 44713.0 40813.2 41157.6 41196.8 45323.3 45421.8 9223.2 9371.2 9373.9 9375.1 9379.4 7854.2 8050.6 10666.8 10846.2 10863.5 11082.7 11113.3 11114.4 11118.8 11124.3 10953.5 11037.6 11038.8 11044.6 11051.2 10694.9 10747.6 10748.8 10756.0 10762.7 42745.8 43318.4 43331.8 43374.8 43448.3 4220.1 4280.5 4304.9 4391.1 4396.9 30079.8 30396.8 30484.5 31077.4 31755.4 4222.8 4282.0 4358.4 4384.8 4470.9 233466.0 233714.0 234370.0 234786.0 235572.0 46246.3 46348.5 46377.3 46501.8 46509.8 46929.3 47444.3 47462.8 47528.0 47589.8 14352.1 14590.3 14686.6 14738.6 14740.5 11087.7 12578.7 12585.7 12586.5 12589.7 11520.7 12290.9 12418.6 12545.2 12589.6 5518.9 5526.3 5536.8 5598.1 5619.5 1025.8 1027.7 1031.6 1035.4 1038.2 28474.9 28517.4 28755.3 28813.1 29153.3 1096.5 1101.3 1101.6 1105.8 1134.7 14728.9 15196.8 15453.6 15464.1 15576.0 356134.0 356726.0 357619.0 358225.0 358645.0 56790.4 56920.0 57279.4 57359.0 57443.0 1465.8 1472.1 1486.9 1502.5 1511.5 27093.6 28399.4 28540.6 28842.3 28918.9 42481.6 42719.0 42741.9 42846.6 42876.6 320376.0 320625.0 320981.0 321136.0 322219.0 33384.2 33430.5 33439.0 34086.3 34142.5 35235.6 36829.3 43417.3 46767.5 48003.0 34407.7 34553.8 34589.7 34718.0 34735.0 34228.7 34480.0 34661.8 34700.1 34775.7 39623.6 39689.4 40215.0 40665.8 40857.4 33174.3 33316.5 33316.7 33371.8 33533.3 26742.9 26853.9 27036.7 27108.5 27210.9 15:58:01 INFO - PROCESS | 20749 | 15:58:01 INFO - PROCESS | 20749 | [#2] jquery.html Cycles:180 Average:39322.13 Median:20442.09 stddev:112097.91 (548.4%) stddev-sans-first:112374.39 15:58:01 INFO - PROCESS | 20749 | Values: 453.7 464.4 465.5 469.5 481.3 20419.4 21565.2 22387.0 22485.3 22669.7 19638.5 20096.1 20566.9 21268.6 21364.9 6767.5 6779.7 6887.7 6900.0 6967.9 6780.3 6859.0 6886.4 6891.5 7216.3 7614.1 7656.0 7663.1 7664.1 7670.5 6991.8 7250.2 7273.4 7286.7 7651.3 7125.6 7258.0 7259.1 7517.3 7590.2 25590.6 25664.4 25769.6 25996.7 26276.0 3089.6 3241.4 3666.2 3676.3 3735.3 15615.4 16251.3 16526.4 16586.8 17030.2 2296.9 2347.3 2399.7 2447.3 2576.9 115659.4 118475.4 121235.4 126505.4 126774.0 21852.0 22027.0 22144.0 24044.6 24480.9 43475.3 43914.6 43972.6 44007.3 44438.8 11503.6 11683.8 11768.1 11888.5 12092.8 9415.9 9526.6 9536.8 9693.0 9857.0 11099.9 11489.8 11532.2 12041.8 12065.8 3937.0 4034.3 4120.5 4177.4 4403.1 1182.8 1199.3 1200.4 1222.5 1230.3 20139.2 20283.8 20345.4 20464.8 20621.9 1170.2 1179.5 1182.5 1186.0 1214.3 10745.1 11366.3 11411.8 11472.6 11486.0 673640.0 673728.0 679123.0 679846.0 691239.0 115965.4 117701.0 118742.0 120474.0 124249.0 1281.4 1299.5 1320.3 1343.7 1344.1 17855.6 18015.1 18063.5 18323.2 18409.4 52429.5 52430.5 52453.0 53179.0 54150.2 69313.3 69406.0 69622.3 70353.6 71293.6 12269.8 12567.9 12709.2 12755.7 12823.0 13825.4 13863.7 13872.9 14066.9 14291.5 12028.2 12080.4 12433.8 12515.9 12571.1 11062.4 11103.5 11120.4 11120.7 11129.6 12373.8 12479.4 12542.8 12588.2 12627.4 12133.0 12203.0 12346.3 12388.9 12635.4 12177.8 12283.0 12284.4 12302.9 12643.6 15:58:01 INFO - PROCESS | 20749 | 15:58:01 INFO - PROCESS | 20749 | [#3] mootools.html Cycles:180 Average:7251.38 Median:2474.93 stddev:4676.07 (188.9%) stddev-sans-first:4668.71 15:58:01 INFO - PROCESS | 20749 | Values: 1426.5 1582.9 1586.9 1605.6 1616.4 9391.3 10870.3 11058.9 11096.9 11164.8 11287.6 11352.8 11371.5 11387.5 11403.3 2009.8 2072.8 2465.7 2495.2 2502.4 2480.1 2526.2 2531.1 2534.4 2541.8 2459.2 2471.7 2478.2 2485.8 2492.5 2465.0 2484.0 2488.0 2491.5 2493.9 2333.8 2339.1 2355.1 2362.0 2363.3 11633.9 11660.9 11741.9 11749.4 11759.8 5695.9 5803.3 5842.9 5855.0 5856.9 3485.3 3503.8 3561.0 3619.6 3666.7 1375.7 1401.8 1408.0 1412.4 1458.6 17293.0 17624.6 18005.7 18009.5 18242.1 4596.8 4742.0 4806.4 4824.8 4831.5 13308.1 13350.4 13361.6 13381.6 13387.7 5746.2 5759.6 5760.7 5760.8 5765.0 5120.5 5187.7 5219.4 5248.7 5322.1 4107.9 4173.1 4266.1 4323.7 4327.5 1062.2 1067.5 1070.7 1087.0 1087.6 1097.5 1111.2 1117.7 1121.6 1158.1 7496.0 7547.9 7583.7 7678.5 7690.1 1045.3 1050.4 1062.5 1070.3 1082.6 4597.6 4883.8 4925.6 5006.3 5132.2 15155.6 15659.1 15680.4 15699.1 15700.5 15177.9 15509.6 15531.6 15558.8 15571.3 10783.2 10890.4 10900.9 11013.3 11046.8 7242.9 7347.1 7380.3 7393.2 7508.5 12965.5 13070.3 13118.4 13140.3 13160.2 11351.8 11796.9 13304.8 13439.2 13568.1 9688.4 9805.3 9882.5 9890.9 10019.2 10734.9 10760.4 10809.4 10858.8 10877.7 9142.6 9167.7 9228.5 9245.4 9376.2 8725.0 8809.3 8828.4 8955.0 9162.8 8670.9 8694.0 8719.5 8788.7 8853.2 6521.5 6622.0 6661.5 6678.8 6715.8 6419.0 6439.8 6517.4 6527.3 6676.8 15:58:01 INFO - PROCESS | 20749 | 15:58:01 INFO - PROCESS | 20749 | [#4] prototype.html Cycles:180 Average:4785.42 Median:5320.77 stddev:1273.13 (23.9%) stddev-sans-first:1233.69 15:58:01 INFO - PROCESS | 20749 | Values: 413.6 437.4 437.5 444.2 445.4 5252.9 5343.5 5404.4 5405.3 5415.5 4977.5 5214.7 5243.4 5252.3 5262.3 4256.1 4284.3 4294.9 4299.7 4307.8 4301.2 4307.5 4308.3 4322.2 4400.2 4335.5 4346.2 4349.3 4358.8 4389.2 4177.4 4306.3 4313.8 4317.2 4324.1 4062.7 4064.7 4071.8 4074.7 4135.1 5065.0 5071.5 5088.6 5093.5 5107.2 4925.2 4977.0 4996.6 5041.4 5077.6 5435.5 5471.7 5482.8 5488.3 5566.8 4478.6 4547.8 4550.7 4579.2 4664.9 5553.9 5685.3 5702.3 5726.6 5803.2 4669.6 4696.6 4717.2 4719.5 4731.9 4670.6 4783.3 4793.8 4832.8 4897.9 5071.4 5076.4 5093.1 5101.1 5122.4 5434.0 5448.5 5530.1 5531.3 5548.4 1555.1 1632.0 1647.9 1656.6 1660.9 1262.0 1276.7 1292.5 1309.6 1310.4 5401.7 5409.3 5419.1 5423.7 5431.7 5564.0 5603.3 5611.9 5620.7 5636.7 5254.3 5313.5 5375.4 5400.4 5408.2 2919.7 2953.8 2954.9 2965.0 2969.5 5754.5 5782.0 5795.2 5796.3 5830.4 5392.4 5523.9 5655.8 5686.3 5738.4 5728.9 5783.3 5787.8 5794.6 5861.5 5555.7 5587.5 5622.7 5632.2 5643.4 5466.9 5484.8 5493.6 5505.9 5645.3 5793.3 5814.8 5815.4 5825.0 5863.4 4442.2 4669.4 4679.9 4686.8 4769.1 5564.8 5571.4 5572.9 5590.2 5639.0 5491.3 5495.7 5500.5 5528.9 5540.9 5235.6 5467.7 5470.3 5471.9 5503.3 5429.3 5437.6 5532.5 5558.2 5563.4 5571.8 5587.9 5594.4 5613.8 5617.3 5301.9 5310.7 5328.0 5363.0 5461.7 15:58:01 INFO - PROCESS | 20749 | 15:58:01 INFO - PROCESS | 20749 | [#5] yui.html Cycles:180 Average:18109.47 Median:41550.69 stddev:21349.56 (51.4%) stddev-sans-first:21370.13 15:58:01 INFO - PROCESS | 20749 | Values: 853.5 873.5 916.6 923.7 929.6 17547.2 19067.7 19102.1 19117.9 19192.1 17274.6 17637.6 17821.8 17835.4 17859.0 899.8 909.4 919.7 919.7 919.9 912.2 913.0 914.5 914.5 914.6 948.5 950.2 956.2 957.0 957.6 944.5 945.8 947.3 947.4 954.3 701.7 704.4 709.5 709.9 709.9 15872.3 15972.7 15995.3 16466.6 16923.0 14824.6 15234.2 15279.3 15384.8 15438.8 12789.0 12868.4 13027.9 13152.2 13277.4 4006.9 4030.1 4039.9 4055.4 4104.6 48503.5 54431.5 56465.4 70932.3 82697.8 13737.3 13777.2 13993.7 14018.9 14094.4 25127.9 25209.5 25342.9 25429.6 25448.0 9113.0 9177.5 9459.4 9487.5 9494.2 5207.9 5317.5 5333.5 5431.1 5453.8 3574.0 3669.1 3676.6 3692.6 3815.7 670.4 671.3 671.6 684.3 685.8 832.0 852.2 852.3 872.4 877.4 11666.8 12251.3 12266.9 12536.4 12814.6 849.5 859.8 874.8 878.3 893.2 5694.5 5765.6 5787.3 5896.5 5906.9 84046.2 86303.6 86432.6 87384.6 87463.6 51663.5 56792.7 62993.7 73380.6 75727.0 56866.7 62662.4 62872.0 63241.7 63559.4 11263.8 11915.9 12210.9 12401.4 12706.9 41338.0 41763.4 42319.0 42619.1 42889.6 49229.0 49655.5 50662.5 52055.0 52551.2 13197.7 13276.3 13751.7 14011.2 14045.6 16769.5 16842.9 16938.9 17350.9 17543.0 15110.9 15407.7 15531.1 16192.9 16728.3 16036.0 16068.8 16218.7 16418.4 16570.2 15299.6 15467.6 15761.7 15801.5 16486.7 11637.1 11642.8 12096.2 12257.2 12285.7 12649.4 12818.3 12860.9 12990.4 13065.2 15:58:01 INFO - PROCESS | 20749 | -------- Summary: end -------- 15:58:01 INFO - PROCESS | 20749 | 15:58:01 INFO - TEST-INFO | 20749: exit 0 15:58:01 INFO - TEST-OK | dromaeo_css | took 1114441ms 15:58:01 INFO - TEST-START | kraken 15:58:01 INFO - operating with platform_type : linux_ 15:58:01 INFO - Initialising browser for kraken test... 15:58:01 INFO - TEST-INFO | started process 21050 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplBVEG5/profile http://localhost:47485/getInfo.html) 15:58:05 INFO - PROCESS | 21050 | __metrics Screen width/height:1600/1200 15:58:05 INFO - PROCESS | 21050 | colorDepth:24 15:58:05 INFO - PROCESS | 21050 | Browser inner width/height: 1024/697 15:58:05 INFO - PROCESS | 21050 | __metrics 15:58:06 INFO - PROCESS | 21050 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:58:06 INFO - PROCESS | 21050 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:58:07 INFO - TEST-INFO | 21050: exit 0 15:58:07 INFO - Browser initialized. 15:58:07 INFO - Running cycle 1/1 for kraken test... 15:58:07 INFO - TEST-INFO | started process 21140 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplBVEG5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:58:19 INFO - PROCESS | 21140 | RSS: Main: 140808192 15:58:19 INFO - PROCESS | 21140 | 15:58:21 INFO - PROCESS | 21140 | Cycle 1(1): loaded http://localhost:47485/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47485/tests/kraken/driver.html?testName=audio-beat-detection) 15:58:22 INFO - PROCESS | 21140 | RSS: Main: 183803904 15:58:22 INFO - PROCESS | 21140 | 15:58:25 INFO - PROCESS | 21140 | Cycle 1(1): loaded http://localhost:47485/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47485/tests/kraken/driver.html?testName=audio-dft) 15:58:25 INFO - PROCESS | 21140 | RSS: Main: 173682688 15:58:25 INFO - PROCESS | 21140 | 15:58:28 INFO - PROCESS | 21140 | Cycle 1(1): loaded http://localhost:47485/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47485/tests/kraken/driver.html?testName=audio-fft) 15:58:29 INFO - PROCESS | 21140 | RSS: Main: 264978432 15:58:29 INFO - PROCESS | 21140 | 15:58:31 INFO - PROCESS | 21140 | Cycle 1(1): loaded http://localhost:47485/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47485/tests/kraken/driver.html?testName=audio-oscillator) 15:58:31 INFO - PROCESS | 21140 | RSS: Main: 171327488 15:58:31 INFO - PROCESS | 21140 | 15:58:33 INFO - PROCESS | 21140 | Cycle 1(1): loaded http://localhost:47485/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47485/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:58:34 INFO - PROCESS | 21140 | RSS: Main: 174059520 15:58:34 INFO - PROCESS | 21140 | 15:58:37 INFO - PROCESS | 21140 | Cycle 1(1): loaded http://localhost:47485/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47485/tests/kraken/driver.html?testName=imaging-darkroom) 15:58:37 INFO - PROCESS | 21140 | RSS: Main: 212377600 15:58:37 INFO - PROCESS | 21140 | 15:58:41 INFO - PROCESS | 21140 | Cycle 1(1): loaded http://localhost:47485/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47485/tests/kraken/driver.html?testName=imaging-desaturate) 15:58:41 INFO - PROCESS | 21140 | RSS: Main: 212676608 15:58:41 INFO - PROCESS | 21140 | 15:58:44 INFO - PROCESS | 21140 | Cycle 1(1): loaded http://localhost:47485/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47485/tests/kraken/driver.html?testName=json-parse-financial) 15:58:45 INFO - PROCESS | 21140 | RSS: Main: 211308544 15:58:45 INFO - PROCESS | 21140 | 15:58:46 INFO - PROCESS | 21140 | Cycle 1(1): loaded http://localhost:47485/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47485/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:58:47 INFO - PROCESS | 21140 | RSS: Main: 173875200 15:58:47 INFO - PROCESS | 21140 | 15:58:48 INFO - PROCESS | 21140 | Cycle 1(1): loaded http://localhost:47485/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47485/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:58:49 INFO - PROCESS | 21140 | RSS: Main: 179843072 15:58:49 INFO - PROCESS | 21140 | 15:58:51 INFO - PROCESS | 21140 | Cycle 1(1): loaded http://localhost:47485/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47485/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:58:52 INFO - PROCESS | 21140 | RSS: Main: 189829120 15:58:52 INFO - PROCESS | 21140 | 15:58:54 INFO - PROCESS | 21140 | Cycle 1(1): loaded http://localhost:47485/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47485/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:58:55 INFO - PROCESS | 21140 | RSS: Main: 199294976 15:58:55 INFO - PROCESS | 21140 | 15:58:58 INFO - PROCESS | 21140 | Cycle 1(1): loaded http://localhost:47485/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47485/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:58:58 INFO - PROCESS | 21140 | RSS: Main: 195264512 15:58:58 INFO - PROCESS | 21140 | 15:59:00 INFO - PROCESS | 21140 | Cycle 1(1): loaded http://localhost:47485/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47485/tests/kraken/driver.html?testName=ai-astar) 15:59:00 INFO - PROCESS | 21140 | RSS: Main: 246042624 15:59:00 INFO - PROCESS | 21140 | 15:59:00 INFO - PROCESS | 21140 | __start_tp_report 15:59:00 INFO - PROCESS | 21140 | _x_x_mozilla_page_load 15:59:00 INFO - PROCESS | 21140 | _x_x_mozilla_page_load_details 15:59:00 INFO - PROCESS | 21140 | |i|pagename|runs| 15:59:00 INFO - PROCESS | 21140 | |0;ai-astar;104;112;114;113;113;112;112;112;113;113 15:59:00 INFO - PROCESS | 21140 | |1;audio-beat-detection;147;119;121;154;116;115;115;115;136;121 15:59:00 INFO - PROCESS | 21140 | |2;audio-dft;160;160;160;159;158;160;159;160;162;161 15:59:00 INFO - PROCESS | 21140 | |3;audio-fft;75;74;81;123;77;76;75;76;90;76 15:59:00 INFO - PROCESS | 21140 | |4;audio-oscillator;81;82;103;82;82;82;92;82;83;105 15:59:00 INFO - PROCESS | 21140 | |5;imaging-gaussian-blur;113;112;113;113;112;113;113;113;113;113 15:59:00 INFO - PROCESS | 21140 | |6;imaging-darkroom;147;145;146;146;146;146;146;145;146;146 15:59:00 INFO - PROCESS | 21140 | |7;imaging-desaturate;94;94;94;94;94;94;93;94;94;93 15:59:00 INFO - PROCESS | 21140 | |8;json-parse-financial;54;54;55;55;54;53;55;54;55;53 15:59:00 INFO - PROCESS | 21140 | |9;json-stringify-tinderbox;52;52;51;52;53;52;52;52;52;52 15:59:00 INFO - PROCESS | 21140 | |10;stanford-crypto-aes;85;82;79;76;80;81;80;80;75;83 15:59:00 INFO - PROCESS | 21140 | |11;stanford-crypto-ccm;123;122;126;124;129;127;119;119;159;121 15:59:00 INFO - PROCESS | 21140 | |12;stanford-crypto-pbkdf2;161;164;159;167;161;159;165;171;162;161 15:59:00 INFO - PROCESS | 21140 | |13;stanford-crypto-sha256-iterative;61;60;62;59;59;59;58;58;58;62 15:59:00 INFO - PROCESS | 21140 | __end_tp_report 15:59:00 INFO - PROCESS | 21140 | __start_cc_report 15:59:00 INFO - PROCESS | 21140 | _x_x_mozilla_cycle_collect,1678 15:59:00 INFO - PROCESS | 21140 | __end_cc_report 15:59:00 INFO - PROCESS | 21140 | __startTimestamp1495493940650__endTimestamp 15:59:00 INFO - PROCESS | 21140 | 15:59:00 INFO - PROCESS | 21140 | ------- Summary: start ------- 15:59:00 INFO - PROCESS | 21140 | Number of tests: 14 15:59:00 INFO - PROCESS | 21140 | 15:59:00 INFO - PROCESS | 21140 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.00 stddev:2.82 (2.5%) stddev-sans-first:0.71 15:59:00 INFO - PROCESS | 21140 | Values: 104.0 112.0 114.0 113.0 113.0 112.0 112.0 112.0 113.0 113.0 15:59:00 INFO - PROCESS | 21140 | 15:59:00 INFO - PROCESS | 21140 | [#1] audio-beat-detection Cycles:10 Average:125.90 Median:121.00 stddev:14.48 (12.0%) stddev-sans-first:13.19 15:59:00 INFO - PROCESS | 21140 | Values: 147.0 119.0 121.0 154.0 116.0 115.0 115.0 115.0 136.0 121.0 15:59:00 INFO - PROCESS | 21140 | 15:59:00 INFO - PROCESS | 21140 | [#2] audio-dft Cycles:10 Average:159.90 Median:160.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 15:59:00 INFO - PROCESS | 21140 | Values: 160.0 160.0 160.0 159.0 158.0 160.0 159.0 160.0 162.0 161.0 15:59:00 INFO - PROCESS | 21140 | 15:59:00 INFO - PROCESS | 21140 | [#3] audio-fft Cycles:10 Average:82.30 Median:76.00 stddev:15.06 (19.8%) stddev-sans-first:15.74 15:59:00 INFO - PROCESS | 21140 | Values: 75.0 74.0 81.0 123.0 77.0 76.0 75.0 76.0 90.0 76.0 15:59:00 INFO - PROCESS | 21140 | 15:59:00 INFO - PROCESS | 21140 | [#4] audio-oscillator Cycles:10 Average:87.40 Median:82.00 stddev:9.31 (11.4%) stddev-sans-first:9.58 15:59:00 INFO - PROCESS | 21140 | Values: 81.0 82.0 103.0 82.0 82.0 82.0 92.0 82.0 83.0 105.0 15:59:00 INFO - PROCESS | 21140 | 15:59:00 INFO - PROCESS | 21140 | [#5] imaging-gaussian-blur Cycles:10 Average:112.80 Median:113.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 15:59:00 INFO - PROCESS | 21140 | Values: 113.0 112.0 113.0 113.0 112.0 113.0 113.0 113.0 113.0 113.0 15:59:00 INFO - PROCESS | 21140 | 15:59:00 INFO - PROCESS | 21140 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.44 15:59:00 INFO - PROCESS | 21140 | Values: 147.0 145.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 15:59:00 INFO - PROCESS | 21140 | 15:59:00 INFO - PROCESS | 21140 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 15:59:00 INFO - PROCESS | 21140 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 93.0 94.0 94.0 93.0 15:59:00 INFO - PROCESS | 21140 | 15:59:00 INFO - PROCESS | 21140 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.50 stddev:0.79 (1.4%) stddev-sans-first:0.83 15:59:00 INFO - PROCESS | 21140 | Values: 54.0 54.0 55.0 55.0 54.0 53.0 55.0 54.0 55.0 53.0 15:59:00 INFO - PROCESS | 21140 | 15:59:00 INFO - PROCESS | 21140 | [#9] json-stringify-tinderbox Cycles:10 Average:52.00 Median:52.00 stddev:0.47 (0.9%) stddev-sans-first:0.50 15:59:00 INFO - PROCESS | 21140 | Values: 52.0 52.0 51.0 52.0 53.0 52.0 52.0 52.0 52.0 52.0 15:59:00 INFO - PROCESS | 21140 | 15:59:00 INFO - PROCESS | 21140 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:80.50 stddev:3.00 (3.7%) stddev-sans-first:2.60 15:59:00 INFO - PROCESS | 21140 | Values: 85.0 82.0 79.0 76.0 80.0 81.0 80.0 80.0 75.0 83.0 15:59:00 INFO - PROCESS | 21140 | 15:59:00 INFO - PROCESS | 21140 | [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:125.00 stddev:11.75 (9.4%) stddev-sans-first:12.38 15:59:00 INFO - PROCESS | 21140 | Values: 123.0 122.0 126.0 124.0 129.0 127.0 119.0 119.0 159.0 121.0 15:59:00 INFO - PROCESS | 21140 | 15:59:00 INFO - PROCESS | 21140 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.00 Median:163.00 stddev:3.80 (2.3%) stddev-sans-first:3.96 15:59:00 INFO - PROCESS | 21140 | Values: 161.0 164.0 159.0 167.0 161.0 159.0 165.0 171.0 162.0 161.0 15:59:00 INFO - PROCESS | 21140 | 15:59:00 INFO - PROCESS | 21140 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.60 Median:59.50 stddev:1.58 (2.7%) stddev-sans-first:1.59 15:59:00 INFO - PROCESS | 21140 | Values: 61.0 60.0 62.0 59.0 59.0 59.0 58.0 58.0 58.0 62.0 15:59:00 INFO - PROCESS | 21140 | -------- Summary: end -------- 15:59:00 INFO - PROCESS | 21140 | 15:59:01 INFO - TEST-INFO | 21140: exit 0 15:59:01 INFO - TEST-OK | kraken | took 59943ms 15:59:01 INFO - SUITE-END | took 1174s 15:59:02 INFO - Completed test suite (00:19:34) 15:59:02 INFO - javascript benchmark 15:59:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7979.516320831892, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3417.487376893466, 3458.049036514958, 3474.8088855112974, 3496.72026237901, 3516.9472457913134, 5800.825975220745, 5860.912086318709, 5868.3838196989345, 5868.4131586841295, 5882.794102206418, 5846.415358464152, 5910.23166988292, 5914.378990206031, 5914.497267732238, 5915.645061296314, 5225.6603320784025, 5227.555657769085, 5238.371395432553, 5261.053010458116, 5312.096943519592, 5045.192769156935, 5067.34124563808, 5243.239730239132, 5316.946830531684, 5337.492938170868, 5282.366116066059, 5284.524392804647, 5321.733913304339, 5322.760475778599, 5334.493223143814, 5312.574994000471, 5315.229291752694, 5315.441878602768, 5319.095753721857, 5350.143976963667, 4983.451820299764, 5061.44324124346, 5095.515925987025, 5197.948020519784, 5200.479952004807, 5780.2196703444915, 5797.623154494944, 5814.592978491507, 5832.300123985106, 5844.123381492767, 6232.439080482733, 6273.717682704244, 6284.18305620271, 6285.59143655661, 6286.842828929268, 5958.940410595926, 5986.760529578812, 6302.18071650687, 6333.240011198685, 6335.936640633581, 5779.913301300484, 5791.0734282514595, 5822.592418530705, 5824.708764561798, 5832.096025116114, 6374.74501019954, 6392.232932048184, 6393.904091438632, 6401.871962560723, 6437.485001199892, 5947.04847224442, 6110.969445152746, 6186.938130618726, 6187.3503282154725, 6188.8762224755255, 6136.304638670978, 6139.706800529493, 6145.525073982212, 6168.9691551541955, 6174.783882564088, 6024.939750602525, 6250.531210159256, 6255.718492667841, 6258.780942666985, 6262.436380725757, 6110.832160913912, 6118.20463339763, 6123.234595675541, 6130.049842274455, 6139.508839292846, 4686.789094490756, 4715.552022557851, 4718.551737584924, 4718.740469274154, 4753.881152971134, 4126.463559737215, 4137.069159439162, 4172.895677608084, 4188.099558594917, 4197.748135111903, 6019.668918209541, 6022.1870047543025, 6043.7884674036195, 6062.9090563641585, 6066.66633335162, 6305.244549204504, 6318.494520438354, 6320.683965801783, 6329.873402531924, 6331.905021424683, 5789.768409263583, 6015.248093988252, 6023.186869772612, 6025.698715064229, 6038.728257228435, 5252.2384254282915, 5263.7104959226845, 5297.602679799031, 5308.389535203501, 5316.069687804618, 6540.955801656171, 6567.2447668516825, 6578.27638959714, 6582.670866456754, 6583.868322633521, 6252.687365631791, 6261.968690156702, 6290.056491526308, 6310.211223597051, 6314.400131987454, 6249.9062514063235, 6301.338359472189, 6417.518686098655, 6463.935360646334, 6473.514486413444, 6197.659128747962, 6205.22434695663, 6210.5652604317265, 6214.40963108504, 6216.968915155395, 6313.463355614824, 6318.241810982711, 6319.494440444661, 6323.873522529616, 6339.2392912850755, 5830.62100963436, 5881.264841894763, 6049.304330002106, 6063.909041364472, 6091.695415229309, 6133.509319254538, 6147.538934580014, 6153.507719382528, 6153.815385538441, 6165.753369865155, 5899.646021238567, 6104.489918297086, 6137.631742095488, 6149.41580549847, 6149.723262453111, 6021.307549631673, 6069.393060693896, 6095.878082438415, 6119.051547010221, 6133.977404287468, 5956.731947062306, 5964.582479226586, 5967.880642387215, 5978.910316345346, 5997.940020599738], "value": 5744.816280010192, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [734.7612026091522, 809.6275713171941, 819.5492479136475, 921.3550514639754, 923.4136323434622, 31596.210094747614, 43544.34683479751, 44607.77696111515, 44693.0, 44713.0, 40813.183736325256, 41157.58842411575, 41196.794016029955, 45323.320150197695, 45421.77289113558, 9223.216026637743, 9371.20344770692, 9373.906260937372, 9375.062493750638, 9379.390339627937, 7854.175311592287, 8050.5974701264995, 10666.839997400046, 10846.18653600983, 10863.45682715861, 11082.667519974413, 11113.277636953613, 11114.444277786119, 11118.777624447546, 11124.332540047582, 10953.507092180831, 11037.558497660084, 11038.779224415506, 11044.558217671283, 11051.17116216287, 10694.946525267324, 10747.623833165802, 10748.838767418494, 10756.0, 10762.677119686421, 42745.786271068755, 43318.35022474665, 43331.78334108341, 43374.78312608448, 43448.348274775904, 4220.134872351161, 4280.464941882265, 4304.870853874389, 4391.099824535994, 4396.912061758747, 30079.849600751855, 30396.84801575978, 30484.54273185904, 31077.37845243105, 31755.364892702248, 4222.78886055696, 4281.978590107061, 4358.411614432042, 4384.780760961971, 4470.8658740237515, 233466.0, 233714.0, 234370.0, 234786.0, 235572.0, 46246.306305405444, 46348.53651463442, 46377.30434043492, 46501.767491163, 46509.76745116253, 46929.29606055912, 47444.288335674995, 47462.76268618704, 47528.0, 47589.76205118952, 14352.138871667734, 14590.343434545472, 14686.55940321792, 14738.55784326472, 14740.484083057256, 11087.667369978913, 12578.685532861751, 12585.748285034248, 12586.496540138474, 12589.748205035849, 11520.654380368602, 12290.877091228973, 12418.627441176779, 12545.184563003375, 12589.622311330675, 5518.944810551923, 5526.253955716007, 5536.7785288588, 5598.1246282495, 5619.494245517923, 1025.8409946458312, 1027.6762819711766, 1031.63377001165, 1035.4460363705532, 1038.2109596706557, 28474.857625712153, 28517.429651406856, 28755.28111797222, 28813.135605931857, 29153.271168220963, 1096.5339730614617, 1101.2786624760795, 1101.6144349477618, 1105.7987127266517, 1134.6879608107672, 14728.852711472748, 15196.848031519543, 15453.613659658373, 15464.149471778936, 15575.987560808511, 356134.0, 356726.0, 357619.0, 358225.0, 358645.0, 56790.432095678516, 56920.0, 57279.42720572824, 57359.0, 57443.0, 1465.846086160959, 1472.1167299620142, 1486.8513148685045, 1502.4591147187004, 1511.4936496273872, 27093.59359609568, 28399.432011359244, 28540.57189142123, 28842.27894302659, 28918.855405722836, 42481.575184249, 42719.0, 42741.93145171396, 42846.57153428426, 42876.57123428726, 320376.0, 320625.0, 320981.0, 321136.0, 322219.0, 33384.1653958653, 33430.49854252237, 33439.0, 34086.31827363389, 34142.487862681584, 35235.64764352324, 36829.26341473102, 43417.34873976956, 46767.532324676315, 48003.0, 34407.655923441445, 34553.82723086469, 34589.65410345965, 34718.0, 34735.0, 34228.657713422544, 34480.0, 34661.826690866386, 34700.13249668779, 34775.65224347825, 39623.60376396199, 39689.40465893072, 40215.0, 40665.796671016455, 40857.38713919353, 33174.336513270086, 33316.50025249672, 33316.66683333136, 33371.83314083414, 33533.32933341368, 26742.866285668446, 26853.865730671223, 27036.72963270342, 27108.45783084367, 27210.863945680147], "value": 18973.39852160651, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [453.74590229471477, 464.42411409851775, 465.5484180345064, 469.5023275328151, 481.34537029639694, 20419.387418377453, 21565.24521641743, 22387.0, 22485.32544023678, 22669.659955100688, 19638.509037274074, 20096.095675694593, 20566.89716551415, 21268.57462850742, 21364.89317553414, 6767.4586033117475, 6779.694913728869, 6887.7244910203535, 6899.965500172517, 6967.895481567781, 6780.254172041072, 6859.039734437158, 6886.449084073262, 6891.483138764587, 7216.278372162794, 7614.124375696811, 7656.004719386472, 7663.118741344733, 7664.080310362764, 7670.501417407879, 6991.7902462926195, 7250.2024777274455, 7273.418126549864, 7286.708531658727, 7651.311381975621, 7125.572465652078, 7257.963710181468, 7259.128904531437, 7517.323440890346, 7590.203028682019, 25590.616140757902, 25664.358391040372, 25769.61345579818, 25996.74003259962, 26276.0, 3089.6137982752157, 3241.4003409369343, 3666.156783939709, 3676.2647470506004, 3735.3276410246144, 15615.375384984587, 16251.268692908847, 16526.421575244927, 16586.83413165865, 17030.233639486254, 2296.873671948059, 2347.33101066197, 2399.6520504526748, 2447.339218411019, 2576.9226923192145, 115659.42170289095, 118475.4076229622, 121235.3938230312, 126505.36747316297, 126774.0, 21852.0, 22027.0, 22144.003519841644, 24044.639330410057, 24480.877595611906, 43475.34786978135, 43914.56085439169, 43972.56027439749, 44007.339889901676, 44438.77780611076, 11503.597374091867, 11683.824742628867, 11768.117391195523, 11888.524459021715, 12092.762838874836, 9415.858762118574, 9526.571304291323, 9536.809263814685, 9692.951535242279, 9856.950715246378, 11099.944500277446, 11489.770204595861, 11532.192746507832, 12041.759164816829, 12065.819012714815, 3936.980315098406, 4034.2854286927936, 4120.526139493936, 4177.352510360899, 4403.14138742942, 1182.8166634171716, 1199.3343694249775, 1200.4057991294192, 1222.529326209398, 1230.2864338683542, 20139.194432222546, 20283.79716202819, 20345.389638310873, 20464.795352046585, 20621.89689051545, 1170.1984140863535, 1179.5281887245171, 1182.5388098641536, 1186.033382793021, 1214.2957084890743, 10745.086667633339, 11366.318020918772, 11411.771764564828, 11472.598459053894, 11486.0, 673640.0, 673728.0, 679123.0, 679846.0, 691239.0, 115965.4201728986, 117701.0, 118742.0, 120474.0, 124249.0, 1281.3657239666425, 1299.5191779041816, 1320.3134370127673, 1343.6573673713335, 1344.072589912957, 17855.553611159827, 18015.099245037956, 18063.458096257134, 18323.175457104197, 18409.447716568524, 52429.47570524246, 52430.47569524256, 52453.0, 53179.0, 54150.18774718461, 69313.3068669327, 69406.0, 69622.25944351431, 70353.64823175852, 71293.64353178201, 12269.75460490803, 12567.93716031414, 12709.1739036966, 12755.744885102431, 12823.0, 13825.377857996615, 13863.72272554523, 13872.861271387157, 14066.859331406964, 14291.499797507453, 12028.218165819193, 12080.39598020078, 12433.75132497327, 12515.874841251834, 12571.057170712416, 11062.391568463812, 11103.50034248477, 11120.388378639253, 11120.721981950515, 11129.610463633733, 12373.814392784296, 12479.376031198222, 12542.811857822322, 12588.181768185039, 12627.3686315682, 12133.0, 12203.0, 12346.320952347707, 12388.938055309665, 12635.3682315882, 12177.817332740193, 12282.990667286573, 12284.38578071075, 12302.876971230173, 12643.620691379274], "value": 12138.661279139467, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1426.529245349035, 1582.905025698458, 1586.9206539673014, 1605.6307049378638, 1616.442327397048, 9391.29565282604, 10870.293430926995, 11058.944705276483, 11096.944515277411, 11164.832527512084, 11287.604933827317, 11352.829707554394, 11371.545138194462, 11387.544498220082, 11403.315801051942, 2009.7990200979857, 2072.823809976154, 2465.728769835312, 2495.1641200197955, 2502.4119331956977, 2480.06997375984, 2526.2042456626195, 2531.063506502587, 2534.42975330551, 2541.796656267494, 2459.1515927005244, 2471.6910386201725, 2478.1698131126004, 2485.801135909123, 2492.53888030714, 2464.963025554618, 2484.006397441029, 2487.9502409951792, 2491.476789874129, 2493.887775050127, 2333.813294936418, 2339.099446713011, 2355.0815182079004, 2361.984346730905, 2363.2910126962015, 11633.883661163365, 11660.883391166064, 11741.88258117425, 11749.353785541793, 11759.764804703944, 5695.857603559903, 5803.332616749043, 5842.941570584282, 5854.97072514639, 5856.912146317809, 3485.2855164691177, 3503.789772613651, 3561.0385195997196, 3619.6199399063244, 3666.6699997000132, 1375.7454870848826, 1401.7757158854533, 1407.971840563183, 1412.3644360038024, 1458.64263255502, 17293.04888231147, 17624.647507049787, 18005.7299140513, 18009.459716208534, 18242.087895605167, 4596.7931443085145, 4741.976290118528, 4806.44725856524, 4824.782884770194, 4831.492693267227, 13308.134971226838, 13350.399232034582, 13361.599152025456, 13381.598552043455, 13387.732245355039, 5746.166805813134, 5759.625624334405, 5760.6543607382855, 5760.769569217185, 5765.048766953406, 5120.48795120485, 5187.662801917939, 5219.399769026534, 5248.685078895279, 5322.0952438085615, 4107.9178416431505, 4173.08192197716, 4266.146770645883, 4323.718958267703, 4327.502337231196, 1062.2298833345917, 1067.4662668665667, 1070.71626019105, 1086.9619563315246, 1087.6138970665459, 1097.540439610513, 1111.2499063132354, 1117.7149826794116, 1121.6354684727496, 1158.137187795098, 7495.962520187364, 7547.886781698279, 7583.658735356812, 7678.5392876427595, 7690.077190737147, 1045.325764881647, 1050.4033868519807, 1062.5484169228048, 1070.272214893864, 1082.6210826210763, 4597.56323149307, 4883.8290659826735, 4925.630577706686, 5006.349174607278, 5132.178851383761, 15155.621109472131, 15659.060456372654, 15680.372785088697, 15699.136547489998, 15700.528984130495, 15177.93754437201, 15509.612259693598, 15531.611709707347, 15558.84441155574, 15571.29929153168, 10783.191260655482, 10890.401027943539, 10900.945495272632, 11013.2841365311, 11046.779064418666, 7242.927570724225, 7347.08161479815, 7380.335769780745, 7393.223711510429, 7508.511946723445, 12965.546205882749, 13070.346482675637, 13118.409671564612, 13140.27728474943, 13160.210387376788, 11351.772964540498, 11796.941015295211, 13304.800427993394, 13439.225354557942, 13568.050236483352, 9688.41869487833, 9805.313628045968, 9882.456464894212, 9890.85163722559, 10019.248556358156, 10734.892651073702, 10760.408177549996, 10809.35143891369, 10858.837117443087, 10877.728056798644, 9142.58858351389, 9167.724968250963, 9228.492432915986, 9245.445273283625, 9376.249900008119, 8724.956375218084, 8809.339299552432, 8828.42615230008, 8954.955225223832, 9162.770930726785, 8670.869936950825, 8694.0, 8719.52042637661, 8788.692395766118, 8853.203211710977, 6521.478281737354, 6622.0, 6661.500387471056, 6678.799636010927, 6715.832104197434, 6419.0, 6439.8068057958335, 6517.446017088411, 6527.281998980014, 6676.766313179015], "value": 5484.549135088591, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.5864135864136, 437.4357079367616, 437.540582388492, 444.22482767570597, 445.38536819189534, 5252.921206181905, 5343.519083282504, 5404.405515393303, 5405.270288511055, 5415.512603865652, 4977.502249775021, 5214.713190774506, 5243.4232234454175, 5252.290940723001, 5262.315898933133, 4256.148575369724, 4284.314509678452, 4294.935575966363, 4299.742015479065, 4307.849225277116, 4301.225779359714, 4307.483102027761, 4308.310670292738, 4322.243607368698, 4400.163968845909, 4335.523092459843, 4346.195953748566, 4349.26062569364, 4358.825646974133, 4389.23188442023, 4177.352510360899, 4306.33251845966, 4313.762743049131, 4317.15815415994, 4324.113556720865, 4062.6749860011128, 4064.7357921734992, 4071.7760523171214, 4074.653654439376, 4135.0902801383645, 5065.0, 5071.518205770446, 5088.592912566985, 5093.522878365269, 5107.233914912756, 4925.236588328815, 4976.975115124437, 4996.63126188967, 5041.369828771403, 5077.5684066854365, 5435.456454354572, 5471.671699698031, 5482.835514934558, 5488.259085023511, 5566.805161819358, 4478.641708663332, 4547.772611369418, 4550.658700597469, 4579.175748365293, 4664.906701865943, 5553.888922221533, 5685.346185188715, 5702.258706368146, 5726.5705072119345, 5803.187553742479, 4669.649776266793, 4696.600788932979, 4717.193270004342, 4719.528047195253, 4731.858044258678, 4670.64970127235, 4783.339928769278, 4793.832215872428, 4832.830850920201, 4897.853064408074, 5071.39143302806, 5076.390833100052, 5093.134167191586, 5101.132807422747, 5122.385313762298, 5434.016583946831, 5448.536874365644, 5530.064477432867, 5531.280933478622, 5548.4174161713245, 1555.1058141568417, 1631.9836801632068, 1647.9176041197893, 1656.6438215783664, 1660.8754343424291, 1262.0156278103095, 1276.704145292529, 1292.476546998467, 1309.6071178646368, 1310.3841194638505, 5401.730593310569, 5409.323834520685, 5419.13040001199, 5423.701696406735, 5431.728413579305, 5563.972180139073, 5603.271574695264, 5611.915821262684, 5620.662760234399, 5636.661800291996, 5254.343207099113, 5313.548348390353, 5375.381831089475, 5400.432954539717, 5408.242846001563, 2919.7445098607805, 2953.8375389353364, 2954.9409011819644, 2965.021542890841, 2969.539721343195, 5754.510866576305, 5781.971090144522, 5795.217645617872, 5796.275465566804, 5830.38780928005, 5392.352917649907, 5523.917141242885, 5655.830325090254, 5686.317641883001, 5738.44639135589, 5728.94014607299, 5783.277090363705, 5787.768489260382, 5794.62334948227, 5861.531077513703, 5555.666660000413, 5587.463447551956, 5622.662640241599, 5632.183333416713, 5643.379228284967, 5466.863328416822, 5484.7806087757635, 5493.599132221258, 5505.862353441196, 5645.266115404971, 5793.275840519935, 5814.796482123105, 5815.3603103657715, 5824.970875145597, 5863.442972917566, 4442.200403927195, 4669.39297891272, 4679.923617568046, 4686.812527498998, 4769.117713223065, 5564.805231816867, 5571.387147413862, 5572.944270557405, 5590.217369568182, 5638.971805140948, 5491.258680078298, 5495.697736624365, 5500.50495455411, 5528.944710552843, 5540.944590554042, 5235.581153507634, 5467.6719396836315, 5470.288862448016, 5471.945280547144, 5503.284573005483, 5429.294191755047, 5437.646552974203, 5532.5020748132865, 5558.166275058774, 5563.443655634404, 5571.804986825442, 5587.944120558743, 5594.356648985418, 5613.803516876889, 5617.297837770278, 5301.920471193012, 5310.734463276744, 5327.987682340343, 5363.0, 5461.743798926349], "value": 4420.71132903455, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [853.543354305446, 873.4846440600045, 916.5600511754358, 923.6890015527104, 929.6002718830904, 17547.2103755331, 19067.713984290247, 19102.14040368183, 19117.904410477946, 19192.136353864076, 17274.56813579661, 17637.64724705505, 17821.82178178221, 17835.37576184834, 17859.017754023524, 899.8155378147496, 909.417972497602, 919.6551293265026, 919.7424721078108, 919.908009199078, 912.1516989200042, 912.9771755706095, 914.5244472874101, 914.5290175559592, 914.6432891172448, 948.5399581203111, 950.2065775077818, 956.1681337236614, 957.0, 957.5547370472729, 944.5466176235377, 945.8202941441104, 947.2706016367393, 947.3842002698233, 954.2699834626447, 701.7158050989358, 704.4223736536043, 709.4501761135161, 709.8615769924867, 709.8615769924867, 15872.285747141406, 15972.680546389123, 15995.280212390471, 16466.588335291595, 16923.0, 14824.555263342118, 15234.238288085551, 15279.312430940634, 15384.846151538453, 15438.768418473732, 12789.0, 12868.420921058574, 13027.86972130276, 13152.21086734799, 13277.402516886763, 4006.9198616027516, 4030.0730831908827, 4039.8508332130295, 4055.393164989364, 4104.56902025286, 48503.514964850256, 54431.455685443034, 56465.43534564643, 70932.2906770936, 82697.75953360704, 13737.313134343443, 13777.242251676054, 13993.72012559743, 14018.929905350611, 14094.365753541115, 25127.87436062808, 25209.495810083696, 25342.87328563382, 25429.618555721678, 25448.0, 9113.0, 9177.541122943827, 9459.432434053979, 9487.525623718924, 9494.240460763122, 5207.92188117171, 5317.499488989629, 5333.466653334635, 5431.131019036935, 5453.809116680897, 3573.982130089385, 3669.064388580895, 3676.5955744868043, 3692.593814680383, 3815.7138214634015, 670.3966430212847, 671.342084756941, 671.5567725301278, 684.322520704499, 685.7634116229992, 831.983360332802, 852.1946760311446, 852.3224036890687, 872.3718922375879, 877.4165180155253, 11666.824997625043, 12251.264924104582, 12266.877331226573, 12536.36736285372, 12814.615561533168, 849.5370023337296, 859.832332695131, 874.7594411536878, 878.2578720980761, 893.2095095840228, 5694.4590263924865, 5765.596408251382, 5787.305523337142, 5896.469317761422, 5906.940930590639, 84046.15953840506, 86303.56848215719, 86432.56783716167, 87384.56307718548, 87463.56268218618, 51663.48336516587, 56792.71603641955, 62993.68503157455, 73380.63309683418, 75727.0, 56866.715666421405, 62662.373376266565, 62872.0, 63241.683791581665, 63559.36440635627, 11263.774724505627, 11915.940420297842, 12210.938945305572, 12401.379931003594, 12706.87293127057, 41338.0, 41763.373549397395, 42319.0, 42619.147617048104, 42889.57110428856, 49229.0, 49655.503444965085, 50662.49337506578, 52055.0, 52551.21173182482, 13197.736045279233, 13276.33618319061, 13751.724965500835, 14011.166734675744, 14045.578632641038, 16769.496915092568, 16842.915785421486, 16938.91530542389, 17350.913245434196, 17543.0, 15110.924445377703, 15407.691846163238, 15531.145786981824, 16192.947458415165, 16728.330866765195, 16036.0, 16068.758968615246, 16218.67562648764, 16418.425355112515, 16570.171491425623, 15299.61750956235, 15467.613309667347, 15761.68476630484, 15801.525954221392, 16486.67026659484, 11637.134090886419, 11642.79395246664, 12096.213746106476, 12257.203281786655, 12285.692857678272, 12649.367531623198, 12818.294993775431, 12860.871391285968, 12990.350482476028, 13065.150765200231], "value": 8046.28017884727, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1455.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 114.0, 113.0, 113.0, 112.0, 112.0, 112.0, 113.0, 113.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 119.0, 121.0, 154.0, 116.0, 115.0, 115.0, 115.0, 136.0, 121.0], "value": 125.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 159.0, 158.0, 160.0, 159.0, 160.0, 162.0, 161.0], "value": 159.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 81.0, 123.0, 77.0, 76.0, 75.0, 76.0, 90.0, 76.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 103.0, 82.0, 82.0, 82.0, 92.0, 82.0, 83.0, 105.0], "value": 87.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 113.0, 113.0, 112.0, 113.0, 113.0, 113.0, 113.0, 113.0], "value": 112.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 93.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 55.0, 54.0, 53.0, 55.0, 54.0, 55.0, 53.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 51.0, 52.0, 53.0, 52.0, 52.0, 52.0, 52.0, 52.0], "value": 52.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 79.0, 76.0, 80.0, 81.0, 80.0, 80.0, 75.0, 83.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 122.0, 126.0, 124.0, 129.0, 127.0, 119.0, 119.0, 159.0, 121.0], "value": 126.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 159.0, 167.0, 161.0, 159.0, 165.0, 171.0, 162.0, 161.0], "value": 163.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 62.0, 59.0, 59.0, 59.0, 58.0, 58.0, 58.0, 62.0], "value": 59.6, "unit": "score"}]}]} 15:59:02 INFO - Return code: 0 15:59:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:59:02 INFO - # TBPL SUCCESS # 15:59:02 INFO - Running post-action listener: _resource_record_post_action 15:59:02 INFO - [mozharness: 2017-05-22 22:59:02.459581Z] Finished run-tests step (success) 15:59:02 INFO - Running post-run listener: _resource_record_post_run 15:59:02 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 520192; Write bytes: 328151040; Read time: 80; Write time: 162440 15:59:02 INFO - TinderboxPrint: CPU usage
13.1% 15:59:02 INFO - TinderboxPrint: I/O read bytes / time
520,192 / 80 15:59:02 INFO - TinderboxPrint: I/O write bytes / time
328,151,040 / 162,440 15:59:02 INFO - TinderboxPrint: CPU idle
8,244.9 (86.9%) 15:59:02 INFO - TinderboxPrint: CPU user
1,200.5 (12.6%) 15:59:02 INFO - TinderboxPrint: Swap in / out
0 / 0 15:59:02 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 4096; Write bytes: 65646592; Read time: 36; Write time: 34508 15:59:02 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 516096; Write bytes: 228745216; Read time: 44; Write time: 85960 15:59:03 INFO - Running post-run listener: _upload_blobber_files 15:59:03 INFO - Blob upload gear active. 15:59:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:59:03 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 15:59:03 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', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:59:03 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 Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:59:03 INFO - (blobuploader) - INFO - Open directory for files ... 15:59:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:59:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:59:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:59:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:59:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:59:06 INFO - (blobuploader) - INFO - Done attempting. 15:59:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:59:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:59:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:59:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:59:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:59:07 INFO - (blobuploader) - INFO - Done attempting. 15:59:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:59:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:59:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:59:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:59:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:59:08 INFO - (blobuploader) - INFO - Done attempting. 15:59:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:59:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:59:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:59:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:59:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:59:09 INFO - (blobuploader) - INFO - Done attempting. 15:59:09 INFO - (blobuploader) - INFO - Iteration through files over. 15:59:09 INFO - Return code: 0 15:59:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:59:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:59:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/aeb49787d0868da3da0734efd630caaad4d01299bc520aa81de4bd79cc26855b417f893d84c84b0b289e24ce751f2d7c1eb820a4c52e92594bc043f52247c2ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d20481cf83604db40d3c6ff83d371aa22c130f76a8993639266ec8b3d13c98017685cab1888722074cf3f5a315ccf808a8faa26be8e9a79b0061d91f29761ceb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d19f1f493585e37bc80214a2324c8b0156847f363be366b00e7d18dbe4c345cb7a79d87391fc7be47b0f031bd3613611fa95f128d6865ce25db57d274f2b1c66", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5a2d5068564b64e36268ede19cd190b7ebddda4752e6ca387b8b81b14ef7012eaca0f179bd1e5c7cbb77975fe3fa018cfcc8723a06a5de085e437f1e253b5a02"} 15:59:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:59:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:59:09 INFO - Contents: 15:59:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/aeb49787d0868da3da0734efd630caaad4d01299bc520aa81de4bd79cc26855b417f893d84c84b0b289e24ce751f2d7c1eb820a4c52e92594bc043f52247c2ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d20481cf83604db40d3c6ff83d371aa22c130f76a8993639266ec8b3d13c98017685cab1888722074cf3f5a315ccf808a8faa26be8e9a79b0061d91f29761ceb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d19f1f493585e37bc80214a2324c8b0156847f363be366b00e7d18dbe4c345cb7a79d87391fc7be47b0f031bd3613611fa95f128d6865ce25db57d274f2b1c66", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5a2d5068564b64e36268ede19cd190b7ebddda4752e6ca387b8b81b14ef7012eaca0f179bd1e5c7cbb77975fe3fa018cfcc8723a06a5de085e437f1e253b5a02"} 15:59:09 INFO - Running post-run listener: copy_logs_to_upload_dir 15:59:09 INFO - Copying logs to upload dir... 15:59:09 INFO - mkdir: /builds/slave/test/build/upload/logs 15:59:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.919467 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-05-22 15:59:09.076995) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-22 15:59:09.080804) ========= 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=438111f3d31ce799eff2119d000001bc-1495491726.669285-1678284415 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/aeb49787d0868da3da0734efd630caaad4d01299bc520aa81de4bd79cc26855b417f893d84c84b0b289e24ce751f2d7c1eb820a4c52e92594bc043f52247c2ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d20481cf83604db40d3c6ff83d371aa22c130f76a8993639266ec8b3d13c98017685cab1888722074cf3f5a315ccf808a8faa26be8e9a79b0061d91f29761ceb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d19f1f493585e37bc80214a2324c8b0156847f363be366b00e7d18dbe4c345cb7a79d87391fc7be47b0f031bd3613611fa95f128d6865ce25db57d274f2b1c66", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5a2d5068564b64e36268ede19cd190b7ebddda4752e6ca387b8b81b14ef7012eaca0f179bd1e5c7cbb77975fe3fa018cfcc8723a06a5de085e437f1e253b5a02"} build_url:https://queue.taskcluster.net/v1/task/eIW7ogXpSZWlHsQpaOZX0Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011363 build_url: 'https://queue.taskcluster.net/v1/task/eIW7ogXpSZWlHsQpaOZX0Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/aeb49787d0868da3da0734efd630caaad4d01299bc520aa81de4bd79cc26855b417f893d84c84b0b289e24ce751f2d7c1eb820a4c52e92594bc043f52247c2ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d20481cf83604db40d3c6ff83d371aa22c130f76a8993639266ec8b3d13c98017685cab1888722074cf3f5a315ccf808a8faa26be8e9a79b0061d91f29761ceb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d19f1f493585e37bc80214a2324c8b0156847f363be366b00e7d18dbe4c345cb7a79d87391fc7be47b0f031bd3613611fa95f128d6865ce25db57d274f2b1c66", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5a2d5068564b64e36268ede19cd190b7ebddda4752e6ca387b8b81b14ef7012eaca0f179bd1e5c7cbb77975fe3fa018cfcc8723a06a5de085e437f1e253b5a02"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-22 15:59:09.105452) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-22 15:59:09.105797) ========= 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=438111f3d31ce799eff2119d000001bc-1495491726.669285-1678284415 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004484 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-22 15:59:09.189223) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-22 15:59:09.189592) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-22 15:59:09.189897) ========= ========= Total master_lag: 0.16 =========