builder: mozilla-beta_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-005 starttime: 1495223121.89 results: success (0) revision: 0241994e3aad3594cae0d42c7d80a2dff7b245e8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-19 12:45:21.895213) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-19 12:45:21.895613) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-19 12:45:21.895882) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-19 12:45:21.945358) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 12:45:21.945643) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1495220490.276601-405361073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-19 12:45:21-- 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% 25.1M=0s 2017-05-19 12:45:22 (25.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.133190 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 12:45:22.111138) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 12:45:22.111406) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1495220490.276601-405361073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018065 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 12:45:22.173492) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-19 12:45:22.173815) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0241994e3aad3594cae0d42c7d80a2dff7b245e8 --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 0241994e3aad3594cae0d42c7d80a2dff7b245e8 --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=7fc86f70bae03e018da0b1d8000001c4-1495220490.276601-405361073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-19 12:45:22,198 truncating revision to first 12 chars 2017-05-19 12:45:22,198 Setting DEBUG logging. 2017-05-19 12:45:22,198 attempt 1/10 2017-05-19 12:45:22,198 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/0241994e3aad?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-19 12:45:23,325 unpacking tar archive at: mozilla-beta-0241994e3aad/testing/mozharness/ program finished with exit code 0 elapsedTime=1.457551 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-19 12:45:23.644403) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-19 12:45:23.647724) ========= script_repo_revision: 0241994e3aad3594cae0d42c7d80a2dff7b245e8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-19 12:45:23.648114) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-19 12:45:23.648381) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-19 12:45:23.657802) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-05-19 12:45:23.658076) ========= /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=7fc86f70bae03e018da0b1d8000001c4-1495220490.276601-405361073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:45:23 INFO - MultiFileLogger online at 20170519 12:45:23 in /builds/slave/test 12:45:23 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 12:45:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:45:23 INFO - {'append_to_log': False, 12:45:23 INFO - 'base_work_dir': '/builds/slave/test', 12:45:23 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 12:45:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:45:23 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 12:45:23 INFO - 'buildbot_json_path': 'buildprops.json', 12:45:23 INFO - 'config_files': ('talos/linux_config.py',), 12:45:23 INFO - 'default_actions': ('clobber', 12:45:23 INFO - 'read-buildbot-config', 12:45:23 INFO - 'download-and-extract', 12:45:23 INFO - 'populate-webroot', 12:45:23 INFO - 'create-virtualenv', 12:45:23 INFO - 'install', 12:45:23 INFO - 'run-tests'), 12:45:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:45:23 INFO - 'download_minidump_stackwalk': True, 12:45:23 INFO - 'download_symbols': 'ondemand', 12:45:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:45:23 INFO - 'tooltool.py': '/tools/tooltool.py', 12:45:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:45:23 INFO - '/tools/misc-python/virtualenv.py')}, 12:45:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:45:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:45:23 INFO - 'gecko_profile': False, 12:45:23 INFO - 'gecko_profile_interval': 0, 12:45:23 INFO - 'installer_path': 'installer.exe', 12:45:23 INFO - 'log_level': 'info', 12:45:23 INFO - 'log_name': 'talos', 12:45:23 INFO - 'log_to_console': True, 12:45:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:45:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:45:23 INFO - 'opt_config_files': (), 12:45:23 INFO - 'pip_index': False, 12:45:23 INFO - 'suite': 'dromaeojs', 12:45:23 INFO - 'system_bits': '32', 12:45:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:45:23 INFO - 'title': 'talos-linux64-ix-005', 12:45:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:45:23 INFO - 'use_talos_json': True, 12:45:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:45:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:45:23 INFO - 'work_dir': 'build'} 12:45:23 INFO - [mozharness: 2017-05-19 19:45:23.777781Z] Running clobber step. 12:45:23 INFO - Running pre-action listener: _resource_record_pre_action 12:45:23 INFO - Running main action method: clobber 12:45:23 INFO - rmtree: /builds/slave/test/build 12:45:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:45:25 INFO - Running post-action listener: _resource_record_post_action 12:45:25 INFO - [mozharness: 2017-05-19 19:45:25.305530Z] Finished clobber step (success) 12:45:25 INFO - [mozharness: 2017-05-19 19:45:25.305628Z] Running read-buildbot-config step. 12:45:25 INFO - Running pre-action listener: _resource_record_pre_action 12:45:25 INFO - Running main action method: read_buildbot_config 12:45:25 INFO - Using buildbot properties: 12:45:25 INFO - { 12:45:25 INFO - "project": "", 12:45:25 INFO - "product": "firefox", 12:45:25 INFO - "who": "ryanvm@gmail.com", 12:45:25 INFO - "installer_path": "public/build/target.tar.bz2", 12:45:25 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 12:45:25 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta/", 12:45:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs", 12:45:25 INFO - "stage_platform": "linux64", 12:45:25 INFO - "basedir": "/builds/slave/test", 12:45:25 INFO - "buildnumber": 51, 12:45:25 INFO - "platform": "ubuntu64_hw", 12:45:25 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:45:25 INFO - "slavebuilddir": "test", 12:45:25 INFO - "taskId": "NGzYzhFtRXGMDMwoM9aQSQ", 12:45:25 INFO - "branch": "mozilla-beta", 12:45:25 INFO - "script_repo_revision": "production", 12:45:25 INFO - "revision": "0241994e3aad3594cae0d42c7d80a2dff7b245e8", 12:45:25 INFO - "slavename": "talos-linux64-ix-005", 12:45:25 INFO - "repo_path": "releases/mozilla-beta" 12:45:25 INFO - } 12:45:25 INFO - Finding installer, test and symbols from parent task. 12:45:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NGzYzhFtRXGMDMwoM9aQSQ'}, attempt #1 12:45:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NGzYzhFtRXGMDMwoM9aQSQ'}, attempt #1 12:45:26 INFO - Task dependencies: AtFWNSmFTS2-tNrUZ0a0qQ 12:45:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AtFWNSmFTS2-tNrUZ0a0qQ'}, attempt #1 12:45:26 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/AtFWNSmFTS2-tNrUZ0a0qQ/artifacts/public/build/target.tar.bz2 12:45:26 INFO - Set test_url: https://queue.taskcluster.net/v1/task/AtFWNSmFTS2-tNrUZ0a0qQ/artifacts/public/build/test_packages.json 12:45:26 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/AtFWNSmFTS2-tNrUZ0a0qQ/artifacts/public/build/target.crashreporter-symbols.zip 12:45:26 INFO - Running post-action listener: _resource_record_post_action 12:45:26 INFO - [mozharness: 2017-05-19 19:45:26.670883Z] Finished read-buildbot-config step (success) 12:45:26 INFO - [mozharness: 2017-05-19 19:45:26.671102Z] Running download-and-extract step. 12:45:26 INFO - Running pre-action listener: _resource_record_pre_action 12:45:26 INFO - Running main action method: download_and_extract 12:45:26 INFO - mkdir: /builds/slave/test/build/tests 12:45:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:45:26 INFO - trying https://queue.taskcluster.net/v1/task/AtFWNSmFTS2-tNrUZ0a0qQ/artifacts/public/build/target.test_packages.json 12:45:26 INFO - Downloading https://queue.taskcluster.net/v1/task/AtFWNSmFTS2-tNrUZ0a0qQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 12:45:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AtFWNSmFTS2-tNrUZ0a0qQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 12:45:27 INFO - Downloaded 986 bytes. 12:45:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 12:45:27 INFO - Using the following test package requirements: 12:45:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 12:45:27 INFO - u'common': [u'target.common.tests.zip'], 12:45:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 12:45:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 12:45:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 12:45:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 12:45:27 INFO - u'mozbase': [u'target.common.tests.zip'], 12:45:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 12:45:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 12:45:27 INFO - u'web-platform': [u'target.common.tests.zip', 12:45:27 INFO - u'target.web-platform.tests.zip'], 12:45:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 12:45:27 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 12:45:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AtFWNSmFTS2-tNrUZ0a0qQ/artifacts/public/build/target.common.tests.zip 12:45:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AtFWNSmFTS2-tNrUZ0a0qQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:45:27 INFO - Fetch https://queue.taskcluster.net/v1/task/AtFWNSmFTS2-tNrUZ0a0qQ/artifacts/public/build/target.common.tests.zip into memory 12:45:29 INFO - Expected file size: 59711579 12:45:29 INFO - Obtained file size: 59711579 12:45:38 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 12:45:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AtFWNSmFTS2-tNrUZ0a0qQ/artifacts/public/build/target.common.tests.zip 12:45:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AtFWNSmFTS2-tNrUZ0a0qQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:45:38 INFO - Fetch https://queue.taskcluster.net/v1/task/AtFWNSmFTS2-tNrUZ0a0qQ/artifacts/public/build/target.common.tests.zip into memory 12:45:40 INFO - Expected file size: 59711579 12:45:40 INFO - Obtained file size: 59711579 12:45:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AtFWNSmFTS2-tNrUZ0a0qQ/artifacts/public/build/target.talos.tests.zip 12:45:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AtFWNSmFTS2-tNrUZ0a0qQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 12:45:51 INFO - Fetch https://queue.taskcluster.net/v1/task/AtFWNSmFTS2-tNrUZ0a0qQ/artifacts/public/build/target.talos.tests.zip into memory 12:45:52 INFO - Expected file size: 14404449 12:45:52 INFO - Obtained file size: 14404449 12:45:52 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')]} 12:45:52 INFO - trying https://queue.taskcluster.net/v1/task/AtFWNSmFTS2-tNrUZ0a0qQ/artifacts/public/build/target.tar.bz2 12:45:52 INFO - Downloading https://queue.taskcluster.net/v1/task/AtFWNSmFTS2-tNrUZ0a0qQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 12:45:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AtFWNSmFTS2-tNrUZ0a0qQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 12:45:55 INFO - Downloaded 59837335 bytes. 12:45:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AtFWNSmFTS2-tNrUZ0a0qQ/artifacts/public/build/target.tar.bz2 12:45:55 INFO - mkdir: /builds/slave/test/properties 12:45:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:45:55 INFO - Writing to file /builds/slave/test/properties/build_url 12:45:55 INFO - Contents: 12:45:55 INFO - build_url:https://queue.taskcluster.net/v1/task/AtFWNSmFTS2-tNrUZ0a0qQ/artifacts/public/build/target.tar.bz2 12:45:55 INFO - Running post-action listener: _resource_record_post_action 12:45:55 INFO - Running post-action listener: set_extra_try_arguments 12:45:55 INFO - [mozharness: 2017-05-19 19:45:55.723509Z] Finished download-and-extract step (success) 12:45:55 INFO - [mozharness: 2017-05-19 19:45:55.723736Z] Running populate-webroot step. 12:45:55 INFO - Running pre-action listener: _resource_record_pre_action 12:45:55 INFO - Running main action method: populate_webroot 12:45:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:45:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:45:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:45:55 INFO - '--tppagecycles', 12:45:55 INFO - '7'], 12:45:55 INFO - 'tests': ['tsvgm']}}, 12:45:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:45:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:45:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:45:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:45:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:45:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:45:55 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:45:55 INFO - 'talos_options': ['--disable-e10s'], 12:45:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:45:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:45:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:45:55 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:45:55 INFO - 'talos_options': ['--disable-e10s'], 12:45:55 INFO - 'tests': ['damp', 'tps']}, 12:45:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:45:55 INFO - 'tests': ['damp', 'tps']}, 12:45:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:45:55 INFO - 'tests': ['dromaeo_dom']}, 12:45:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:45:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:45:55 INFO - 'tests': ['basic_compositor_video']}, 12:45:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:45:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:45:55 INFO - 'tests': ['a11yr', 12:45:55 INFO - 'ts_paint', 12:45:55 INFO - 'tpaint', 12:45:55 INFO - 'sessionrestore', 12:45:55 INFO - 'sessionrestore_no_auto_restore', 12:45:55 INFO - 'tabpaint']}, 12:45:55 INFO - 'other-e10s': {'tests': ['a11yr', 12:45:55 INFO - 'ts_paint', 12:45:55 INFO - 'tpaint', 12:45:55 INFO - 'sessionrestore', 12:45:55 INFO - 'sessionrestore_no_auto_restore', 12:45:55 INFO - 'tabpaint']}, 12:45:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:45:55 INFO - 'ts_paint', 12:45:55 INFO - 'tpaint', 12:45:55 INFO - 'sessionrestore', 12:45:55 INFO - 'sessionrestore_no_auto_restore', 12:45:55 INFO - 'tabpaint']}, 12:45:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:45:55 INFO - 'ts_paint', 12:45:55 INFO - 'tpaint', 12:45:55 INFO - 'sessionrestore', 12:45:55 INFO - 'sessionrestore_no_auto_restore', 12:45:55 INFO - 'tabpaint']}, 12:45:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:45:55 INFO - 'tests': ['a11yr', 12:45:55 INFO - 'ts_paint', 12:45:55 INFO - 'tpaint', 12:45:55 INFO - 'sessionrestore', 12:45:55 INFO - 'sessionrestore_no_auto_restore', 12:45:55 INFO - 'tabpaint']}, 12:45:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:45:55 INFO - 'tests': ['a11yr', 12:45:55 INFO - 'ts_paint', 12:45:55 INFO - 'tpaint', 12:45:55 INFO - 'sessionrestore', 12:45:55 INFO - 'sessionrestore_no_auto_restore', 12:45:55 INFO - 'tabpaint']}, 12:45:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:45:55 INFO - 'tests': ['tsvgx', 12:45:55 INFO - 'tsvgr_opacity', 12:45:55 INFO - 'tart', 12:45:55 INFO - 'tscrollx', 12:45:55 INFO - 'cart', 12:45:55 INFO - 'tsvg_static']}, 12:45:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:45:55 INFO - 'tsvgr_opacity', 12:45:55 INFO - 'tart', 12:45:55 INFO - 'tscrollx', 12:45:55 INFO - 'cart', 12:45:55 INFO - 'tsvg_static']}, 12:45:55 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:45:55 INFO - 'talos_options': ['--disable-e10s'], 12:45:55 INFO - 'tests': ['tp5o']}, 12:45:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:45:55 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:45:55 INFO - 'talos_options': ['--disable-e10s', 12:45:55 INFO - '--xperf_path', 12:45:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:45:55 INFO - 'tests': ['tp5n']}, 12:45:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:45:55 INFO - 'talos_options': ['--xperf_path', 12:45:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:45:55 INFO - 'tests': ['tp5n']}}, 12:45:55 INFO - 'talos.zip': {'path': '', 12:45:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:45:55 INFO - Running post-action listener: _resource_record_post_action 12:45:55 INFO - [mozharness: 2017-05-19 19:45:55.748082Z] Finished populate-webroot step (success) 12:45:55 INFO - [mozharness: 2017-05-19 19:45:55.748173Z] Running create-virtualenv step. 12:45:55 INFO - Running pre-action listener: _resource_record_pre_action 12:45:55 INFO - Running main action method: create_virtualenv 12:45:55 INFO - Creating virtualenv /builds/slave/test/build/venv 12:45: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 12:45:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:45:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:45:55 INFO - Using real prefix '/usr' 12:45:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:45:56 INFO - Installing distribute.............................................................................................................................................................................................done. 12:45:58 INFO - Installing pip.................done. 12:45:58 INFO - Return code: 0 12:45:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:45:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:45:58 INFO - Reading from file tmpfile_stdout 12:45:58 INFO - Output received: 12:45:58 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) 12:45:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:45: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')]} 12:45:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45: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')]} 12:45:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xceb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd29a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf89310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf86400>, '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 0xf873b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf87840>, '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': '7fc86f70bae03e018da0b1d8000001c4-1495220490.276601-405361073', '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 12:45: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', 'pip>=1.5'] in /builds/slave/test/build 12:45: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 pip>=1.5 12:45:58 INFO - Using env: {'DISPLAY': ':0', 12:45:58 INFO - 'HOME': '/home/cltbld', 12:45:58 INFO - 'LANG': 'en_US.UTF-8', 12:45:58 INFO - 'LANGUAGE': 'en_US:en', 12:45:58 INFO - 'LOGNAME': 'cltbld', 12:45:58 INFO - 'MAIL': '/var/mail/cltbld', 12:45:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:58 INFO - 'MOZ_NO_REMOTE': '1', 12:45:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:58 INFO - 'NO_EM_RESTART': '1', 12:45:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:58 INFO - 'PWD': '/builds/slave/test', 12:45:58 INFO - 'SHELL': '/bin/bash', 12:45:58 INFO - 'SHLVL': '1', 12:45:58 INFO - 'TERM': 'linux', 12:45:58 INFO - 'TMOUT': '86400', 12:45:58 INFO - 'USER': 'cltbld', 12:45:58 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1495220490.276601-405361073', 12:45:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:58 INFO - '_': '/tools/buildbot/bin/python'} 12:45:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45: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 12:45:58 INFO - Cleaning up... 12:45:58 INFO - Return code: 0 12:45:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:45: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')]} 12:45:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45: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')]} 12:45:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45: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 0xceb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd29a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf89310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf86400>, '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 0xf873b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf87840>, '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': '7fc86f70bae03e018da0b1d8000001c4-1495220490.276601-405361073', '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 12:45: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 12:45: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 12:45:58 INFO - Using env: {'DISPLAY': ':0', 12:45:58 INFO - 'HOME': '/home/cltbld', 12:45:58 INFO - 'LANG': 'en_US.UTF-8', 12:45:58 INFO - 'LANGUAGE': 'en_US:en', 12:45:58 INFO - 'LOGNAME': 'cltbld', 12:45:58 INFO - 'MAIL': '/var/mail/cltbld', 12:45:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:58 INFO - 'MOZ_NO_REMOTE': '1', 12:45:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:58 INFO - 'NO_EM_RESTART': '1', 12:45:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:58 INFO - 'PWD': '/builds/slave/test', 12:45:58 INFO - 'SHELL': '/bin/bash', 12:45:58 INFO - 'SHLVL': '1', 12:45:58 INFO - 'TERM': 'linux', 12:45:58 INFO - 'TMOUT': '86400', 12:45:58 INFO - 'USER': 'cltbld', 12:45:58 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1495220490.276601-405361073', 12:45:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:58 INFO - '_': '/tools/buildbot/bin/python'} 12:45:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:59 INFO - Downloading/unpacking psutil>=3.1.1 12:45:59 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 12:45:59 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 12:45:59 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 12:45:59 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 12:46:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:46:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:46:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:46:00 INFO - Installing collected packages: psutil 12:46:00 INFO - Running setup.py install for psutil 12:46:00 INFO - building 'psutil._psutil_linux' extension 12:46:00 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 12:46:00 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 12:46:00 INFO - building 'psutil._psutil_posix' extension 12:46:00 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 12:46:00 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 12:46:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:46:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:46:00 INFO - Successfully installed psutil 12:46:00 INFO - Cleaning up... 12:46:00 INFO - Return code: 0 12:46:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:46: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')]} 12:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:46: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')]} 12:46:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:46: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 0xceb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd29a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf89310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf86400>, '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 0xf873b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf87840>, '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': '7fc86f70bae03e018da0b1d8000001c4-1495220490.276601-405361073', '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 12:46: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 12:46: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 12:46:00 INFO - Using env: {'DISPLAY': ':0', 12:46:00 INFO - 'HOME': '/home/cltbld', 12:46:00 INFO - 'LANG': 'en_US.UTF-8', 12:46:00 INFO - 'LANGUAGE': 'en_US:en', 12:46:00 INFO - 'LOGNAME': 'cltbld', 12:46:00 INFO - 'MAIL': '/var/mail/cltbld', 12:46:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:46:00 INFO - 'MOZ_NO_REMOTE': '1', 12:46:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:46:00 INFO - 'NO_EM_RESTART': '1', 12:46:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:46:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:46:00 INFO - 'PWD': '/builds/slave/test', 12:46:00 INFO - 'SHELL': '/bin/bash', 12:46:00 INFO - 'SHLVL': '1', 12:46:00 INFO - 'TERM': 'linux', 12:46:00 INFO - 'TMOUT': '86400', 12:46:00 INFO - 'USER': 'cltbld', 12:46:00 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1495220490.276601-405361073', 12:46:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:46:00 INFO - '_': '/tools/buildbot/bin/python'} 12:46:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:46:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:46: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 12:46: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 12:46: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 12:46: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 12:46:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:46:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:46:02 INFO - Installing collected packages: mozsystemmonitor 12:46:02 INFO - Running setup.py install for mozsystemmonitor 12:46:02 INFO - Successfully installed mozsystemmonitor 12:46:02 INFO - Cleaning up... 12:46:02 INFO - Return code: 0 12:46:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:46:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:46:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:46:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:46:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xceb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd29a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf89310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf86400>, '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 0xf873b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf87840>, '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': '7fc86f70bae03e018da0b1d8000001c4-1495220490.276601-405361073', '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 12:46:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:46:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:46:02 INFO - Using env: {'DISPLAY': ':0', 12:46:02 INFO - 'HOME': '/home/cltbld', 12:46:02 INFO - 'LANG': 'en_US.UTF-8', 12:46:02 INFO - 'LANGUAGE': 'en_US:en', 12:46:02 INFO - 'LOGNAME': 'cltbld', 12:46:02 INFO - 'MAIL': '/var/mail/cltbld', 12:46:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:46:02 INFO - 'MOZ_NO_REMOTE': '1', 12:46:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:46:02 INFO - 'NO_EM_RESTART': '1', 12:46:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:46:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:46:02 INFO - 'PWD': '/builds/slave/test', 12:46:02 INFO - 'SHELL': '/bin/bash', 12:46:02 INFO - 'SHLVL': '1', 12:46:02 INFO - 'TERM': 'linux', 12:46:02 INFO - 'TMOUT': '86400', 12:46:02 INFO - 'USER': 'cltbld', 12:46:02 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1495220490.276601-405361073', 12:46:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:46:02 INFO - '_': '/tools/buildbot/bin/python'} 12:46:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:46:02 INFO - Downloading/unpacking jsonschema==2.5.1 12:46: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 12:46: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 12:46: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 12:46: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 12:46:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:46:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:46: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 12:46: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 12:46: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 12:46: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 12:46:03 INFO - Downloading functools32-3.2.3-2.tar.gz 12:46:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:46:03 INFO - warning: no files found matching '*.txt' 12:46:03 INFO - no previously-included directories found matching 'build' 12:46:03 INFO - no previously-included directories found matching 'dist' 12:46:03 INFO - no previously-included directories found matching '.git*' 12:46:03 INFO - Installing collected packages: jsonschema, functools32 12:46:03 INFO - Running setup.py install for functools32 12:46:03 INFO - warning: no files found matching '*.txt' 12:46:03 INFO - no previously-included directories found matching 'build' 12:46:03 INFO - no previously-included directories found matching 'dist' 12:46:03 INFO - no previously-included directories found matching '.git*' 12:46:03 INFO - Successfully installed jsonschema functools32 12:46:03 INFO - Cleaning up... 12:46:03 INFO - Return code: 0 12:46:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:46: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')]} 12:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:46: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')]} 12:46:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:46: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 0xceb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd29a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf89310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf86400>, '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 0xf873b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf87840>, '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': '7fc86f70bae03e018da0b1d8000001c4-1495220490.276601-405361073', '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 12:46: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 12:46: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 12:46:03 INFO - Using env: {'DISPLAY': ':0', 12:46:03 INFO - 'HOME': '/home/cltbld', 12:46:03 INFO - 'LANG': 'en_US.UTF-8', 12:46:03 INFO - 'LANGUAGE': 'en_US:en', 12:46:03 INFO - 'LOGNAME': 'cltbld', 12:46:03 INFO - 'MAIL': '/var/mail/cltbld', 12:46:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:46:03 INFO - 'MOZ_NO_REMOTE': '1', 12:46:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:46:03 INFO - 'NO_EM_RESTART': '1', 12:46:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:46:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:46:03 INFO - 'PWD': '/builds/slave/test', 12:46:03 INFO - 'SHELL': '/bin/bash', 12:46:03 INFO - 'SHLVL': '1', 12:46:03 INFO - 'TERM': 'linux', 12:46:03 INFO - 'TMOUT': '86400', 12:46:03 INFO - 'USER': 'cltbld', 12:46:03 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1495220490.276601-405361073', 12:46:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:46:03 INFO - '_': '/tools/buildbot/bin/python'} 12:46:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:46:04 INFO - Cleaning up... 12:46:04 INFO - Return code: 0 12:46:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:46:04 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')]} 12:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:46:04 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')]} 12:46:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:46:04 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 0xceb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd29a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf89310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf86400>, '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 0xf873b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf87840>, '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': '7fc86f70bae03e018da0b1d8000001c4-1495220490.276601-405361073', '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 12:46:04 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 12:46:04 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 12:46:04 INFO - Using env: {'DISPLAY': ':0', 12:46:04 INFO - 'HOME': '/home/cltbld', 12:46:04 INFO - 'LANG': 'en_US.UTF-8', 12:46:04 INFO - 'LANGUAGE': 'en_US:en', 12:46:04 INFO - 'LOGNAME': 'cltbld', 12:46:04 INFO - 'MAIL': '/var/mail/cltbld', 12:46:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:46:04 INFO - 'MOZ_NO_REMOTE': '1', 12:46:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:46:04 INFO - 'NO_EM_RESTART': '1', 12:46:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:46:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:46:04 INFO - 'PWD': '/builds/slave/test', 12:46:04 INFO - 'SHELL': '/bin/bash', 12:46:04 INFO - 'SHLVL': '1', 12:46:04 INFO - 'TERM': 'linux', 12:46:04 INFO - 'TMOUT': '86400', 12:46:04 INFO - 'USER': 'cltbld', 12:46:04 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1495220490.276601-405361073', 12:46:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:46:04 INFO - '_': '/tools/buildbot/bin/python'} 12:46:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:46:04 INFO - Downloading/unpacking blobuploader==1.2.4 12:46: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 12:46: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 12:46: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 12:46: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 12:46:05 INFO - Downloading blobuploader-1.2.4.tar.gz 12:46:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:46:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:46: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 12:46: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 12:46: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 12:46: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 12:46:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:46:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:46: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 12:46: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 12:46: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 12:46: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 12:46:05 INFO - Downloading docopt-0.6.1.tar.gz 12:46:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:46:06 INFO - Installing collected packages: blobuploader, requests, docopt 12:46:06 INFO - Running setup.py install for blobuploader 12:46:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:46:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:46:06 INFO - Running setup.py install for requests 12:46:06 INFO - Running setup.py install for docopt 12:46:06 INFO - Successfully installed blobuploader requests docopt 12:46:06 INFO - Cleaning up... 12:46:06 INFO - Return code: 0 12:46:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:46:06 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')]} 12:46:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:46:06 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')]} 12:46:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:46:06 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 0xceb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd29a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf89310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf86400>, '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 0xf873b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf87840>, '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': '7fc86f70bae03e018da0b1d8000001c4-1495220490.276601-405361073', '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 12:46:06 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 12:46:06 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 12:46:06 INFO - Using env: {'DISPLAY': ':0', 12:46:06 INFO - 'HOME': '/home/cltbld', 12:46:06 INFO - 'LANG': 'en_US.UTF-8', 12:46:06 INFO - 'LANGUAGE': 'en_US:en', 12:46:06 INFO - 'LOGNAME': 'cltbld', 12:46:06 INFO - 'MAIL': '/var/mail/cltbld', 12:46:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:46:06 INFO - 'MOZ_NO_REMOTE': '1', 12:46:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:46:06 INFO - 'NO_EM_RESTART': '1', 12:46:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:46:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:46:06 INFO - 'PWD': '/builds/slave/test', 12:46:06 INFO - 'SHELL': '/bin/bash', 12:46:06 INFO - 'SHLVL': '1', 12:46:06 INFO - 'TERM': 'linux', 12:46:06 INFO - 'TMOUT': '86400', 12:46:06 INFO - 'USER': 'cltbld', 12:46:06 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1495220490.276601-405361073', 12:46:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:46:06 INFO - '_': '/tools/buildbot/bin/python'} 12:46:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:46:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:46:06 INFO - Running setup.py (path:/tmp/pip-3LZMsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:46:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:46:06 INFO - Running setup.py (path:/tmp/pip-naW3S3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:46:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:46:06 INFO - Running setup.py (path:/tmp/pip-5xqWP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:46:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:46:07 INFO - Running setup.py (path:/tmp/pip-tKxwJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:46:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:46:07 INFO - Running setup.py (path:/tmp/pip-4I5KG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:46:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:46:07 INFO - Running setup.py (path:/tmp/pip-isxiYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:46:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:46:07 INFO - Running setup.py (path:/tmp/pip-aajshp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:46:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:46:07 INFO - Running setup.py (path:/tmp/pip-UOmAuu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:46:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:46:07 INFO - Running setup.py (path:/tmp/pip-2QVhj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:46:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:46:07 INFO - Running setup.py (path:/tmp/pip-gY74oq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:46:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:46:07 INFO - Running setup.py (path:/tmp/pip-2Dij_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:46:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:46:07 INFO - Running setup.py (path:/tmp/pip-nthtkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:46:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:46:07 INFO - Running setup.py (path:/tmp/pip-JJSNXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:46:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:46:07 INFO - Running setup.py (path:/tmp/pip-1sQo8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:46:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:46:07 INFO - Running setup.py (path:/tmp/pip-G6vocA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:46:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:46:07 INFO - Running setup.py (path:/tmp/pip-02SRdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:46:08 INFO - Running setup.py (path:/tmp/pip-DXCUD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:46:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:46:08 INFO - Running setup.py install for manifestparser 12:46:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:46:08 INFO - Running setup.py install for mozcrash 12:46:08 INFO - Running setup.py install for mozdebug 12:46:08 INFO - Running setup.py install for mozdevice 12:46:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:46:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:46:08 INFO - Running setup.py install for mozfile 12:46:08 INFO - Running setup.py install for mozhttpd 12:46:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:46:08 INFO - Running setup.py install for mozinfo 12:46:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:46:08 INFO - Running setup.py install for mozInstall 12:46:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:46:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:46:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:46:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:46:08 INFO - Running setup.py install for mozleak 12:46:08 INFO - Running setup.py install for mozlog 12:46:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:46:09 INFO - Running setup.py install for moznetwork 12:46:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:46:09 INFO - Running setup.py install for mozprocess 12:46:09 INFO - Running setup.py install for mozprofile 12:46:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:46:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:46:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:46:09 INFO - Running setup.py install for mozrunner 12:46:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:46:09 INFO - Running setup.py install for mozscreenshot 12:46:09 INFO - Running setup.py install for moztest 12:46:09 INFO - Running setup.py install for mozversion 12:46:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:46:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:46:09 INFO - Cleaning up... 12:46:09 INFO - Return code: 0 12:46:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:46: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')]} 12:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:46: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')]} 12:46:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:46: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 0xceb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd29a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf89310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf86400>, '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 0xf873b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf87840>, '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': '7fc86f70bae03e018da0b1d8000001c4-1495220490.276601-405361073', '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 12:46: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 12:46: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 12:46:09 INFO - Using env: {'DISPLAY': ':0', 12:46:09 INFO - 'HOME': '/home/cltbld', 12:46:09 INFO - 'LANG': 'en_US.UTF-8', 12:46:09 INFO - 'LANGUAGE': 'en_US:en', 12:46:09 INFO - 'LOGNAME': 'cltbld', 12:46:09 INFO - 'MAIL': '/var/mail/cltbld', 12:46:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:46:09 INFO - 'MOZ_NO_REMOTE': '1', 12:46:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:46:09 INFO - 'NO_EM_RESTART': '1', 12:46:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:46:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:46:09 INFO - 'PWD': '/builds/slave/test', 12:46:09 INFO - 'SHELL': '/bin/bash', 12:46:09 INFO - 'SHLVL': '1', 12:46:09 INFO - 'TERM': 'linux', 12:46:09 INFO - 'TMOUT': '86400', 12:46:09 INFO - 'USER': 'cltbld', 12:46:09 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1495220490.276601-405361073', 12:46:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:46:09 INFO - '_': '/tools/buildbot/bin/python'} 12:46:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:46:10 INFO - Running setup.py (path:/tmp/pip-fEIflO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:46:10 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)) 12:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:46:10 INFO - Running setup.py (path:/tmp/pip-tgIQAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:46:10 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)) 12:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:46:10 INFO - Running setup.py (path:/tmp/pip-ui9eYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:46:10 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)) 12:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:46:10 INFO - Running setup.py (path:/tmp/pip-uHZzRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:46:10 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)) 12:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:46:10 INFO - Running setup.py (path:/tmp/pip-X9ITpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:46:10 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)) 12:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:46:10 INFO - Running setup.py (path:/tmp/pip-DJLShU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:46:10 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)) 12:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:46:10 INFO - Running setup.py (path:/tmp/pip-wS79Ao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:46: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)) 12:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:46:10 INFO - Running setup.py (path:/tmp/pip-PH2PAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:46: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)) 12:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:46:10 INFO - Running setup.py (path:/tmp/pip-xjch6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:46: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)) 12:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:46:10 INFO - Running setup.py (path:/tmp/pip-LvZwIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:46: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)) 12:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:46:10 INFO - Running setup.py (path:/tmp/pip-1lSjRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:46: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)) 12:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:46:10 INFO - Running setup.py (path:/tmp/pip-0y5e95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:46: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)) 12:46:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:46:10 INFO - Running setup.py (path:/tmp/pip-NZnJpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:46:11 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)) 12:46:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:46:11 INFO - Running setup.py (path:/tmp/pip-JY_xUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:46:11 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)) 12:46:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:46:11 INFO - Running setup.py (path:/tmp/pip-04Z3YU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:46:11 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)) 12:46:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:46:11 INFO - Running setup.py (path:/tmp/pip-CGvyTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:46:11 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)) 12:46:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:46:11 INFO - Running setup.py (path:/tmp/pip-F0DRTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:46:11 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)) 12:46:11 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)) 12:46:11 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)) 12:46:11 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)) 12:46:11 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)) 12:46:11 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)) 12:46:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:46:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:46:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:46:12 INFO - Downloading blessings-1.6.tar.gz 12:46:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:46:12 INFO - Installing collected packages: blessings 12:46:12 INFO - Running setup.py install for blessings 12:46:12 INFO - Successfully installed blessings 12:46:12 INFO - Cleaning up... 12:46:12 INFO - Return code: 0 12:46:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:46:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:46:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:46:12 INFO - Reading from file tmpfile_stdout 12:46:12 INFO - Current package versions: 12:46:12 INFO - argparse == 1.2.1 12:46:12 INFO - blessings == 1.6 12:46:12 INFO - blobuploader == 1.2.4 12:46:12 INFO - docopt == 0.6.1 12:46:12 INFO - functools32 == 3.2.3-2 12:46:12 INFO - jsonschema == 2.5.1 12:46:12 INFO - manifestparser == 1.1 12:46:12 INFO - mozInstall == 1.12 12:46:12 INFO - mozcrash == 1.0 12:46:12 INFO - mozdebug == 0.1 12:46:12 INFO - mozdevice == 0.49 12:46:12 INFO - mozfile == 1.2 12:46:12 INFO - mozhttpd == 0.7 12:46:12 INFO - mozinfo == 0.9 12:46:12 INFO - mozleak == 0.1 12:46:12 INFO - mozlog == 3.4 12:46:12 INFO - moznetwork == 0.27 12:46:12 INFO - mozprocess == 0.25 12:46:12 INFO - mozprofile == 0.28 12:46:12 INFO - mozrunner == 6.13 12:46:12 INFO - mozscreenshot == 0.1 12:46:12 INFO - mozsystemmonitor == 0.3 12:46:12 INFO - moztest == 0.8 12:46:12 INFO - mozversion == 1.4 12:46:12 INFO - psutil == 3.1.1 12:46:12 INFO - requests == 1.2.3 12:46:12 INFO - wsgiref == 0.1.2 12:46:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:46: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')]} 12:46:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:46: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')]} 12:46:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:46: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 0xceb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd29a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf89310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf86400>, '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 0xf873b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf87840>, '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': '7fc86f70bae03e018da0b1d8000001c4-1495220490.276601-405361073', '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 12:46: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 12:46: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 12:46:12 INFO - Using env: {'DISPLAY': ':0', 12:46:12 INFO - 'HOME': '/home/cltbld', 12:46:12 INFO - 'LANG': 'en_US.UTF-8', 12:46:12 INFO - 'LANGUAGE': 'en_US:en', 12:46:12 INFO - 'LOGNAME': 'cltbld', 12:46:12 INFO - 'MAIL': '/var/mail/cltbld', 12:46:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:46:12 INFO - 'MOZ_NO_REMOTE': '1', 12:46:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:46:12 INFO - 'NO_EM_RESTART': '1', 12:46:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:46:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:46:12 INFO - 'PWD': '/builds/slave/test', 12:46:12 INFO - 'SHELL': '/bin/bash', 12:46:12 INFO - 'SHLVL': '1', 12:46:12 INFO - 'TERM': 'linux', 12:46:12 INFO - 'TMOUT': '86400', 12:46:12 INFO - 'USER': 'cltbld', 12:46:12 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1495220490.276601-405361073', 12:46:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:46:12 INFO - '_': '/tools/buildbot/bin/python'} 12:46:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:46:13 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)) 12:46:13 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)) 12:46:13 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)) 12:46:13 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)) 12:46:13 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)) 12:46:13 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)) 12:46:13 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)) 12:46:13 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)) 12:46:13 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)) 12:46:13 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:46:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:46:13 INFO - Cleaning up... 12:46:13 INFO - Return code: 0 12:46:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:46:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:46:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:46:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:46:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:46:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xceb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd29a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf89310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf86400>, '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 0xf873b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf87840>, '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': '7fc86f70bae03e018da0b1d8000001c4-1495220490.276601-405361073', '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 12:46:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:46:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:46:13 INFO - Using env: {'DISPLAY': ':0', 12:46:13 INFO - 'HOME': '/home/cltbld', 12:46:13 INFO - 'LANG': 'en_US.UTF-8', 12:46:13 INFO - 'LANGUAGE': 'en_US:en', 12:46:13 INFO - 'LOGNAME': 'cltbld', 12:46:13 INFO - 'MAIL': '/var/mail/cltbld', 12:46:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:46:13 INFO - 'MOZ_NO_REMOTE': '1', 12:46:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:46:13 INFO - 'NO_EM_RESTART': '1', 12:46:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:46:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:46:13 INFO - 'PWD': '/builds/slave/test', 12:46:13 INFO - 'SHELL': '/bin/bash', 12:46:13 INFO - 'SHLVL': '1', 12:46:13 INFO - 'TERM': 'linux', 12:46:13 INFO - 'TMOUT': '86400', 12:46:13 INFO - 'USER': 'cltbld', 12:46:13 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1495220490.276601-405361073', 12:46:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:46:13 INFO - '_': '/tools/buildbot/bin/python'} 12:46:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:46:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:46:13 INFO - Cleaning up... 12:46:13 INFO - Return code: 0 12:46:13 INFO - Running post-action listener: _resource_record_post_action 12:46:13 INFO - Running post-action listener: _start_resource_monitoring 12:46:13 INFO - Starting resource monitoring. 12:46:13 INFO - [mozharness: 2017-05-19 19:46:13.386534Z] Finished create-virtualenv step (success) 12:46:13 INFO - [mozharness: 2017-05-19 19:46:13.387050Z] Running install step. 12:46:13 INFO - Running pre-action listener: _resource_record_pre_action 12:46:13 INFO - Running main action method: install 12:46:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:46:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:46:13 INFO - Reading from file tmpfile_stdout 12:46:13 INFO - Detecting whether we're running mozinstall >=1.0... 12:46:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:46:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:46:13 INFO - Reading from file tmpfile_stdout 12:46:13 INFO - Output received: 12:46:13 INFO - Usage: mozinstall [options] installer 12:46:13 INFO - Options: 12:46:13 INFO - -h, --help show this help message and exit 12:46:13 INFO - -d DEST, --destination=DEST 12:46:13 INFO - Directory to install application into. [default: 12:46:13 INFO - "/builds/slave/test"] 12:46:13 INFO - --app=APP Application being installed. [default: firefox] 12:46:13 INFO - mkdir: /builds/slave/test/build/application 12:46: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'] 12:46:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 12:46:27 INFO - Reading from file tmpfile_stdout 12:46:27 INFO - Output received: 12:46:27 INFO - /builds/slave/test/build/application/firefox/firefox 12:46:27 INFO - Running post-action listener: _resource_record_post_action 12:46:27 INFO - [mozharness: 2017-05-19 19:46:27.806935Z] Finished install step (success) 12:46:27 INFO - [mozharness: 2017-05-19 19:46:27.807179Z] Running run-tests step. 12:46:27 INFO - Running pre-action listener: _resource_record_pre_action 12:46:27 INFO - Running main action method: run_tests 12:46:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:46:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:46:27 INFO - Python 2.7.3 12:46:27 INFO - Return code: 0 12:46:27 INFO - grabbing minidump binary from tooltool 12:46: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')]} 12:46: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 0xf86400>, '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 0xf873b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf87840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:46: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 12:46: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 12:46: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 12:46:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:46:27 INFO - Return code: 0 12:46:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:46:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:46:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:46:27 INFO - ENV: RUST_BACKTRACE is now 1 12:46:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:46:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:46: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/AtFWNSmFTS2-tNrUZ0a0qQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 12:46: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/AtFWNSmFTS2-tNrUZ0a0qQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 12:46:27 INFO - Using env: {'DISPLAY': ':0', 12:46:27 INFO - 'HOME': '/home/cltbld', 12:46:27 INFO - 'LANG': 'en_US.UTF-8', 12:46:27 INFO - 'LANGUAGE': 'en_US:en', 12:46:27 INFO - 'LOGNAME': 'cltbld', 12:46:27 INFO - 'MAIL': '/var/mail/cltbld', 12:46:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:46:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:46:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:46:27 INFO - 'MOZ_NO_REMOTE': '1', 12:46:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:46:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:46:27 INFO - 'NO_EM_RESTART': '1', 12:46:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:46:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:46:27 INFO - 'PWD': '/builds/slave/test', 12:46:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:46:27 INFO - 'RUST_BACKTRACE': '1', 12:46:27 INFO - 'SHELL': '/bin/bash', 12:46:27 INFO - 'SHLVL': '1', 12:46:27 INFO - 'TERM': 'linux', 12:46:27 INFO - 'TMOUT': '86400', 12:46:27 INFO - 'USER': 'cltbld', 12:46:27 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1495220490.276601-405361073', 12:46:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:46:27 INFO - '_': '/tools/buildbot/bin/python'} 12:46: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/AtFWNSmFTS2-tNrUZ0a0qQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 12:46:28 INFO - mozversion application_buildid: 20170519185742 12:46:28 INFO - mozversion application_changeset: 0241994e3aad3594cae0d42c7d80a2dff7b245e8 12:46:28 INFO - mozversion application_display_name: Firefox 12:46:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:46:28 INFO - mozversion application_name: Firefox 12:46:28 INFO - mozversion application_remotingname: firefox 12:46:28 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:46:28 INFO - mozversion application_vendor: Mozilla 12:46:28 INFO - mozversion application_version: 54.0 12:46:28 INFO - mozversion platform_buildid: 20170519185742 12:46:28 INFO - mozversion platform_changeset: 0241994e3aad3594cae0d42c7d80a2dff7b245e8 12:46:28 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:46:28 INFO - mozversion platform_version: 54.0 12:46:28 INFO - using testdate: 1495223188 12:46:28 INFO - actual date: 1495223188 12:46:28 INFO - starting webserver on 'localhost:59491' 12:46:28 INFO - SUITE-START | Running 2 tests 12:46:28 INFO - TEST-START | dromaeo_css 12:46:28 INFO - operating with platform_type : linux_ 12:46:28 INFO - Initialising browser for dromaeo_css test... 12:46:28 INFO - TEST-INFO | started process 12224 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEDeYOu/profile http://localhost:59491/getInfo.html) 12:46:32 INFO - PROCESS | 12224 | __metrics Screen width/height:1600/1200 12:46:32 INFO - PROCESS | 12224 | colorDepth:24 12:46:32 INFO - PROCESS | 12224 | Browser inner width/height: 1024/697 12:46:32 INFO - PROCESS | 12224 | __metrics 12:46:33 INFO - PROCESS | 12224 | 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" 12:46:33 INFO - PROCESS | 12224 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:46:33 INFO - PROCESS | 12224 | console.error: PushService: 12:46:33 INFO - PROCESS | 12224 | stateChangeProcessEnqueue: Error transitioning state 12:46:33 INFO - PROCESS | 12224 | UnknownError 12:46:34 INFO - TEST-INFO | 12224: exit 0 12:46:34 INFO - Browser initialized. 12:46:34 INFO - Running cycle 1/1 for dromaeo_css test... 12:46:34 INFO - TEST-INFO | started process 12316 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEDeYOu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:46:45 INFO - PROCESS | 12316 | RSS: Main: 141742080 12:46:45 INFO - PROCESS | 12316 | 12:49:47 INFO - PROCESS | 12316 | Cycle 1(1): loaded http://localhost:59491/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59491/tests/dromaeo/cssquery-ext.html) 12:49:49 INFO - PROCESS | 12316 | RSS: Main: 273522688 12:49:49 INFO - PROCESS | 12316 | 12:52:51 INFO - PROCESS | 12316 | Cycle 1(1): loaded http://localhost:59491/tests/dromaeo/cssquery-ext.html (next: http://localhost:59491/tests/dromaeo/cssquery-jquery.html) 12:52:51 INFO - PROCESS | 12316 | RSS: Main: 225923072 12:52:51 INFO - PROCESS | 12316 | 12:55:53 INFO - PROCESS | 12316 | Cycle 1(1): loaded http://localhost:59491/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59491/tests/dromaeo/cssquery-mootools.html) 12:55:54 INFO - PROCESS | 12316 | RSS: Main: 177049600 12:55:54 INFO - PROCESS | 12316 | 12:58:56 INFO - PROCESS | 12316 | Cycle 1(1): loaded http://localhost:59491/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59491/tests/dromaeo/cssquery-prototype.html) 12:58:57 INFO - PROCESS | 12316 | RSS: Main: 171630592 12:58:57 INFO - PROCESS | 12316 | 13:01:59 INFO - PROCESS | 12316 | Cycle 1(1): loaded http://localhost:59491/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59491/tests/dromaeo/cssquery-yui.html) 13:02:00 INFO - PROCESS | 12316 | RSS: Main: 172920832 13:02:00 INFO - PROCESS | 12316 | 13:05:02 INFO - PROCESS | 12316 | Cycle 1(1): loaded http://localhost:59491/tests/dromaeo/cssquery-yui.html (next: http://localhost:59491/tests/dromaeo/cssquery-dojo.html) 13:05:03 INFO - PROCESS | 12316 | RSS: Main: 265031680 13:05:03 INFO - PROCESS | 12316 | 13:05:03 INFO - PROCESS | 12316 | __start_tp_report 13:05:03 INFO - PROCESS | 12316 | _x_x_mozilla_page_load 13:05:03 INFO - PROCESS | 12316 | _x_x_mozilla_page_load_details 13:05:03 INFO - PROCESS | 12316 | |i|pagename|runs| 13:05:03 INFO - PROCESS | 12316 | |0;dojo.html;3339.5825521809775;3371.140359208402;3376.645452227516;3395.151212196951;3411.8635254589803;5780.364159942403;5791.681457519835;5844.590878638497;5855.590108692393;5871.148683440899;5847.532197424206;5896.380880007602;5906.173135760997;5906.557008224389;5919.082542205954;5290.418054014055;5322.574194064485;5343.812966546172;5383.380911195223;5397.919031214535;5153.845384638467;5181.870453238662;5415.864603384907;5421.701806400646;5426.348838139429;5256.132738098209;5286.947130528703;5299.205119232108;5315.681059136445;5336.412994570614;5353.491418315254;5366.114591092484;5374.7043912584795;5376.166694162392;5377.677339359612;5060.51925067118;5211.869703257411;5250.763715632767;5311;5315.521603055744;5628.746706398222;5662.433756624346;5723.255976723041;5734.512566431858;5737.655740655574;6215.1609532712955;6226.128342032119;6240.531960102965;6242.09489624002;6253.062040693887;6304.87390252197;6306.810795676091;6310.7791227306825;6312.652804095773;6315.842103947392;5614.859628509279;5642.4357564243655;5757.683327417032;5794.913076303858;5860.296764388258;6355.491560675135;6357.4914006879335;6359.077933699587;6363.395477429637;6372.6495042773095;6083.8174854754425;6126.23422072241;6135.141080248769;6136.969315153396;6137.631742095488;6013.248343957005;6040.7583696651645;6127.9837278401355;6178.505719542426;6238.844028899314;6195.2255968004;6220.03589443637;6223.595466294676;6233.2208473940755;6243.843903902439;5948.67282299469;5989.880202396015;5999.460048595647;6109.131392049051;6111.35830737775;4723.551262630044;4752.477227504972;4781.450133234653;4791.281307803857;4795.784189711471;4240.787960601958;4247.447831781848;4261.083866968616;4270.444842170498;4289.742615443083;5801.129830525455;5850.94149058504;5892.086726557391;5935.347111817697;6025.578209525291;6234.251889773256;6244.438000579969;6245.219347581552;6245.437910588069;6252.187215661935;5985.910211346833;5988.131720900445;5989.940100599026;5990.880182396328;6034.879302413927;5133.332666753373;5170.353705786777;5257.395399529103;5284.656497327738;5306.52241298285;6455.7740479083;6494.188226471691;6496.480281577463;6501.0248462731915;6507.251666058464;6240;6299.338569450325;6316.778912738032;6320.083587879823;6320.178376810985;6222.377762223922;6248.937510624835;6315.652639104709;6524.902126468011;6535.986922027093;6122.794608434163;6132.0495871890025;6137.714085983886;6138.725610151984;6139.4781443577795;6230.532710046674;6234.657093859882;6236.968815155895;6238.344973777869;6239.844003899939;5822.155787410887;5879.970600146972;6020.307664618625;6072.028475443908;6082.787102451393;6057.545684073801;6087.299960504599;6111.95640283616;6153.907691384543;6155.446009858955;6120.142398366865;6126.805272971727;6128.503123582109;6132.99804414626;6134.1610691366095;5941.58408911372;5974.103884417372;5975.282966044103;6089.969550152398;6127.119784992317;6024.548158888013;6028.1861948638125;6054.576179667557;6074.3014553325165;6075 13:05:03 INFO - PROCESS | 12316 | |1;ext.html;775.3603277296232;845.0324378586517;862.3015357560377;918.4030380252839;922.3220932614523;30754.692453075462;44980.77509612451;45639;45684.77157614207;45759.31361029583;38057.429138562875;38412;38549;38628.42057369135;38644;7775.922240777605;7914.445988780759;9259.16667499925;9381;9388.577514011851;10760.78478430431;10921.672349829518;10984;10987.560497580087;10988.230823842334;11054.392008439532;11130.38782866942;11139.275947063416;11144.554217831277;11149.944250278737;10992.450377481135;11022.338659680445;11031.22781405302;11033.668989930275;11038.503267352948;10734.355938643628;10746;10766.73083172927;10782.245242833005;10788.190885683605;43614.12771744547;43716.562834371565;43855;43910.56089439129;43921;3728.6271372862766;3783;3783.697304215656;3788.3749181385037;3882.5729169791302;30820.2294942626;30880;30947.690523094705;31148.844255778575;31421.214469638213;4357.193919124972;4368.759718215497;4416.939934415749;4512.390827238347;4552.1350943320995;249046;249295;249908.9999999982;250220;250319;45278.32082518765;45821;45993.31010034852;45999.31001034987;46043.539564604594;49119;49165.75417122892;49205.75397122991;49244.75377623089;49318.26022609664;15849.841501585068;16145.515634530982;16194.190290485663;16196.352145914032;16198.59503512398;12120.696982575506;12153.210041347284;13952.930235348758;14020.579382618538;14036.087654302437;13393.799093013613;13462.596122116352;13491.527796527074;13544.59366219015;13601.047926645238;5658.122990936411;5668.433156684381;5670.603057785916;5686.289213848269;5708;1007.7480629842539;1010.4038617215878;1021.2085633633993;1030.9793804123876;1042.3797840285017;29923.850380747957;29934.850325748666;30150.246243844078;30289.697103029128;30585.388292234475;1068.8770791358938;1097.1168209591356;1099.4118146791427;1103.7406209540752;1128.7798879218637;15370;16181.271842767104;16712.41506547265;17333.913330433268;17477.38829140974;333216;333373;333881;334093;334907;53561.73219133957;53873;53883.19175212375;53963.730181348845;54053.72973135109;1513.583764464759;1522;1587.0874247307613;1617.5551723276194;1621.7405215165518;30521.389572207987;33023.339533208724;33774.49338259879;33949.321013580084;34720.479192812636;46551.30173047475;46733.532664672915;46766.76616616895;46848.297275540215;47008.52991470179;322578;324060;324438;326617;329655;39712.80143599264;40420.595794041685;40471.59528404678;40496.3925541123;40579;48131;48272.27591586059;48382.5161748378;48398.27402589034;48462.27306590333;35609.28781424409;36321.27357452783;36403;36620.81689591535;37085;36038.639613603526;36189.27621447609;36559.45160822537;36685;36831.8158409217;41326.1734765309;41908.58091419169;41950.37074443947;41958.790206048776;42174.578254217064;35550.64449355473;35590.8220458896;35922.64077359193;36067.27865442729;36098;27221.31946701269;27859.86070069637;28358.432831342845;28386.858065710367;28425.28936776597 13:05:03 INFO - PROCESS | 12316 | |2;jquery.html;464.664090739125;484.6946423753036;485.12919309838855;487.91705410080283;502.78129013878953;20231.39305820824;21621.891890540566;21904.342869713895;22449.32652020438;22648.207312744056;21979.780202197973;21986.670199946973;22550.097996080138;22624.547509049808;22904;6655.567388119781;6873.725050997967;6899.37905588497;6937.410320122771;6944.826379340531;6848.075509806187;6942.444604431634;7300.379467745248;7596.772096837104;7606.353459955911;7507.286807753255;7750.108737495176;7766.766996990099;7768.951191589148;7773.805654858617;7764.689412423496;7825.37397008238;7857.567833769141;7901.328387087105;7907.2488113629115;7615.46691731579;7725.381969442431;7759.650815713307;7761.72833950809;7769.067711874612;25494.617580736303;26407;26442.6033609496;26795.59806602883;27044;3047.43622429849;3146.858391372371;3228.1606782236554;3593.8562457501666;3616.18635806944;18590;18825.811741882542;19514.12186451599;19516.70724939127;19605.411837644893;2439.865807380593;2479.566075936704;2511.259178542316;2572.704139023999;2587.275562842407;115113;116842;117514;118063.40968295104;125851;20996.265130720352;21651;21673.566528669337;22000.229991950204;22225.333240002827;43635.563644363785;43757.78121109374;43770.12459750787;43773.34339984903;43775.78112109483;10283.9485802572;10774.138068954464;10931.672049838518;10958.452077396258;11065.50205240766;8989.55052247385;9118.86321705175;9145.176934075966;9195.448273103502;9324.440533568008;9340.486273255035;9461.337706360626;9534.761630959281;9556;9557.904420955701;3338.8831390901687;3713.5729391119826;3750.7374483785875;3860.864869729602;3911.8630847920185;976.1312431935582;981.9803603927882;982.3663736889808;1000.6547741029333;1011.9645812396531;21426.464338391666;21754.676015377616;21783.67324490134;21882;21913.780862191492;996.6960077176531;1000.9599616015278;1007.6322142417964;1014.832552628808;1021.3871676993892;11074.778504429867;11537.48081336342;11985.940070299766;11986.820197697041;12040.096992725405;612610;612621;614053;617990;628235;115470.4226478879;118015;119477.40261298638;120064.7993520071;121097;1272.3129510064646;1275.2348590845418;1288.2077522323702;1290.9806352904902;1307.9476820927246;18425.170867310735;18625.627487449903;18731.250749969848;19053.902091611286;19414.805851941866;52451;52714;53433.7328313356;53510.73244633752;53574.196387053446;68092.31907681059;68151.65924170546;68770.08530053482;69778.65110674415;70283;12150.21023633461;12161.39193040362;12217.14479986428;12279.815802763145;12296;13352.332383380986;13532.59402217935;13603.183808971493;13622.591322259952;14004.929975350058;11961.401929903644;12182.269063855843;12194.268343899394;12212.75574488523;12240.469941257343;10507.054365107177;10581.4709264538;10673.57305707763;10712.3572585642;10830.837537437103;12173;12356.752864942831;12431;12439.315837629018;12778.169418988107;11993.880061199276;12174.526030470743;12269.263844169378;12464;12481.126321157795;12124.151309408257;12211.633650990485;12244.510219591117;12533.87466125327;12810.935945320214 13:05:03 INFO - PROCESS | 12316 | |3;mootools.html;1453.5493996860966;1592.6257329527566;1600.9039457632543;1605.044998226055;1617.0782653887286;9186.954065229673;11213.719657008569;11476.967072963442;11491.540338386476;11510.884891151087;11646;11705.70735731607;11710;11712.882871171285;11732.413379331041;1990.93031743889;2062.5668609592003;2478.566250906093;2493.763092506209;2520.2565243253193;2302.735185453669;2358.5872472317274;2360.1975328388344;2360.7639236076425;2367.633016882386;2459.631055341695;2471.5551200783943;2473.4063824682034;2474.5669507836146;2482.863442510661;2385.439421735891;2401.147592604618;2403.807695384365;2406.38637147528;2407.1214006887535;2241.551689662058;2251.763564825686;2255.458689914425;2258.367657056027;2346.894389752465;11456.71358216043;11529.192956493049;11532.077433805276;11538.711532211679;11554.94222528882;5856.590038697293;6001.549883758736;6022.69886505673;6027.126066720301;6028.457438830483;3391.728661707082;3463.8960831175104;3646.398344273192;3662.4689420033947;3687.502187204747;1259.3010878962173;1302.4008955880306;1369.3632460905626;1417.9220142892136;1439.172475826404;16787.244573994078;16793.99236045841;16801.411950581794;16823.49529514104;16849.241784119746;4881.121398148367;4990.351254336913;5041.445441001487;5050.595952323805;5095.592352611782;13224.206547607175;13295.401706923212;13318.667033324244;13344;13345.065845390729;6067.817965461043;6080.391960803884;6084.148219249309;6087.6956152192215;6091.756329746849;5384.219288203267;5488.4785945335125;5578.63738856973;5589.385167631557;5654.208410822488;3952.486176796998;4045.6763458923215;4049.4330793688905;4083.7549747015273;4107.301758701028;1025.4308858583408;1030.644427672452;1045.1116550931647;1046.283295942282;1049.9370037797758;1048.554364395129;1067.5996501312009;1076.5263284154946;1078.1428764132534;1085.934843909368;7389.852202955911;7550.169481357047;7597.354224890946;7651.770446886602;7751.496152750166;1084.967450976472;1095.6274866545414;1115.8382034604938;1143.2625956258166;1169;4737.881552961204;4804.663673542888;4860.513948605111;4994.725290109079;5128.307678463434;14689.265536723122;15018.249087545579;15123.848761512245;15308.923455382874;15346.232688365537;14832.184229867245;15172.165530895907;15281.694366112615;15365.539033829004;15366.84633153654;10078;10218.642347517949;10330.070293673456;10780.191485638608;10899.237053406185;7166.104236970379;7372.815679608053;7383.815404614713;7389.445791565547;7467.887981680171;12876.549320773727;12980.286084265455;13009.739805204032;13101.934490327869;13204.933975330061;11193.104551635686;11264.94367528157;12960.222386656831;13087.672808179872;13207.537736179187;9682.225421966084;9769.364991275545;9793.608255669693;10118.342307749972;10254.692359229235;10400.115990140923;11242.325460472397;11262.831057534308;11335.206535542433;11336.093112551142;9303.395279307095;9435.669751558937;9502.809943800947;9582.808343833223;9610.807783844424;8788.736337909873;8803.119688031145;8816.691415800417;8865.468071915706;9028.36801423894;8419.36854735885;8496.235338819535;8547.700830470903;8566.357523185661;8582.227599516074;6369.394907483782;6479.935200647933;6492.156019717407;6493.253275873146;6560.3111673273615;6275.3724627536885;6321.620702757666;6369.20384951881;6491.870162596816;6577.80266592003 13:05:03 INFO - PROCESS | 12316 | |4;prototype.html;426.1073051956151;443.43904960225314;444.2314795403951;453.80032785574343;456.2016471175443;5276.2036120855955;5300.496452836984;5303.840884773458;5314.601404894634;5347.144456886899;5094.46508116648;5133.845984620458;5166.664166829153;5217.252220506135;5248.265242866002;4224.549761138547;4229.471316085489;4230.19626271009;4246.575342465744;4274.935875961863;4251.553586873365;4253.80857861397;4257.425247591582;4260.510041345238;4282.935755963663;4169.353750168729;4234.9364759528635;4257.467816522934;4274.679399045069;4315.575859966204;4221.691275704526;4242.493914660313;4245.490541135053;4268.935965960513;4282.807273672676;3887.3974533947003;3899.902502437433;3919.902002449933;3922.391609579626;3928.2339943710986;5085.821996230151;5109.335786347789;5144.768485418165;5152.716600586966;5169.948300517022;4677.263800676608;4821.566059054702;4848.8302909398;4874.634402419797;4911.901761964741;5426.810061647863;5430.018043414126;5461.208124821878;5474.178873169017;5497.312835895513;4290.742555446684;4310.1379724055005;4316.2446571849805;4332.328489084197;4336.544662810423;5471.346396997453;5674.801381951612;5682.2044913712525;5690.5447564194765;5728.62763920348;4396.406485124531;4397.890052748707;4398.670099742532;4399.62603178727;4422.204003279377;4454.175977444183;4467.977660111678;4474.239379305526;4501.01955139744;4502.829264391216;4728.338032675429;4821.349117869113;4826.444958829779;4836.250381190921;4846;5447.700376479332;5469.5232287282215;5471.440639417747;5488.56091512678;5517.420670829585;1671.7910261217348;1721.7345251240329;1753.3863147898135;1760.9647807043787;1771.4508502364308;1392.5891861900764;1410.6684929041667;1446.4720377062297;1453.2152637575803;1461.3131828040803;5314.28257185275;5348.406023078804;5384.542313903362;5388.245645609618;5400.459954004568;5540.833774986757;5561.610687251934;5595.38450770415;5624.493795558419;5635.139929148547;5170.431252562215;5331.360236771535;5336.893262134736;5375.865603359869;5446.346438427414;2971.7667168124985;2979.6722360540325;2980.210244285266;2983.9850800745858;2996.161074899032;5794.855128621818;5795.797147099831;5798.507126894261;5834.912476312858;5844.503217226498;5434.2935418395355;5544.974179776754;5559.916601250984;5697.544196464273;5711.429856564562;5649.7852961612625;5737;5752.798652047159;5780.075187969905;5788.5369170466265;5595.860103497445;5612.887742245214;5618.410066942912;5626.943730562805;5628.802991895264;5123.590112790893;5254.13306804373;5459.12653975362;5498.780048798003;5537.2524709165355;5703.572232082527;5710.971445142748;5718.256626638677;5736.856578585402;5786.855328616818;4720.480747117883;4896.192128298933;4922.852314430573;4947.604191664586;4950.975245123751;5560.471755183413;5571.303587051619;5585.5531557476115;5593.384727679871;5600.691961942132;5405.5135037846785;5417.214503896992;5482.29944787275;5498.031063225973;5513.2005859151;5176.948230517647;5418.295621569171;5433.565314774887;5433.891322173614;5502.642328248651;5424.728763561727;5428.67427954324;5474.781008759605;5498.945010549844;5525.4474552544425;5478.780848766164;5488.780448782164;5523.944760552343;5537.944620553743;5560.221568980265;5073.264376665436;5316.893662126813;5362.51737343641;5374.253367655449;5381.67709937405 13:05:03 INFO - PROCESS | 12316 | |5;yui.html;845.8477474054675;863.9956800215998;900.5182227508283;914.7895983923696;934.9953250233748;17289.308427662894;17669.20488578014;17803.287868485244;18050.5487362816;19182.13680384384;16893.83106168941;16907.070111143883;17013.659726805457;17035;17170.9697418155;899.1682693508495;923.0815338737932;923.5613083785215;923.6536298887917;923.7921467669788;887.5917078144029;912.9315301352392;925.2089463508704;926.1433174313732;926.7451450851037;971.6939164163301;972.8248915195262;972.8346181149221;975.0103644800533;975.2831668723483;963.4026903319916;967.0088159636358;967.086103632068;967.4050458967755;967.5162418790604;708.3624737736027;708.6669265445232;708.7200555780489;708.7377670262036;708.8086216721508;18671.06644667761;18686.813131868643;18689.719654205197;19628.313009044614;19789.802101979083;16043.598910027225;16137.43518976842;16200.594985125348;16214.270357833926;16539.007659540464;12882.904953079;13866.4453421863;14090.506832260822;14179.29103544829;14275.571732848031;4915.164422048225;4967.677100988424;5046;5113.514216149497;5228.764705588258;78575.21424785737;79476.60261698712;81351;81660.59169704113;82565;11834.585789497327;11870.287782733063;11874.881251187378;11988.160828741904;11992.220505667105;22634.207802726825;22742.772572274396;23000.65499017516;23011.539769204523;23033.193838215582;8692.565371731389;8890.199882010651;9093.181613654802;9120.954395227982;9161.725148245563;5059.114654935372;5119.539241468286;5158.535731784157;5178.689278643218;5228.9738551307;3542.6988705959766;3615.4757560154158;3624.909377265537;3628.63713628635;3630.3828349180703;632.6425569553188;633.9080833279148;637.1589501857596;649.9707513161919;653.4380432827764;619.3465893482419;621.18314416543;629.0626965820894;636.2301615045847;649.4252586461016;10916.56333746657;10997.450127493594;11158.218924675357;11345.716357090974;11593.130515211393;768.0783060327518;768.4812751392899;772.9188435214334;804.5373910001655;812.6586833529932;5329.333833270841;5402.837914862561;5516.338039435213;5518.365387980433;5526.226328314039;68335.65832170808;71011.64494177495;73820.26179738241;76970;83162;63957;64047.359526405075;64055.35944640587;68441.65779171072;70656.64671676609;58910.41089589049;64760.352396475435;65258.34741652618;67662.30844228933;70564;11337.546498140311;11907.583234586747;11977.760444791229;12278.386080696107;12279.570215042431;46463.30305045359;46897;47226.055478890914;47603.76198118987;47655;51822;52335;52488;52742;52946.205806912156;15645.217739113226;15957.920210398874;16029.519114426586;16278.186090695655;16956.321747129976;16925.576860578585;17008.404705835732;17407.042612656427;17587.29650813953;17981.280748770427;15822.208889555706;16045.919770401073;16347.754783678016;16713.74929376036;17221.655566888843;15924.203789810696;15939.545495302355;16348.427805026768;16724.832751672813;17244.913775431545;14941.879359047898;15014.174220417983;15702.9214853925;16435.09606971628;16529.917350413172;11396.48715807774;11499.885001149882;11796.94101529487;12210.755784884075;12245.326507042199;13182.143160694524;13210.80183797263;13283.335833208494;13305.268210248529;13626 13:05:03 INFO - PROCESS | 12316 | __end_tp_report 13:05:03 INFO - PROCESS | 12316 | __start_cc_report 13:05:03 INFO - PROCESS | 12316 | _x_x_mozilla_cycle_collect,1462 13:05:03 INFO - PROCESS | 12316 | __end_cc_report 13:05:03 INFO - PROCESS | 12316 | __startTimestamp1495224303039__endTimestamp 13:05:03 INFO - PROCESS | 12316 | 13:05:03 INFO - PROCESS | 12316 | ------- Summary: start ------- 13:05:03 INFO - PROCESS | 12316 | Number of tests: 6 13:05:03 INFO - PROCESS | 12316 | 13:05:03 INFO - PROCESS | 12316 | [#0] dojo.html Cycles:165 Average:5779.72 Median:6020.31 stddev:655.15 (10.9%) stddev-sans-first:628.57 13:05:03 INFO - PROCESS | 12316 | Values: 3339.6 3371.1 3376.6 3395.2 3411.9 5780.4 5791.7 5844.6 5855.6 5871.1 5847.5 5896.4 5906.2 5906.6 5919.1 5290.4 5322.6 5343.8 5383.4 5397.9 5153.8 5181.9 5415.9 5421.7 5426.3 5256.1 5286.9 5299.2 5315.7 5336.4 5353.5 5366.1 5374.7 5376.2 5377.7 5060.5 5211.9 5250.8 5311.0 5315.5 5628.7 5662.4 5723.3 5734.5 5737.7 6215.2 6226.1 6240.5 6242.1 6253.1 6304.9 6306.8 6310.8 6312.7 6315.8 5614.9 5642.4 5757.7 5794.9 5860.3 6355.5 6357.5 6359.1 6363.4 6372.6 6083.8 6126.2 6135.1 6137.0 6137.6 6013.2 6040.8 6128.0 6178.5 6238.8 6195.2 6220.0 6223.6 6233.2 6243.8 5948.7 5989.9 5999.5 6109.1 6111.4 4723.6 4752.5 4781.5 4791.3 4795.8 4240.8 4247.4 4261.1 4270.4 4289.7 5801.1 5850.9 5892.1 5935.3 6025.6 6234.3 6244.4 6245.2 6245.4 6252.2 5985.9 5988.1 5989.9 5990.9 6034.9 5133.3 5170.4 5257.4 5284.7 5306.5 6455.8 6494.2 6496.5 6501.0 6507.3 6240.0 6299.3 6316.8 6320.1 6320.2 6222.4 6248.9 6315.7 6524.9 6536.0 6122.8 6132.0 6137.7 6138.7 6139.5 6230.5 6234.7 6237.0 6238.3 6239.8 5822.2 5880.0 6020.3 6072.0 6082.8 6057.5 6087.3 6112.0 6153.9 6155.4 6120.1 6126.8 6128.5 6133.0 6134.2 5941.6 5974.1 5975.3 6090.0 6127.1 6024.5 6028.2 6054.6 6074.3 6075.0 13:05:03 INFO - PROCESS | 12316 | 13:05:03 INFO - PROCESS | 12316 | [#1] ext.html Cycles:180 Average:47830.23 Median:35135.56 stddev:79672.09 (226.8%) stddev-sans-first:79817.25 13:05:03 INFO - PROCESS | 12316 | Values: 775.4 845.0 862.3 918.4 922.3 30754.7 44980.8 45639.0 45684.8 45759.3 38057.4 38412.0 38549.0 38628.4 38644.0 7775.9 7914.4 9259.2 9381.0 9388.6 10760.8 10921.7 10984.0 10987.6 10988.2 11054.4 11130.4 11139.3 11144.6 11149.9 10992.5 11022.3 11031.2 11033.7 11038.5 10734.4 10746.0 10766.7 10782.2 10788.2 43614.1 43716.6 43855.0 43910.6 43921.0 3728.6 3783.0 3783.7 3788.4 3882.6 30820.2 30880.0 30947.7 31148.8 31421.2 4357.2 4368.8 4416.9 4512.4 4552.1 249046.0 249295.0 249909.0 250220.0 250319.0 45278.3 45821.0 45993.3 45999.3 46043.5 49119.0 49165.8 49205.8 49244.8 49318.3 15849.8 16145.5 16194.2 16196.4 16198.6 12120.7 12153.2 13952.9 14020.6 14036.1 13393.8 13462.6 13491.5 13544.6 13601.0 5658.1 5668.4 5670.6 5686.3 5708.0 1007.7 1010.4 1021.2 1031.0 1042.4 29923.9 29934.9 30150.2 30289.7 30585.4 1068.9 1097.1 1099.4 1103.7 1128.8 15370.0 16181.3 16712.4 17333.9 17477.4 333216.0 333373.0 333881.0 334093.0 334907.0 53561.7 53873.0 53883.2 53963.7 54053.7 1513.6 1522.0 1587.1 1617.6 1621.7 30521.4 33023.3 33774.5 33949.3 34720.5 46551.3 46733.5 46766.8 46848.3 47008.5 322578.0 324060.0 324438.0 326617.0 329655.0 39712.8 40420.6 40471.6 40496.4 40579.0 48131.0 48272.3 48382.5 48398.3 48462.3 35609.3 36321.3 36403.0 36620.8 37085.0 36038.6 36189.3 36559.5 36685.0 36831.8 41326.2 41908.6 41950.4 41958.8 42174.6 35550.6 35590.8 35922.6 36067.3 36098.0 27221.3 27859.9 28358.4 28386.9 28425.3 13:05:03 INFO - PROCESS | 12316 | 13:05:03 INFO - PROCESS | 12316 | [#2] jquery.html Cycles:180 Average:37508.67 Median:22337.33 stddev:102082.83 (457.0%) stddev-sans-first:102331.30 13:05:03 INFO - PROCESS | 12316 | Values: 464.7 484.7 485.1 487.9 502.8 20231.4 21621.9 21904.3 22449.3 22648.2 21979.8 21986.7 22550.1 22624.5 22904.0 6655.6 6873.7 6899.4 6937.4 6944.8 6848.1 6942.4 7300.4 7596.8 7606.4 7507.3 7750.1 7766.8 7769.0 7773.8 7764.7 7825.4 7857.6 7901.3 7907.2 7615.5 7725.4 7759.7 7761.7 7769.1 25494.6 26407.0 26442.6 26795.6 27044.0 3047.4 3146.9 3228.2 3593.9 3616.2 18590.0 18825.8 19514.1 19516.7 19605.4 2439.9 2479.6 2511.3 2572.7 2587.3 115113.0 116842.0 117514.0 118063.4 125851.0 20996.3 21651.0 21673.6 22000.2 22225.3 43635.6 43757.8 43770.1 43773.3 43775.8 10283.9 10774.1 10931.7 10958.5 11065.5 8989.6 9118.9 9145.2 9195.4 9324.4 9340.5 9461.3 9534.8 9556.0 9557.9 3338.9 3713.6 3750.7 3860.9 3911.9 976.1 982.0 982.4 1000.7 1012.0 21426.5 21754.7 21783.7 21882.0 21913.8 996.7 1001.0 1007.6 1014.8 1021.4 11074.8 11537.5 11985.9 11986.8 12040.1 612610.0 612621.0 614053.0 617990.0 628235.0 115470.4 118015.0 119477.4 120064.8 121097.0 1272.3 1275.2 1288.2 1291.0 1307.9 18425.2 18625.6 18731.3 19053.9 19414.8 52451.0 52714.0 53433.7 53510.7 53574.2 68092.3 68151.7 68770.1 69778.7 70283.0 12150.2 12161.4 12217.1 12279.8 12296.0 13352.3 13532.6 13603.2 13622.6 14004.9 11961.4 12182.3 12194.3 12212.8 12240.5 10507.1 10581.5 10673.6 10712.4 10830.8 12173.0 12356.8 12431.0 12439.3 12778.2 11993.9 12174.5 12269.3 12464.0 12481.1 12124.2 12211.6 12244.5 12533.9 12810.9 13:05:03 INFO - PROCESS | 12316 | 13:05:03 INFO - PROCESS | 12316 | [#3] mootools.html Cycles:180 Average:7202.95 Median:2360.48 stddev:4578.46 (194.0%) stddev-sans-first:4570.92 13:05:03 INFO - PROCESS | 12316 | Values: 1453.5 1592.6 1600.9 1605.0 1617.1 9187.0 11213.7 11477.0 11491.5 11510.9 11646.0 11705.7 11710.0 11712.9 11732.4 1990.9 2062.6 2478.6 2493.8 2520.3 2302.7 2358.6 2360.2 2360.8 2367.6 2459.6 2471.6 2473.4 2474.6 2482.9 2385.4 2401.1 2403.8 2406.4 2407.1 2241.6 2251.8 2255.5 2258.4 2346.9 11456.7 11529.2 11532.1 11538.7 11554.9 5856.6 6001.5 6022.7 6027.1 6028.5 3391.7 3463.9 3646.4 3662.5 3687.5 1259.3 1302.4 1369.4 1417.9 1439.2 16787.2 16794.0 16801.4 16823.5 16849.2 4881.1 4990.4 5041.4 5050.6 5095.6 13224.2 13295.4 13318.7 13344.0 13345.1 6067.8 6080.4 6084.1 6087.7 6091.8 5384.2 5488.5 5578.6 5589.4 5654.2 3952.5 4045.7 4049.4 4083.8 4107.3 1025.4 1030.6 1045.1 1046.3 1049.9 1048.6 1067.6 1076.5 1078.1 1085.9 7389.9 7550.2 7597.4 7651.8 7751.5 1085.0 1095.6 1115.8 1143.3 1169.0 4737.9 4804.7 4860.5 4994.7 5128.3 14689.3 15018.2 15123.8 15308.9 15346.2 14832.2 15172.2 15281.7 15365.5 15366.8 10078.0 10218.6 10330.1 10780.2 10899.2 7166.1 7372.8 7383.8 7389.4 7467.9 12876.5 12980.3 13009.7 13101.9 13204.9 11193.1 11264.9 12960.2 13087.7 13207.5 9682.2 9769.4 9793.6 10118.3 10254.7 10400.1 11242.3 11262.8 11335.2 11336.1 9303.4 9435.7 9502.8 9582.8 9610.8 8788.7 8803.1 8816.7 8865.5 9028.4 8419.4 8496.2 8547.7 8566.4 8582.2 6369.4 6479.9 6492.2 6493.3 6560.3 6275.4 6321.6 6369.2 6491.9 6577.8 13:05:03 INFO - PROCESS | 12316 | 13:05:03 INFO - PROCESS | 12316 | [#4] prototype.html Cycles:180 Average:4731.26 Median:5288.35 stddev:1248.67 (23.6%) stddev-sans-first:1209.64 13:05:03 INFO - PROCESS | 12316 | Values: 426.1 443.4 444.2 453.8 456.2 5276.2 5300.5 5303.8 5314.6 5347.1 5094.5 5133.8 5166.7 5217.3 5248.3 4224.5 4229.5 4230.2 4246.6 4274.9 4251.6 4253.8 4257.4 4260.5 4282.9 4169.4 4234.9 4257.5 4274.7 4315.6 4221.7 4242.5 4245.5 4268.9 4282.8 3887.4 3899.9 3919.9 3922.4 3928.2 5085.8 5109.3 5144.8 5152.7 5169.9 4677.3 4821.6 4848.8 4874.6 4911.9 5426.8 5430.0 5461.2 5474.2 5497.3 4290.7 4310.1 4316.2 4332.3 4336.5 5471.3 5674.8 5682.2 5690.5 5728.6 4396.4 4397.9 4398.7 4399.6 4422.2 4454.2 4468.0 4474.2 4501.0 4502.8 4728.3 4821.3 4826.4 4836.3 4846.0 5447.7 5469.5 5471.4 5488.6 5517.4 1671.8 1721.7 1753.4 1761.0 1771.5 1392.6 1410.7 1446.5 1453.2 1461.3 5314.3 5348.4 5384.5 5388.2 5400.5 5540.8 5561.6 5595.4 5624.5 5635.1 5170.4 5331.4 5336.9 5375.9 5446.3 2971.8 2979.7 2980.2 2984.0 2996.2 5794.9 5795.8 5798.5 5834.9 5844.5 5434.3 5545.0 5559.9 5697.5 5711.4 5649.8 5737.0 5752.8 5780.1 5788.5 5595.9 5612.9 5618.4 5626.9 5628.8 5123.6 5254.1 5459.1 5498.8 5537.3 5703.6 5711.0 5718.3 5736.9 5786.9 4720.5 4896.2 4922.9 4947.6 4951.0 5560.5 5571.3 5585.6 5593.4 5600.7 5405.5 5417.2 5482.3 5498.0 5513.2 5176.9 5418.3 5433.6 5433.9 5502.6 5424.7 5428.7 5474.8 5498.9 5525.4 5478.8 5488.8 5523.9 5537.9 5560.2 5073.3 5316.9 5362.5 5374.3 5381.7 13:05:03 INFO - PROCESS | 12316 | 13:05:03 INFO - PROCESS | 12316 | [#5] yui.html Cycles:180 Average:18661.50 Median:4941.42 stddev:22091.09 (447.1%) stddev-sans-first:22112.55 13:05:03 INFO - PROCESS | 12316 | Values: 845.8 864.0 900.5 914.8 935.0 17289.3 17669.2 17803.3 18050.5 19182.1 16893.8 16907.1 17013.7 17035.0 17171.0 899.2 923.1 923.6 923.7 923.8 887.6 912.9 925.2 926.1 926.7 971.7 972.8 972.8 975.0 975.3 963.4 967.0 967.1 967.4 967.5 708.4 708.7 708.7 708.7 708.8 18671.1 18686.8 18689.7 19628.3 19789.8 16043.6 16137.4 16200.6 16214.3 16539.0 12882.9 13866.4 14090.5 14179.3 14275.6 4915.2 4967.7 5046.0 5113.5 5228.8 78575.2 79476.6 81351.0 81660.6 82565.0 11834.6 11870.3 11874.9 11988.2 11992.2 22634.2 22742.8 23000.7 23011.5 23033.2 8692.6 8890.2 9093.2 9121.0 9161.7 5059.1 5119.5 5158.5 5178.7 5229.0 3542.7 3615.5 3624.9 3628.6 3630.4 632.6 633.9 637.2 650.0 653.4 619.3 621.2 629.1 636.2 649.4 10916.6 10997.5 11158.2 11345.7 11593.1 768.1 768.5 772.9 804.5 812.7 5329.3 5402.8 5516.3 5518.4 5526.2 68335.7 71011.6 73820.3 76970.0 83162.0 63957.0 64047.4 64055.4 68441.7 70656.6 58910.4 64760.4 65258.3 67662.3 70564.0 11337.5 11907.6 11977.8 12278.4 12279.6 46463.3 46897.0 47226.1 47603.8 47655.0 51822.0 52335.0 52488.0 52742.0 52946.2 15645.2 15957.9 16029.5 16278.2 16956.3 16925.6 17008.4 17407.0 17587.3 17981.3 15822.2 16045.9 16347.8 16713.7 17221.7 15924.2 15939.5 16348.4 16724.8 17244.9 14941.9 15014.2 15702.9 16435.1 16529.9 11396.5 11499.9 11796.9 12210.8 12245.3 13182.1 13210.8 13283.3 13305.3 13626.0 13:05:03 INFO - PROCESS | 12316 | -------- Summary: end -------- 13:05:03 INFO - PROCESS | 12316 | 13:05:03 INFO - TEST-INFO | 12316: exit 0 13:05:03 INFO - TEST-OK | dromaeo_css | took 1115733ms 13:05:03 INFO - TEST-START | kraken 13:05:03 INFO - operating with platform_type : linux_ 13:05:03 INFO - Initialising browser for kraken test... 13:05:03 INFO - TEST-INFO | started process 12618 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPY4hnN/profile http://localhost:59491/getInfo.html) 13:05:07 INFO - PROCESS | 12618 | __metrics Screen width/height:1600/1200 13:05:07 INFO - PROCESS | 12618 | colorDepth:24 13:05:07 INFO - PROCESS | 12618 | Browser inner width/height: 1024/697 13:05:07 INFO - PROCESS | 12618 | __metrics 13:05:08 INFO - PROCESS | 12618 | 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" 13:05:08 INFO - PROCESS | 12618 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:05:08 INFO - PROCESS | 12618 | console.error: PushService: 13:05:08 INFO - PROCESS | 12618 | stateChangeProcessEnqueue: Error transitioning state 13:05:08 INFO - PROCESS | 12618 | UnknownError 13:05:09 INFO - TEST-INFO | 12618: exit 0 13:05:09 INFO - Browser initialized. 13:05:09 INFO - Running cycle 1/1 for kraken test... 13:05:09 INFO - TEST-INFO | started process 12709 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPY4hnN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:05:21 INFO - PROCESS | 12709 | RSS: Main: 141762560 13:05:21 INFO - PROCESS | 12709 | 13:05:23 INFO - PROCESS | 12709 | Cycle 1(1): loaded http://localhost:59491/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59491/tests/kraken/driver.html?testName=audio-beat-detection) 13:05:24 INFO - PROCESS | 12709 | RSS: Main: 183939072 13:05:24 INFO - PROCESS | 12709 | 13:05:27 INFO - PROCESS | 12709 | Cycle 1(1): loaded http://localhost:59491/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59491/tests/kraken/driver.html?testName=audio-dft) 13:05:27 INFO - PROCESS | 12709 | RSS: Main: 173867008 13:05:27 INFO - PROCESS | 12709 | 13:05:30 INFO - PROCESS | 12709 | Cycle 1(1): loaded http://localhost:59491/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59491/tests/kraken/driver.html?testName=audio-fft) 13:05:31 INFO - PROCESS | 12709 | RSS: Main: 265318400 13:05:31 INFO - PROCESS | 12709 | 13:05:33 INFO - PROCESS | 12709 | Cycle 1(1): loaded http://localhost:59491/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59491/tests/kraken/driver.html?testName=audio-oscillator) 13:05:33 INFO - PROCESS | 12709 | RSS: Main: 171556864 13:05:33 INFO - PROCESS | 12709 | 13:05:35 INFO - PROCESS | 12709 | Cycle 1(1): loaded http://localhost:59491/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59491/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:05:36 INFO - PROCESS | 12709 | RSS: Main: 174133248 13:05:36 INFO - PROCESS | 12709 | 13:05:39 INFO - PROCESS | 12709 | Cycle 1(1): loaded http://localhost:59491/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59491/tests/kraken/driver.html?testName=imaging-darkroom) 13:05:39 INFO - PROCESS | 12709 | RSS: Main: 210104320 13:05:39 INFO - PROCESS | 12709 | 13:05:43 INFO - PROCESS | 12709 | Cycle 1(1): loaded http://localhost:59491/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59491/tests/kraken/driver.html?testName=imaging-desaturate) 13:05:43 INFO - PROCESS | 12709 | RSS: Main: 205008896 13:05:43 INFO - PROCESS | 12709 | 13:05:46 INFO - PROCESS | 12709 | Cycle 1(1): loaded http://localhost:59491/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59491/tests/kraken/driver.html?testName=json-parse-financial) 13:05:47 INFO - PROCESS | 12709 | RSS: Main: 208850944 13:05:47 INFO - PROCESS | 12709 | 13:05:48 INFO - PROCESS | 12709 | Cycle 1(1): loaded http://localhost:59491/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59491/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:05:49 INFO - PROCESS | 12709 | RSS: Main: 171626496 13:05:49 INFO - PROCESS | 12709 | 13:05:51 INFO - PROCESS | 12709 | Cycle 1(1): loaded http://localhost:59491/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59491/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:05:51 INFO - PROCESS | 12709 | RSS: Main: 178466816 13:05:51 INFO - PROCESS | 12709 | 13:05:53 INFO - PROCESS | 12709 | Cycle 1(1): loaded http://localhost:59491/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59491/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:05:54 INFO - PROCESS | 12709 | RSS: Main: 188809216 13:05:54 INFO - PROCESS | 12709 | 13:05:56 INFO - PROCESS | 12709 | Cycle 1(1): loaded http://localhost:59491/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59491/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:05:57 INFO - PROCESS | 12709 | RSS: Main: 197922816 13:05:57 INFO - PROCESS | 12709 | 13:06:00 INFO - PROCESS | 12709 | Cycle 1(1): loaded http://localhost:59491/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59491/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:06:00 INFO - PROCESS | 12709 | RSS: Main: 194154496 13:06:00 INFO - PROCESS | 12709 | 13:06:02 INFO - PROCESS | 12709 | Cycle 1(1): loaded http://localhost:59491/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59491/tests/kraken/driver.html?testName=ai-astar) 13:06:02 INFO - PROCESS | 12709 | RSS: Main: 244740096 13:06:02 INFO - PROCESS | 12709 | 13:06:02 INFO - PROCESS | 12709 | __start_tp_report 13:06:02 INFO - PROCESS | 12709 | _x_x_mozilla_page_load 13:06:02 INFO - PROCESS | 12709 | _x_x_mozilla_page_load_details 13:06:02 INFO - PROCESS | 12709 | |i|pagename|runs| 13:06:02 INFO - PROCESS | 12709 | |0;ai-astar;101;111;111;110;111;112;111;111;111;111 13:06:02 INFO - PROCESS | 12709 | |1;audio-beat-detection;137;114;115;162;117;120;117;116;141;115 13:06:02 INFO - PROCESS | 12709 | |2;audio-dft;159;159;161;160;163;160;164;159;161;161 13:06:02 INFO - PROCESS | 12709 | |3;audio-fft;75;74;75;105;75;75;75;75;93;74 13:06:02 INFO - PROCESS | 12709 | |4;audio-oscillator;82;83;109;81;82;81;109;82;81;116 13:06:02 INFO - PROCESS | 12709 | |5;imaging-gaussian-blur;113;112;112;113;113;112;112;113;112;112 13:06:02 INFO - PROCESS | 12709 | |6;imaging-darkroom;148;146;146;146;146;146;146;146;146;145 13:06:02 INFO - PROCESS | 12709 | |7;imaging-desaturate;93;94;94;94;93;94;94;94;94;94 13:06:02 INFO - PROCESS | 12709 | |8;json-parse-financial;57;54;55;53;56;54;58;56;55;55 13:06:02 INFO - PROCESS | 12709 | |9;json-stringify-tinderbox;53;53;54;53;53;53;53;52;53;53 13:06:02 INFO - PROCESS | 12709 | |10;stanford-crypto-aes;77;76;77;79;80;77;80;80;78;78 13:06:02 INFO - PROCESS | 12709 | |11;stanford-crypto-ccm;119;122;130;125;118;118;118;117;162;115 13:06:02 INFO - PROCESS | 12709 | |12;stanford-crypto-pbkdf2;162;155;156;160;162;157;159;159;162;168 13:06:02 INFO - PROCESS | 12709 | |13;stanford-crypto-sha256-iterative;60;63;61;62;58;58;62;61;63;56 13:06:02 INFO - PROCESS | 12709 | __end_tp_report 13:06:02 INFO - PROCESS | 12709 | __start_cc_report 13:06:02 INFO - PROCESS | 12709 | _x_x_mozilla_cycle_collect,1683 13:06:02 INFO - PROCESS | 12709 | __end_cc_report 13:06:02 INFO - PROCESS | 12709 | __startTimestamp1495224362676__endTimestamp 13:06:02 INFO - PROCESS | 12709 | 13:06:02 INFO - PROCESS | 12709 | ------- Summary: start ------- 13:06:02 INFO - PROCESS | 12709 | Number of tests: 14 13:06:02 INFO - PROCESS | 12709 | 13:06:02 INFO - PROCESS | 12709 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:3.20 (2.9%) stddev-sans-first:0.50 13:06:02 INFO - PROCESS | 12709 | Values: 101.0 111.0 111.0 110.0 111.0 112.0 111.0 111.0 111.0 111.0 13:06:02 INFO - PROCESS | 12709 | 13:06:02 INFO - PROCESS | 12709 | [#1] audio-beat-detection Cycles:10 Average:125.40 Median:118.50 stddev:16.06 (13.6%) stddev-sans-first:16.48 13:06:02 INFO - PROCESS | 12709 | Values: 137.0 114.0 115.0 162.0 117.0 120.0 117.0 116.0 141.0 115.0 13:06:02 INFO - PROCESS | 12709 | 13:06:02 INFO - PROCESS | 12709 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.70 (1.1%) stddev-sans-first:1.69 13:06:02 INFO - PROCESS | 12709 | Values: 159.0 159.0 161.0 160.0 163.0 160.0 164.0 159.0 161.0 161.0 13:06:02 INFO - PROCESS | 12709 | 13:06:02 INFO - PROCESS | 12709 | [#3] audio-fft Cycles:10 Average:79.60 Median:75.00 stddev:10.62 (14.2%) stddev-sans-first:11.13 13:06:02 INFO - PROCESS | 12709 | Values: 75.0 74.0 75.0 105.0 75.0 75.0 75.0 75.0 93.0 74.0 13:06:02 INFO - PROCESS | 12709 | 13:06:02 INFO - PROCESS | 12709 | [#4] audio-oscillator Cycles:10 Average:90.60 Median:81.50 stddev:14.45 (17.7%) stddev-sans-first:14.98 13:06:02 INFO - PROCESS | 12709 | Values: 82.0 83.0 109.0 81.0 82.0 81.0 109.0 82.0 81.0 116.0 13:06:02 INFO - PROCESS | 12709 | 13:06:02 INFO - PROCESS | 12709 | [#5] imaging-gaussian-blur Cycles:10 Average:112.40 Median:112.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 13:06:02 INFO - PROCESS | 12709 | Values: 113.0 112.0 112.0 113.0 113.0 112.0 112.0 113.0 112.0 112.0 13:06:02 INFO - PROCESS | 12709 | 13:06:02 INFO - PROCESS | 12709 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.33 13:06:02 INFO - PROCESS | 12709 | Values: 148.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 13:06:02 INFO - PROCESS | 12709 | 13:06:02 INFO - PROCESS | 12709 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 13:06:02 INFO - PROCESS | 12709 | Values: 93.0 94.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 94.0 13:06:02 INFO - PROCESS | 12709 | 13:06:02 INFO - PROCESS | 12709 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.50 stddev:1.49 (2.7%) stddev-sans-first:1.45 13:06:02 INFO - PROCESS | 12709 | Values: 57.0 54.0 55.0 53.0 56.0 54.0 58.0 56.0 55.0 55.0 13:06:02 INFO - PROCESS | 12709 | 13:06:02 INFO - PROCESS | 12709 | [#9] json-stringify-tinderbox Cycles:10 Average:53.00 Median:53.00 stddev:0.47 (0.9%) stddev-sans-first:0.50 13:06:02 INFO - PROCESS | 12709 | Values: 53.0 53.0 54.0 53.0 53.0 53.0 53.0 52.0 53.0 53.0 13:06:02 INFO - PROCESS | 12709 | 13:06:02 INFO - PROCESS | 12709 | [#10] stanford-crypto-aes Cycles:10 Average:78.20 Median:78.50 stddev:1.48 (1.9%) stddev-sans-first:1.50 13:06:02 INFO - PROCESS | 12709 | Values: 77.0 76.0 77.0 79.0 80.0 77.0 80.0 80.0 78.0 78.0 13:06:02 INFO - PROCESS | 12709 | 13:06:02 INFO - PROCESS | 12709 | [#11] stanford-crypto-ccm Cycles:10 Average:124.40 Median:120.50 stddev:13.93 (11.6%) stddev-sans-first:14.64 13:06:02 INFO - PROCESS | 12709 | Values: 119.0 122.0 130.0 125.0 118.0 118.0 118.0 117.0 162.0 115.0 13:06:02 INFO - PROCESS | 12709 | 13:06:02 INFO - PROCESS | 12709 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.00 Median:161.00 stddev:3.77 (2.3%) stddev-sans-first:3.93 13:06:02 INFO - PROCESS | 12709 | Values: 162.0 155.0 156.0 160.0 162.0 157.0 159.0 159.0 162.0 168.0 13:06:02 INFO - PROCESS | 12709 | 13:06:02 INFO - PROCESS | 12709 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.40 Median:61.50 stddev:2.37 (3.8%) stddev-sans-first:2.51 13:06:02 INFO - PROCESS | 12709 | Values: 60.0 63.0 61.0 62.0 58.0 58.0 62.0 61.0 63.0 56.0 13:06:02 INFO - PROCESS | 12709 | -------- Summary: end -------- 13:06:02 INFO - PROCESS | 12709 | 13:06:03 INFO - TEST-INFO | 12709: exit 0 13:06:03 INFO - TEST-OK | kraken | took 59911ms 13:06:03 INFO - SUITE-END | took 1175s 13:06:03 INFO - Completed test suite (00:19:35) 13:06:03 INFO - javascript benchmark 13:06:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7985.992508403193, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3339.5825521809775, 3371.140359208402, 3376.645452227516, 3395.151212196951, 3411.8635254589803, 5780.364159942403, 5791.681457519835, 5844.590878638497, 5855.590108692393, 5871.148683440899, 5847.532197424206, 5896.380880007602, 5906.173135760997, 5906.557008224389, 5919.082542205954, 5290.418054014055, 5322.574194064485, 5343.812966546172, 5383.380911195223, 5397.919031214535, 5153.845384638467, 5181.870453238662, 5415.864603384907, 5421.701806400646, 5426.348838139429, 5256.132738098209, 5286.947130528703, 5299.205119232108, 5315.681059136445, 5336.412994570614, 5353.491418315254, 5366.114591092484, 5374.7043912584795, 5376.166694162392, 5377.677339359612, 5060.51925067118, 5211.869703257411, 5250.763715632767, 5311.0, 5315.521603055744, 5628.746706398222, 5662.433756624346, 5723.255976723041, 5734.512566431858, 5737.655740655574, 6215.1609532712955, 6226.128342032119, 6240.531960102965, 6242.09489624002, 6253.062040693887, 6304.87390252197, 6306.810795676091, 6310.7791227306825, 6312.652804095773, 6315.842103947392, 5614.859628509279, 5642.4357564243655, 5757.683327417032, 5794.913076303858, 5860.296764388258, 6355.491560675135, 6357.4914006879335, 6359.077933699587, 6363.395477429637, 6372.6495042773095, 6083.8174854754425, 6126.23422072241, 6135.141080248769, 6136.969315153396, 6137.631742095488, 6013.248343957005, 6040.7583696651645, 6127.9837278401355, 6178.505719542426, 6238.844028899314, 6195.2255968004, 6220.03589443637, 6223.595466294676, 6233.2208473940755, 6243.843903902439, 5948.67282299469, 5989.880202396015, 5999.460048595647, 6109.131392049051, 6111.35830737775, 4723.551262630044, 4752.477227504972, 4781.450133234653, 4791.281307803857, 4795.784189711471, 4240.787960601958, 4247.447831781848, 4261.083866968616, 4270.444842170498, 4289.742615443083, 5801.129830525455, 5850.94149058504, 5892.086726557391, 5935.347111817697, 6025.578209525291, 6234.251889773256, 6244.438000579969, 6245.219347581552, 6245.437910588069, 6252.187215661935, 5985.910211346833, 5988.131720900445, 5989.940100599026, 5990.880182396328, 6034.879302413927, 5133.332666753373, 5170.353705786777, 5257.395399529103, 5284.656497327738, 5306.52241298285, 6455.7740479083, 6494.188226471691, 6496.480281577463, 6501.0248462731915, 6507.251666058464, 6240.0, 6299.338569450325, 6316.778912738032, 6320.083587879823, 6320.178376810985, 6222.377762223922, 6248.937510624835, 6315.652639104709, 6524.902126468011, 6535.986922027093, 6122.794608434163, 6132.0495871890025, 6137.714085983886, 6138.725610151984, 6139.4781443577795, 6230.532710046674, 6234.657093859882, 6236.968815155895, 6238.344973777869, 6239.844003899939, 5822.155787410887, 5879.970600146972, 6020.307664618625, 6072.028475443908, 6082.787102451393, 6057.545684073801, 6087.299960504599, 6111.95640283616, 6153.907691384543, 6155.446009858955, 6120.142398366865, 6126.805272971727, 6128.503123582109, 6132.99804414626, 6134.1610691366095, 5941.58408911372, 5974.103884417372, 5975.282966044103, 6089.969550152398, 6127.119784992317, 6024.548158888013, 6028.1861948638125, 6054.576179667557, 6074.3014553325165, 6075.0], "value": 5735.676434172138, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [775.3603277296232, 845.0324378586517, 862.3015357560377, 918.4030380252839, 922.3220932614523, 30754.692453075462, 44980.77509612451, 45639.0, 45684.77157614207, 45759.31361029583, 38057.429138562875, 38412.0, 38549.0, 38628.42057369135, 38644.0, 7775.922240777605, 7914.445988780759, 9259.16667499925, 9381.0, 9388.577514011851, 10760.78478430431, 10921.672349829518, 10984.0, 10987.560497580087, 10988.230823842334, 11054.392008439532, 11130.38782866942, 11139.275947063416, 11144.554217831277, 11149.944250278737, 10992.450377481135, 11022.338659680445, 11031.22781405302, 11033.668989930275, 11038.503267352948, 10734.355938643628, 10746.0, 10766.73083172927, 10782.245242833005, 10788.190885683605, 43614.12771744547, 43716.562834371565, 43855.0, 43910.56089439129, 43921.0, 3728.6271372862766, 3783.0, 3783.697304215656, 3788.3749181385037, 3882.5729169791302, 30820.2294942626, 30880.0, 30947.690523094705, 31148.844255778575, 31421.214469638213, 4357.193919124972, 4368.759718215497, 4416.939934415749, 4512.390827238347, 4552.1350943320995, 249046.0, 249295.0, 249908.9999999982, 250220.0, 250319.0, 45278.32082518765, 45821.0, 45993.31010034852, 45999.31001034987, 46043.539564604594, 49119.0, 49165.75417122892, 49205.75397122991, 49244.75377623089, 49318.26022609664, 15849.841501585068, 16145.515634530982, 16194.190290485663, 16196.352145914032, 16198.59503512398, 12120.696982575506, 12153.210041347284, 13952.930235348758, 14020.579382618538, 14036.087654302437, 13393.799093013613, 13462.596122116352, 13491.527796527074, 13544.59366219015, 13601.047926645238, 5658.122990936411, 5668.433156684381, 5670.603057785916, 5686.289213848269, 5708.0, 1007.7480629842539, 1010.4038617215878, 1021.2085633633993, 1030.9793804123876, 1042.3797840285017, 29923.850380747957, 29934.850325748666, 30150.246243844078, 30289.697103029128, 30585.388292234475, 1068.8770791358938, 1097.1168209591356, 1099.4118146791427, 1103.7406209540752, 1128.7798879218637, 15370.0, 16181.271842767104, 16712.41506547265, 17333.913330433268, 17477.38829140974, 333216.0, 333373.0, 333881.0, 334093.0, 334907.0, 53561.73219133957, 53873.0, 53883.19175212375, 53963.730181348845, 54053.72973135109, 1513.583764464759, 1522.0, 1587.0874247307613, 1617.5551723276194, 1621.7405215165518, 30521.389572207987, 33023.339533208724, 33774.49338259879, 33949.321013580084, 34720.479192812636, 46551.30173047475, 46733.532664672915, 46766.76616616895, 46848.297275540215, 47008.52991470179, 322578.0, 324060.0, 324438.0, 326617.0, 329655.0, 39712.80143599264, 40420.595794041685, 40471.59528404678, 40496.3925541123, 40579.0, 48131.0, 48272.27591586059, 48382.5161748378, 48398.27402589034, 48462.27306590333, 35609.28781424409, 36321.27357452783, 36403.0, 36620.81689591535, 37085.0, 36038.639613603526, 36189.27621447609, 36559.45160822537, 36685.0, 36831.8158409217, 41326.1734765309, 41908.58091419169, 41950.37074443947, 41958.790206048776, 42174.578254217064, 35550.64449355473, 35590.8220458896, 35922.64077359193, 36067.27865442729, 36098.0, 27221.31946701269, 27859.86070069637, 28358.432831342845, 28386.858065710367, 28425.28936776597], "value": 19600.53500135822, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [464.664090739125, 484.6946423753036, 485.12919309838855, 487.91705410080283, 502.78129013878953, 20231.39305820824, 21621.891890540566, 21904.342869713895, 22449.32652020438, 22648.207312744056, 21979.780202197973, 21986.670199946973, 22550.097996080138, 22624.547509049808, 22904.0, 6655.567388119781, 6873.725050997967, 6899.37905588497, 6937.410320122771, 6944.826379340531, 6848.075509806187, 6942.444604431634, 7300.379467745248, 7596.772096837104, 7606.353459955911, 7507.286807753255, 7750.108737495176, 7766.766996990099, 7768.951191589148, 7773.805654858617, 7764.689412423496, 7825.37397008238, 7857.567833769141, 7901.328387087105, 7907.2488113629115, 7615.46691731579, 7725.381969442431, 7759.650815713307, 7761.72833950809, 7769.067711874612, 25494.617580736303, 26407.0, 26442.6033609496, 26795.59806602883, 27044.0, 3047.43622429849, 3146.858391372371, 3228.1606782236554, 3593.8562457501666, 3616.18635806944, 18590.0, 18825.811741882542, 19514.12186451599, 19516.70724939127, 19605.411837644893, 2439.865807380593, 2479.566075936704, 2511.259178542316, 2572.704139023999, 2587.275562842407, 115113.0, 116842.0, 117514.0, 118063.40968295104, 125851.0, 20996.265130720352, 21651.0, 21673.566528669337, 22000.229991950204, 22225.333240002827, 43635.563644363785, 43757.78121109374, 43770.12459750787, 43773.34339984903, 43775.78112109483, 10283.9485802572, 10774.138068954464, 10931.672049838518, 10958.452077396258, 11065.50205240766, 8989.55052247385, 9118.86321705175, 9145.176934075966, 9195.448273103502, 9324.440533568008, 9340.486273255035, 9461.337706360626, 9534.761630959281, 9556.0, 9557.904420955701, 3338.8831390901687, 3713.5729391119826, 3750.7374483785875, 3860.864869729602, 3911.8630847920185, 976.1312431935582, 981.9803603927882, 982.3663736889808, 1000.6547741029333, 1011.9645812396531, 21426.464338391666, 21754.676015377616, 21783.67324490134, 21882.0, 21913.780862191492, 996.6960077176531, 1000.9599616015278, 1007.6322142417964, 1014.832552628808, 1021.3871676993892, 11074.778504429867, 11537.48081336342, 11985.940070299766, 11986.820197697041, 12040.096992725405, 612610.0, 612621.0, 614053.0, 617990.0, 628235.0, 115470.4226478879, 118015.0, 119477.40261298638, 120064.7993520071, 121097.0, 1272.3129510064646, 1275.2348590845418, 1288.2077522323702, 1290.9806352904902, 1307.9476820927246, 18425.170867310735, 18625.627487449903, 18731.250749969848, 19053.902091611286, 19414.805851941866, 52451.0, 52714.0, 53433.7328313356, 53510.73244633752, 53574.196387053446, 68092.31907681059, 68151.65924170546, 68770.08530053482, 69778.65110674415, 70283.0, 12150.21023633461, 12161.39193040362, 12217.14479986428, 12279.815802763145, 12296.0, 13352.332383380986, 13532.59402217935, 13603.183808971493, 13622.591322259952, 14004.929975350058, 11961.401929903644, 12182.269063855843, 12194.268343899394, 12212.75574488523, 12240.469941257343, 10507.054365107177, 10581.4709264538, 10673.57305707763, 10712.3572585642, 10830.837537437103, 12173.0, 12356.752864942831, 12431.0, 12439.315837629018, 12778.169418988107, 11993.880061199276, 12174.526030470743, 12269.263844169378, 12464.0, 12481.126321157795, 12124.151309408257, 12211.633650990485, 12244.510219591117, 12533.87466125327, 12810.935945320214], "value": 11959.822568774245, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1453.5493996860966, 1592.6257329527566, 1600.9039457632543, 1605.044998226055, 1617.0782653887286, 9186.954065229673, 11213.719657008569, 11476.967072963442, 11491.540338386476, 11510.884891151087, 11646.0, 11705.70735731607, 11710.0, 11712.882871171285, 11732.413379331041, 1990.93031743889, 2062.5668609592003, 2478.566250906093, 2493.763092506209, 2520.2565243253193, 2302.735185453669, 2358.5872472317274, 2360.1975328388344, 2360.7639236076425, 2367.633016882386, 2459.631055341695, 2471.5551200783943, 2473.4063824682034, 2474.5669507836146, 2482.863442510661, 2385.439421735891, 2401.147592604618, 2403.807695384365, 2406.38637147528, 2407.1214006887535, 2241.551689662058, 2251.763564825686, 2255.458689914425, 2258.367657056027, 2346.894389752465, 11456.71358216043, 11529.192956493049, 11532.077433805276, 11538.711532211679, 11554.94222528882, 5856.590038697293, 6001.549883758736, 6022.69886505673, 6027.126066720301, 6028.457438830483, 3391.728661707082, 3463.8960831175104, 3646.398344273192, 3662.4689420033947, 3687.502187204747, 1259.3010878962173, 1302.4008955880306, 1369.3632460905626, 1417.9220142892136, 1439.172475826404, 16787.244573994078, 16793.99236045841, 16801.411950581794, 16823.49529514104, 16849.241784119746, 4881.121398148367, 4990.351254336913, 5041.445441001487, 5050.595952323805, 5095.592352611782, 13224.206547607175, 13295.401706923212, 13318.667033324244, 13344.0, 13345.065845390729, 6067.817965461043, 6080.391960803884, 6084.148219249309, 6087.6956152192215, 6091.756329746849, 5384.219288203267, 5488.4785945335125, 5578.63738856973, 5589.385167631557, 5654.208410822488, 3952.486176796998, 4045.6763458923215, 4049.4330793688905, 4083.7549747015273, 4107.301758701028, 1025.4308858583408, 1030.644427672452, 1045.1116550931647, 1046.283295942282, 1049.9370037797758, 1048.554364395129, 1067.5996501312009, 1076.5263284154946, 1078.1428764132534, 1085.934843909368, 7389.852202955911, 7550.169481357047, 7597.354224890946, 7651.770446886602, 7751.496152750166, 1084.967450976472, 1095.6274866545414, 1115.8382034604938, 1143.2625956258166, 1169.0, 4737.881552961204, 4804.663673542888, 4860.513948605111, 4994.725290109079, 5128.307678463434, 14689.265536723122, 15018.249087545579, 15123.848761512245, 15308.923455382874, 15346.232688365537, 14832.184229867245, 15172.165530895907, 15281.694366112615, 15365.539033829004, 15366.84633153654, 10078.0, 10218.642347517949, 10330.070293673456, 10780.191485638608, 10899.237053406185, 7166.104236970379, 7372.815679608053, 7383.815404614713, 7389.445791565547, 7467.887981680171, 12876.549320773727, 12980.286084265455, 13009.739805204032, 13101.934490327869, 13204.933975330061, 11193.104551635686, 11264.94367528157, 12960.222386656831, 13087.672808179872, 13207.537736179187, 9682.225421966084, 9769.364991275545, 9793.608255669693, 10118.342307749972, 10254.692359229235, 10400.115990140923, 11242.325460472397, 11262.831057534308, 11335.206535542433, 11336.093112551142, 9303.395279307095, 9435.669751558937, 9502.809943800947, 9582.808343833223, 9610.807783844424, 8788.736337909873, 8803.119688031145, 8816.691415800417, 8865.468071915706, 9028.36801423894, 8419.36854735885, 8496.235338819535, 8547.700830470903, 8566.357523185661, 8582.227599516074, 6369.394907483782, 6479.935200647933, 6492.156019717407, 6493.253275873146, 6560.3111673273615, 6275.3724627536885, 6321.620702757666, 6369.20384951881, 6491.870162596816, 6577.80266592003], "value": 5452.230460318562, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [426.1073051956151, 443.43904960225314, 444.2314795403951, 453.80032785574343, 456.2016471175443, 5276.2036120855955, 5300.496452836984, 5303.840884773458, 5314.601404894634, 5347.144456886899, 5094.46508116648, 5133.845984620458, 5166.664166829153, 5217.252220506135, 5248.265242866002, 4224.549761138547, 4229.471316085489, 4230.19626271009, 4246.575342465744, 4274.935875961863, 4251.553586873365, 4253.80857861397, 4257.425247591582, 4260.510041345238, 4282.935755963663, 4169.353750168729, 4234.9364759528635, 4257.467816522934, 4274.679399045069, 4315.575859966204, 4221.691275704526, 4242.493914660313, 4245.490541135053, 4268.935965960513, 4282.807273672676, 3887.3974533947003, 3899.902502437433, 3919.902002449933, 3922.391609579626, 3928.2339943710986, 5085.821996230151, 5109.335786347789, 5144.768485418165, 5152.716600586966, 5169.948300517022, 4677.263800676608, 4821.566059054702, 4848.8302909398, 4874.634402419797, 4911.901761964741, 5426.810061647863, 5430.018043414126, 5461.208124821878, 5474.178873169017, 5497.312835895513, 4290.742555446684, 4310.1379724055005, 4316.2446571849805, 4332.328489084197, 4336.544662810423, 5471.346396997453, 5674.801381951612, 5682.2044913712525, 5690.5447564194765, 5728.62763920348, 4396.406485124531, 4397.890052748707, 4398.670099742532, 4399.62603178727, 4422.204003279377, 4454.175977444183, 4467.977660111678, 4474.239379305526, 4501.01955139744, 4502.829264391216, 4728.338032675429, 4821.349117869113, 4826.444958829779, 4836.250381190921, 4846.0, 5447.700376479332, 5469.5232287282215, 5471.440639417747, 5488.56091512678, 5517.420670829585, 1671.7910261217348, 1721.7345251240329, 1753.3863147898135, 1760.9647807043787, 1771.4508502364308, 1392.5891861900764, 1410.6684929041667, 1446.4720377062297, 1453.2152637575803, 1461.3131828040803, 5314.28257185275, 5348.406023078804, 5384.542313903362, 5388.245645609618, 5400.459954004568, 5540.833774986757, 5561.610687251934, 5595.38450770415, 5624.493795558419, 5635.139929148547, 5170.431252562215, 5331.360236771535, 5336.893262134736, 5375.865603359869, 5446.346438427414, 2971.7667168124985, 2979.6722360540325, 2980.210244285266, 2983.9850800745858, 2996.161074899032, 5794.855128621818, 5795.797147099831, 5798.507126894261, 5834.912476312858, 5844.503217226498, 5434.2935418395355, 5544.974179776754, 5559.916601250984, 5697.544196464273, 5711.429856564562, 5649.7852961612625, 5737.0, 5752.798652047159, 5780.075187969905, 5788.5369170466265, 5595.860103497445, 5612.887742245214, 5618.410066942912, 5626.943730562805, 5628.802991895264, 5123.590112790893, 5254.13306804373, 5459.12653975362, 5498.780048798003, 5537.2524709165355, 5703.572232082527, 5710.971445142748, 5718.256626638677, 5736.856578585402, 5786.855328616818, 4720.480747117883, 4896.192128298933, 4922.852314430573, 4947.604191664586, 4950.975245123751, 5560.471755183413, 5571.303587051619, 5585.5531557476115, 5593.384727679871, 5600.691961942132, 5405.5135037846785, 5417.214503896992, 5482.29944787275, 5498.031063225973, 5513.2005859151, 5176.948230517647, 5418.295621569171, 5433.565314774887, 5433.891322173614, 5502.642328248651, 5424.728763561727, 5428.67427954324, 5474.781008759605, 5498.945010549844, 5525.4474552544425, 5478.780848766164, 5488.780448782164, 5523.944760552343, 5537.944620553743, 5560.221568980265, 5073.264376665436, 5316.893662126813, 5362.51737343641, 5374.253367655449, 5381.67709937405], "value": 4387.862931569753, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [845.8477474054675, 863.9956800215998, 900.5182227508283, 914.7895983923696, 934.9953250233748, 17289.308427662894, 17669.20488578014, 17803.287868485244, 18050.5487362816, 19182.13680384384, 16893.83106168941, 16907.070111143883, 17013.659726805457, 17035.0, 17170.9697418155, 899.1682693508495, 923.0815338737932, 923.5613083785215, 923.6536298887917, 923.7921467669788, 887.5917078144029, 912.9315301352392, 925.2089463508704, 926.1433174313732, 926.7451450851037, 971.6939164163301, 972.8248915195262, 972.8346181149221, 975.0103644800533, 975.2831668723483, 963.4026903319916, 967.0088159636358, 967.086103632068, 967.4050458967755, 967.5162418790604, 708.3624737736027, 708.6669265445232, 708.7200555780489, 708.7377670262036, 708.8086216721508, 18671.06644667761, 18686.813131868643, 18689.719654205197, 19628.313009044614, 19789.802101979083, 16043.598910027225, 16137.43518976842, 16200.594985125348, 16214.270357833926, 16539.007659540464, 12882.904953079, 13866.4453421863, 14090.506832260822, 14179.29103544829, 14275.571732848031, 4915.164422048225, 4967.677100988424, 5046.0, 5113.514216149497, 5228.764705588258, 78575.21424785737, 79476.60261698712, 81351.0, 81660.59169704113, 82565.0, 11834.585789497327, 11870.287782733063, 11874.881251187378, 11988.160828741904, 11992.220505667105, 22634.207802726825, 22742.772572274396, 23000.65499017516, 23011.539769204523, 23033.193838215582, 8692.565371731389, 8890.199882010651, 9093.181613654802, 9120.954395227982, 9161.725148245563, 5059.114654935372, 5119.539241468286, 5158.535731784157, 5178.689278643218, 5228.9738551307, 3542.6988705959766, 3615.4757560154158, 3624.909377265537, 3628.63713628635, 3630.3828349180703, 632.6425569553188, 633.9080833279148, 637.1589501857596, 649.9707513161919, 653.4380432827764, 619.3465893482419, 621.18314416543, 629.0626965820894, 636.2301615045847, 649.4252586461016, 10916.56333746657, 10997.450127493594, 11158.218924675357, 11345.716357090974, 11593.130515211393, 768.0783060327518, 768.4812751392899, 772.9188435214334, 804.5373910001655, 812.6586833529932, 5329.333833270841, 5402.837914862561, 5516.338039435213, 5518.365387980433, 5526.226328314039, 68335.65832170808, 71011.64494177495, 73820.26179738241, 76970.0, 83162.0, 63957.0, 64047.359526405075, 64055.35944640587, 68441.65779171072, 70656.64671676609, 58910.41089589049, 64760.352396475435, 65258.34741652618, 67662.30844228933, 70564.0, 11337.546498140311, 11907.583234586747, 11977.760444791229, 12278.386080696107, 12279.570215042431, 46463.30305045359, 46897.0, 47226.055478890914, 47603.76198118987, 47655.0, 51822.0, 52335.0, 52488.0, 52742.0, 52946.205806912156, 15645.217739113226, 15957.920210398874, 16029.519114426586, 16278.186090695655, 16956.321747129976, 16925.576860578585, 17008.404705835732, 17407.042612656427, 17587.29650813953, 17981.280748770427, 15822.208889555706, 16045.919770401073, 16347.754783678016, 16713.74929376036, 17221.655566888843, 15924.203789810696, 15939.545495302355, 16348.427805026768, 16724.832751672813, 17244.913775431545, 14941.879359047898, 15014.174220417983, 15702.9214853925, 16435.09606971628, 16529.917350413172, 11396.48715807774, 11499.885001149882, 11796.94101529487, 12210.755784884075, 12245.326507042199, 13182.143160694524, 13210.80183797263, 13283.335833208494, 13305.268210248529, 13626.0], "value": 8063.590270521516, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1449.9000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 111.0, 110.0, 111.0, 112.0, 111.0, 111.0, 111.0, 111.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 114.0, 115.0, 162.0, 117.0, 120.0, 117.0, 116.0, 141.0, 115.0], "value": 125.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 161.0, 160.0, 163.0, 160.0, 164.0, 159.0, 161.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 105.0, 75.0, 75.0, 75.0, 75.0, 93.0, 74.0], "value": 79.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 109.0, 81.0, 82.0, 81.0, 109.0, 82.0, 81.0, 116.0], "value": 90.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 112.0, 113.0, 113.0, 112.0, 112.0, 113.0, 112.0, 112.0], "value": 112.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 55.0, 53.0, 56.0, 54.0, 58.0, 56.0, 55.0, 55.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 53.0, 53.0, 53.0, 53.0, 52.0, 53.0, 53.0], "value": 53.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 79.0, 80.0, 77.0, 80.0, 80.0, 78.0, 78.0], "value": 78.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 122.0, 130.0, 125.0, 118.0, 118.0, 118.0, 117.0, 162.0, 115.0], "value": 124.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 155.0, 156.0, 160.0, 162.0, 157.0, 159.0, 159.0, 162.0, 168.0], "value": 160.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 63.0, 61.0, 62.0, 58.0, 58.0, 62.0, 61.0, 63.0, 56.0], "value": 60.4, "unit": "score"}]}]} 13:06:03 INFO - Return code: 0 13:06:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:06:03 INFO - # TBPL SUCCESS # 13:06:03 INFO - Running post-action listener: _resource_record_post_action 13:06:03 INFO - [mozharness: 2017-05-19 20:06:03.996983Z] Finished run-tests step (success) 13:06:03 INFO - Running post-run listener: _resource_record_post_run 13:06:04 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 311296; Write bytes: 328269824; Read time: 36; Write time: 173180 13:06:04 INFO - TinderboxPrint: CPU usage
13.1% 13:06:04 INFO - TinderboxPrint: I/O read bytes / time
311,296 / 36 13:06:04 INFO - TinderboxPrint: I/O write bytes / time
328,269,824 / 173,180 13:06:04 INFO - TinderboxPrint: CPU idle
8,252.4 (86.9%) 13:06:04 INFO - TinderboxPrint: CPU user
1,200.3 (12.6%) 13:06:04 INFO - TinderboxPrint: Swap in / out
0 / 0 13:06:04 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 78831616; Read time: 0; Write time: 38880 13:06:04 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 307200; Write bytes: 228835328; Read time: 24; Write time: 100164 13:06:04 INFO - Running post-run listener: _upload_blobber_files 13:06:04 INFO - Blob upload gear active. 13:06:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:06:04 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 13:06:04 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'] 13:06:04 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 13:06:05 INFO - (blobuploader) - INFO - Open directory for files ... 13:06:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:06:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:06:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:06:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:06:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:06:05 INFO - (blobuploader) - INFO - Done attempting. 13:06:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:06:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:06:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:06:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:06:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:06:06 INFO - (blobuploader) - INFO - Done attempting. 13:06:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:06:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:06:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:06:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:06:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:06:14 INFO - (blobuploader) - INFO - Done attempting. 13:06:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:06:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:06:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:06:15 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:06:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:06:15 INFO - (blobuploader) - INFO - Done attempting. 13:06:15 INFO - (blobuploader) - INFO - Iteration through files over. 13:06:15 INFO - Return code: 0 13:06:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:06:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:06:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/49d973cb016255271c7b9ebd34570cd648ba60839a7959145a0d32a3473c7fea6804e457326d85ae130b04730b25c09d10cc267a43df056ce9b24b1260ecc775", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1b074e25250a28e4dccd01f02ce4d9ace78259833452c170681fb6117b2fe9dc6d6856807106abed0880095330f4179e5dbb1588d38c162d1cb219acaafe27f2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/53f8f6c4c31273a1e8080e6e688db8b75a53e5f62137db17b6b3c6c6ac0904e09e4368529d06b24b8776de62f6992f3fa46c0519ab1e147d01b408f4307d4899", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/256a581df49448857f3eef83bb183c03386e0e508e0e5bcc5277ffef9312a3496d9389d1df3459226872fd40fd47c39fc4e3dcbe3337c51ded7ebd17fff68ef3"} 13:06:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:06:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:06:15 INFO - Contents: 13:06:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/49d973cb016255271c7b9ebd34570cd648ba60839a7959145a0d32a3473c7fea6804e457326d85ae130b04730b25c09d10cc267a43df056ce9b24b1260ecc775", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1b074e25250a28e4dccd01f02ce4d9ace78259833452c170681fb6117b2fe9dc6d6856807106abed0880095330f4179e5dbb1588d38c162d1cb219acaafe27f2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/53f8f6c4c31273a1e8080e6e688db8b75a53e5f62137db17b6b3c6c6ac0904e09e4368529d06b24b8776de62f6992f3fa46c0519ab1e147d01b408f4307d4899", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/256a581df49448857f3eef83bb183c03386e0e508e0e5bcc5277ffef9312a3496d9389d1df3459226872fd40fd47c39fc4e3dcbe3337c51ded7ebd17fff68ef3"} 13:06:15 INFO - Running post-run listener: copy_logs_to_upload_dir 13:06:15 INFO - Copying logs to upload dir... 13:06:15 INFO - mkdir: /builds/slave/test/build/upload/logs 13:06:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.629629 ========= master_lag: -0.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-05-19 13:06:15.136663) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-19 13:06:15.141014) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1495220490.276601-405361073 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/49d973cb016255271c7b9ebd34570cd648ba60839a7959145a0d32a3473c7fea6804e457326d85ae130b04730b25c09d10cc267a43df056ce9b24b1260ecc775", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1b074e25250a28e4dccd01f02ce4d9ace78259833452c170681fb6117b2fe9dc6d6856807106abed0880095330f4179e5dbb1588d38c162d1cb219acaafe27f2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/53f8f6c4c31273a1e8080e6e688db8b75a53e5f62137db17b6b3c6c6ac0904e09e4368529d06b24b8776de62f6992f3fa46c0519ab1e147d01b408f4307d4899", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/256a581df49448857f3eef83bb183c03386e0e508e0e5bcc5277ffef9312a3496d9389d1df3459226872fd40fd47c39fc4e3dcbe3337c51ded7ebd17fff68ef3"} build_url:https://queue.taskcluster.net/v1/task/AtFWNSmFTS2-tNrUZ0a0qQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011266 build_url: 'https://queue.taskcluster.net/v1/task/AtFWNSmFTS2-tNrUZ0a0qQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/49d973cb016255271c7b9ebd34570cd648ba60839a7959145a0d32a3473c7fea6804e457326d85ae130b04730b25c09d10cc267a43df056ce9b24b1260ecc775", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1b074e25250a28e4dccd01f02ce4d9ace78259833452c170681fb6117b2fe9dc6d6856807106abed0880095330f4179e5dbb1588d38c162d1cb219acaafe27f2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/53f8f6c4c31273a1e8080e6e688db8b75a53e5f62137db17b6b3c6c6ac0904e09e4368529d06b24b8776de62f6992f3fa46c0519ab1e147d01b408f4307d4899", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/256a581df49448857f3eef83bb183c03386e0e508e0e5bcc5277ffef9312a3496d9389d1df3459226872fd40fd47c39fc4e3dcbe3337c51ded7ebd17fff68ef3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-19 13:06:15.167961) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 13:06:15.168272) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1495220490.276601-405361073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004427 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 13:06:15.249227) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-19 13:06:15.249544) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-19 13:06:15.252863) ========= ========= Total master_lag: 0.03 =========