builder: mozilla-beta_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-048 starttime: 1495133222.19 results: success (0) revision: 54f218cec92ffcc2cc8160ed80c58ffe8b6c268d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-18 11:47:02.191397) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-18 11:47:02.191873) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-18 11:47:02.192149) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-18 11:47:02.355726) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 11:47:02.356075) ========= 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=fa44defc139c4ba8574fe040000001db-1495131440.351375-1898100091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-18 11:47:02-- 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% 109M=0s 2017-05-18 11:47:03 (109 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.298040 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 11:47:02.728602) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 11:47:02.728961) ========= 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=fa44defc139c4ba8574fe040000001db-1495131440.351375-1898100091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018209 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 11:47:02.798894) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 11:47:02.799233) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 54f218cec92ffcc2cc8160ed80c58ffe8b6c268d --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 54f218cec92ffcc2cc8160ed80c58ffe8b6c268d --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=fa44defc139c4ba8574fe040000001db-1495131440.351375-1898100091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-18 11:47:03,243 truncating revision to first 12 chars 2017-05-18 11:47:03,243 Setting DEBUG logging. 2017-05-18 11:47:03,243 attempt 1/10 2017-05-18 11:47:03,243 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/54f218cec92f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-18 11:47:03,553 unpacking tar archive at: mozilla-beta-54f218cec92f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.614835 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 11:47:03.449614) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-18 11:47:03.453050) ========= script_repo_revision: 54f218cec92ffcc2cc8160ed80c58ffe8b6c268d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-18 11:47:03.453477) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-18 11:47:03.453758) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-18 11:47:03.462218) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-05-18 11:47:03.462566) ========= /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=fa44defc139c4ba8574fe040000001db-1495131440.351375-1898100091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:47:03 INFO - MultiFileLogger online at 20170518 11:47:03 in /builds/slave/test 11:47:03 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 11:47:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:47:03 INFO - {'append_to_log': False, 11:47:03 INFO - 'base_work_dir': '/builds/slave/test', 11:47:03 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 11:47:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:47:03 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 11:47:03 INFO - 'buildbot_json_path': 'buildprops.json', 11:47:03 INFO - 'config_files': ('talos/linux_config.py',), 11:47:03 INFO - 'default_actions': ('clobber', 11:47:03 INFO - 'read-buildbot-config', 11:47:03 INFO - 'download-and-extract', 11:47:03 INFO - 'populate-webroot', 11:47:03 INFO - 'create-virtualenv', 11:47:03 INFO - 'install', 11:47:03 INFO - 'run-tests'), 11:47:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:47:03 INFO - 'download_minidump_stackwalk': True, 11:47:03 INFO - 'download_symbols': 'ondemand', 11:47:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:47:03 INFO - 'tooltool.py': '/tools/tooltool.py', 11:47:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:47:03 INFO - '/tools/misc-python/virtualenv.py')}, 11:47:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:47:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:47:03 INFO - 'gecko_profile': False, 11:47:03 INFO - 'gecko_profile_interval': 0, 11:47:03 INFO - 'installer_path': 'installer.exe', 11:47:03 INFO - 'log_level': 'info', 11:47:03 INFO - 'log_name': 'talos', 11:47:03 INFO - 'log_to_console': True, 11:47:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:47:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:47:03 INFO - 'opt_config_files': (), 11:47:03 INFO - 'pip_index': False, 11:47:03 INFO - 'suite': 'dromaeojs', 11:47:03 INFO - 'system_bits': '32', 11:47:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:47:03 INFO - 'title': 'talos-linux64-ix-048', 11:47:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:47:03 INFO - 'use_talos_json': True, 11:47:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:47:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:47:03 INFO - 'work_dir': 'build'} 11:47:03 INFO - [mozharness: 2017-05-18 18:47:03.989558Z] Running clobber step. 11:47:03 INFO - Running pre-action listener: _resource_record_pre_action 11:47:03 INFO - Running main action method: clobber 11:47:03 INFO - rmtree: /builds/slave/test/build 11:47:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:47:04 INFO - Running post-action listener: _resource_record_post_action 11:47:04 INFO - [mozharness: 2017-05-18 18:47:04.999661Z] Finished clobber step (success) 11:47:04 INFO - [mozharness: 2017-05-18 18:47:04.999760Z] Running read-buildbot-config step. 11:47:04 INFO - Running pre-action listener: _resource_record_pre_action 11:47:04 INFO - Running main action method: read_buildbot_config 11:47:05 INFO - Using buildbot properties: 11:47:05 INFO - { 11:47:05 INFO - "project": "", 11:47:05 INFO - "product": "firefox", 11:47:05 INFO - "who": "ryanvm@gmail.com", 11:47:05 INFO - "installer_path": "public/build/target.tar.bz2", 11:47:05 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 11:47:05 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta/", 11:47:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs", 11:47:05 INFO - "stage_platform": "linux64", 11:47:05 INFO - "basedir": "/builds/slave/test", 11:47:05 INFO - "buildnumber": 51, 11:47:05 INFO - "platform": "ubuntu64_hw", 11:47:05 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:47:05 INFO - "slavebuilddir": "test", 11:47:05 INFO - "taskId": "Tpey24C2RZeEB8bCoxDfNw", 11:47:05 INFO - "branch": "mozilla-beta", 11:47:05 INFO - "script_repo_revision": "production", 11:47:05 INFO - "revision": "54f218cec92ffcc2cc8160ed80c58ffe8b6c268d", 11:47:05 INFO - "slavename": "talos-linux64-ix-048", 11:47:05 INFO - "repo_path": "releases/mozilla-beta" 11:47:05 INFO - } 11:47:05 INFO - Finding installer, test and symbols from parent task. 11:47:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tpey24C2RZeEB8bCoxDfNw'}, attempt #1 11:47:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tpey24C2RZeEB8bCoxDfNw'}, attempt #1 11:47:05 INFO - Task dependencies: G1jXTk_5SVmuJadBtJ0AJQ 11:47:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G1jXTk_5SVmuJadBtJ0AJQ'}, attempt #1 11:47:06 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/G1jXTk_5SVmuJadBtJ0AJQ/artifacts/public/build/target.tar.bz2 11:47:06 INFO - Set test_url: https://queue.taskcluster.net/v1/task/G1jXTk_5SVmuJadBtJ0AJQ/artifacts/public/build/test_packages.json 11:47:06 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/G1jXTk_5SVmuJadBtJ0AJQ/artifacts/public/build/target.crashreporter-symbols.zip 11:47:06 INFO - Running post-action listener: _resource_record_post_action 11:47:06 INFO - [mozharness: 2017-05-18 18:47:06.334279Z] Finished read-buildbot-config step (success) 11:47:06 INFO - [mozharness: 2017-05-18 18:47:06.334501Z] Running download-and-extract step. 11:47:06 INFO - Running pre-action listener: _resource_record_pre_action 11:47:06 INFO - Running main action method: download_and_extract 11:47:06 INFO - mkdir: /builds/slave/test/build/tests 11:47: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')]} 11:47:06 INFO - trying https://queue.taskcluster.net/v1/task/G1jXTk_5SVmuJadBtJ0AJQ/artifacts/public/build/target.test_packages.json 11:47:06 INFO - Downloading https://queue.taskcluster.net/v1/task/G1jXTk_5SVmuJadBtJ0AJQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:47:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G1jXTk_5SVmuJadBtJ0AJQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:47:06 INFO - Downloaded 986 bytes. 11:47:06 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:47:06 INFO - Using the following test package requirements: 11:47:06 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:47:06 INFO - u'common': [u'target.common.tests.zip'], 11:47:06 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:47:06 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:47:06 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:47:06 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:47:06 INFO - u'mozbase': [u'target.common.tests.zip'], 11:47:06 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:47:06 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:47:06 INFO - u'web-platform': [u'target.common.tests.zip', 11:47:06 INFO - u'target.web-platform.tests.zip'], 11:47:06 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:47:06 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:47:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G1jXTk_5SVmuJadBtJ0AJQ/artifacts/public/build/target.common.tests.zip 11:47:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G1jXTk_5SVmuJadBtJ0AJQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:47:06 INFO - Fetch https://queue.taskcluster.net/v1/task/G1jXTk_5SVmuJadBtJ0AJQ/artifacts/public/build/target.common.tests.zip into memory 11:47:10 INFO - Expected file size: 59562654 11:47:10 INFO - Obtained file size: 59562654 11:47:19 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:47:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G1jXTk_5SVmuJadBtJ0AJQ/artifacts/public/build/target.common.tests.zip 11:47:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G1jXTk_5SVmuJadBtJ0AJQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:47:19 INFO - Fetch https://queue.taskcluster.net/v1/task/G1jXTk_5SVmuJadBtJ0AJQ/artifacts/public/build/target.common.tests.zip into memory 11:47:22 INFO - Expected file size: 59562654 11:47:22 INFO - Obtained file size: 59562654 11:47:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G1jXTk_5SVmuJadBtJ0AJQ/artifacts/public/build/target.talos.tests.zip 11:47:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G1jXTk_5SVmuJadBtJ0AJQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:47:32 INFO - Fetch https://queue.taskcluster.net/v1/task/G1jXTk_5SVmuJadBtJ0AJQ/artifacts/public/build/target.talos.tests.zip into memory 11:47:33 INFO - Expected file size: 14404449 11:47:33 INFO - Obtained file size: 14404449 11:47:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:33 INFO - trying https://queue.taskcluster.net/v1/task/G1jXTk_5SVmuJadBtJ0AJQ/artifacts/public/build/target.tar.bz2 11:47:33 INFO - Downloading https://queue.taskcluster.net/v1/task/G1jXTk_5SVmuJadBtJ0AJQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:47:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G1jXTk_5SVmuJadBtJ0AJQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:47:36 INFO - Downloaded 59665179 bytes. 11:47:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G1jXTk_5SVmuJadBtJ0AJQ/artifacts/public/build/target.tar.bz2 11:47:36 INFO - mkdir: /builds/slave/test/properties 11:47:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:47:36 INFO - Writing to file /builds/slave/test/properties/build_url 11:47:36 INFO - Contents: 11:47:36 INFO - build_url:https://queue.taskcluster.net/v1/task/G1jXTk_5SVmuJadBtJ0AJQ/artifacts/public/build/target.tar.bz2 11:47:36 INFO - Running post-action listener: _resource_record_post_action 11:47:36 INFO - Running post-action listener: set_extra_try_arguments 11:47:36 INFO - [mozharness: 2017-05-18 18:47:36.400212Z] Finished download-and-extract step (success) 11:47:36 INFO - [mozharness: 2017-05-18 18:47:36.400436Z] Running populate-webroot step. 11:47:36 INFO - Running pre-action listener: _resource_record_pre_action 11:47:36 INFO - Running main action method: populate_webroot 11:47:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:47:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:47:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:47:36 INFO - '--tppagecycles', 11:47:36 INFO - '7'], 11:47:36 INFO - 'tests': ['tsvgm']}}, 11:47:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:47:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:47:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:47:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:47:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:47:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:47:36 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:47:36 INFO - 'talos_options': ['--disable-e10s'], 11:47:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:47:36 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:47:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:47:36 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:47:36 INFO - 'talos_options': ['--disable-e10s'], 11:47:36 INFO - 'tests': ['damp', 'tps']}, 11:47:36 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:47:36 INFO - 'tests': ['damp', 'tps']}, 11:47:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:47:36 INFO - 'tests': ['dromaeo_dom']}, 11:47:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:47:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:47:36 INFO - 'tests': ['basic_compositor_video']}, 11:47:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:47:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:47:36 INFO - 'tests': ['a11yr', 11:47:36 INFO - 'ts_paint', 11:47:36 INFO - 'tpaint', 11:47:36 INFO - 'sessionrestore', 11:47:36 INFO - 'sessionrestore_no_auto_restore', 11:47:36 INFO - 'tabpaint']}, 11:47:36 INFO - 'other-e10s': {'tests': ['a11yr', 11:47:36 INFO - 'ts_paint', 11:47:36 INFO - 'tpaint', 11:47:36 INFO - 'sessionrestore', 11:47:36 INFO - 'sessionrestore_no_auto_restore', 11:47:36 INFO - 'tabpaint']}, 11:47:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:47:36 INFO - 'ts_paint', 11:47:36 INFO - 'tpaint', 11:47:36 INFO - 'sessionrestore', 11:47:36 INFO - 'sessionrestore_no_auto_restore', 11:47:36 INFO - 'tabpaint']}, 11:47:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:47:36 INFO - 'ts_paint', 11:47:36 INFO - 'tpaint', 11:47:36 INFO - 'sessionrestore', 11:47:36 INFO - 'sessionrestore_no_auto_restore', 11:47:36 INFO - 'tabpaint']}, 11:47:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:47:36 INFO - 'tests': ['a11yr', 11:47:36 INFO - 'ts_paint', 11:47:36 INFO - 'tpaint', 11:47:36 INFO - 'sessionrestore', 11:47:36 INFO - 'sessionrestore_no_auto_restore', 11:47:36 INFO - 'tabpaint']}, 11:47:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:47:36 INFO - 'tests': ['a11yr', 11:47:36 INFO - 'ts_paint', 11:47:36 INFO - 'tpaint', 11:47:36 INFO - 'sessionrestore', 11:47:36 INFO - 'sessionrestore_no_auto_restore', 11:47:36 INFO - 'tabpaint']}, 11:47:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:47:36 INFO - 'tests': ['tsvgx', 11:47:36 INFO - 'tsvgr_opacity', 11:47:36 INFO - 'tart', 11:47:36 INFO - 'tscrollx', 11:47:36 INFO - 'cart', 11:47:36 INFO - 'tsvg_static']}, 11:47:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:47:36 INFO - 'tsvgr_opacity', 11:47:36 INFO - 'tart', 11:47:36 INFO - 'tscrollx', 11:47:36 INFO - 'cart', 11:47:36 INFO - 'tsvg_static']}, 11:47:36 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:47:36 INFO - 'talos_options': ['--disable-e10s'], 11:47:36 INFO - 'tests': ['tp5o']}, 11:47:36 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:47:36 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:47:36 INFO - 'talos_options': ['--disable-e10s', 11:47:36 INFO - '--xperf_path', 11:47:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:47:36 INFO - 'tests': ['tp5n']}, 11:47:36 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:47:36 INFO - 'talos_options': ['--xperf_path', 11:47:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:47:36 INFO - 'tests': ['tp5n']}}, 11:47:36 INFO - 'talos.zip': {'path': '', 11:47:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:47:36 INFO - Running post-action listener: _resource_record_post_action 11:47:36 INFO - [mozharness: 2017-05-18 18:47:36.419649Z] Finished populate-webroot step (success) 11:47:36 INFO - [mozharness: 2017-05-18 18:47:36.419739Z] Running create-virtualenv step. 11:47:36 INFO - Running pre-action listener: _resource_record_pre_action 11:47:36 INFO - Running main action method: create_virtualenv 11:47:36 INFO - Creating virtualenv /builds/slave/test/build/venv 11:47:36 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 11:47:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:47:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:47:36 INFO - Using real prefix '/usr' 11:47:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:47:37 INFO - Installing distribute.............................................................................................................................................................................................done. 11:47:39 INFO - Installing pip.................done. 11:47:39 INFO - Return code: 0 11:47:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:47:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:47:39 INFO - Reading from file tmpfile_stdout 11:47:39 INFO - Output received: 11:47:39 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) 11:47:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:47:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:39 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 0xb681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe06310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe03400>, '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 0xe043b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04840>, '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': 'fa44defc139c4ba8574fe040000001db-1495131440.351375-1898100091', '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 11:47:39 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 11:47:39 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 11:47:39 INFO - Using env: {'DISPLAY': ':0', 11:47:39 INFO - 'HOME': '/home/cltbld', 11:47:39 INFO - 'LANG': 'en_US.UTF-8', 11:47:39 INFO - 'LANGUAGE': 'en_US:en', 11:47:39 INFO - 'LOGNAME': 'cltbld', 11:47:39 INFO - 'MAIL': '/var/mail/cltbld', 11:47:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:39 INFO - 'MOZ_NO_REMOTE': '1', 11:47:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:39 INFO - 'NO_EM_RESTART': '1', 11:47:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:39 INFO - 'PWD': '/builds/slave/test', 11:47:39 INFO - 'SHELL': '/bin/bash', 11:47:39 INFO - 'SHLVL': '1', 11:47:39 INFO - 'TERM': 'linux', 11:47:39 INFO - 'TMOUT': '86400', 11:47:39 INFO - 'USER': 'cltbld', 11:47:39 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1495131440.351375-1898100091', 11:47:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:39 INFO - '_': '/tools/buildbot/bin/python'} 11:47:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:39 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 11:47:39 INFO - Cleaning up... 11:47:39 INFO - Return code: 0 11:47:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:47:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:39 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 0xb681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe06310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe03400>, '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 0xe043b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04840>, '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': 'fa44defc139c4ba8574fe040000001db-1495131440.351375-1898100091', '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 11:47:39 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 11:47:39 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 11:47:39 INFO - Using env: {'DISPLAY': ':0', 11:47:39 INFO - 'HOME': '/home/cltbld', 11:47:39 INFO - 'LANG': 'en_US.UTF-8', 11:47:39 INFO - 'LANGUAGE': 'en_US:en', 11:47:39 INFO - 'LOGNAME': 'cltbld', 11:47:39 INFO - 'MAIL': '/var/mail/cltbld', 11:47:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:39 INFO - 'MOZ_NO_REMOTE': '1', 11:47:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:39 INFO - 'NO_EM_RESTART': '1', 11:47:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:39 INFO - 'PWD': '/builds/slave/test', 11:47:39 INFO - 'SHELL': '/bin/bash', 11:47:39 INFO - 'SHLVL': '1', 11:47:39 INFO - 'TERM': 'linux', 11:47:39 INFO - 'TMOUT': '86400', 11:47:39 INFO - 'USER': 'cltbld', 11:47:39 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1495131440.351375-1898100091', 11:47:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:39 INFO - '_': '/tools/buildbot/bin/python'} 11:47:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:39 INFO - Downloading/unpacking psutil>=3.1.1 11:47:39 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 11:47:39 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 11:47:39 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 11:47:39 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 11:47:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:47:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:47:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:47:40 INFO - Installing collected packages: psutil 11:47:40 INFO - Running setup.py install for psutil 11:47:40 INFO - building 'psutil._psutil_linux' extension 11:47:40 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 11:47:41 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 11:47:41 INFO - building 'psutil._psutil_posix' extension 11:47:41 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 11:47:41 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 11:47:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:47:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:47:41 INFO - Successfully installed psutil 11:47:41 INFO - Cleaning up... 11:47:41 INFO - Return code: 0 11:47:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:47:41 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')]} 11:47:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:41 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')]} 11:47:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:41 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 0xb681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe06310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe03400>, '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 0xe043b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04840>, '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': 'fa44defc139c4ba8574fe040000001db-1495131440.351375-1898100091', '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 11:47:41 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 11:47:41 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 11:47:41 INFO - Using env: {'DISPLAY': ':0', 11:47:41 INFO - 'HOME': '/home/cltbld', 11:47:41 INFO - 'LANG': 'en_US.UTF-8', 11:47:41 INFO - 'LANGUAGE': 'en_US:en', 11:47:41 INFO - 'LOGNAME': 'cltbld', 11:47:41 INFO - 'MAIL': '/var/mail/cltbld', 11:47:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:41 INFO - 'MOZ_NO_REMOTE': '1', 11:47:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:41 INFO - 'NO_EM_RESTART': '1', 11:47:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:41 INFO - 'PWD': '/builds/slave/test', 11:47:41 INFO - 'SHELL': '/bin/bash', 11:47:41 INFO - 'SHLVL': '1', 11:47:41 INFO - 'TERM': 'linux', 11:47:41 INFO - 'TMOUT': '86400', 11:47:41 INFO - 'USER': 'cltbld', 11:47:41 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1495131440.351375-1898100091', 11:47:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:41 INFO - '_': '/tools/buildbot/bin/python'} 11:47:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:47:41 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 11:47:41 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 11:47:41 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 11:47:41 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 11:47:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:47:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:47:42 INFO - Installing collected packages: mozsystemmonitor 11:47:42 INFO - Running setup.py install for mozsystemmonitor 11:47:42 INFO - Successfully installed mozsystemmonitor 11:47:42 INFO - Cleaning up... 11:47:42 INFO - Return code: 0 11:47:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:47:42 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')]} 11:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:42 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')]} 11:47:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:42 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 0xb681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe06310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe03400>, '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 0xe043b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04840>, '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': 'fa44defc139c4ba8574fe040000001db-1495131440.351375-1898100091', '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 11:47:42 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 11:47:42 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 11:47:42 INFO - Using env: {'DISPLAY': ':0', 11:47:42 INFO - 'HOME': '/home/cltbld', 11:47:42 INFO - 'LANG': 'en_US.UTF-8', 11:47:42 INFO - 'LANGUAGE': 'en_US:en', 11:47:42 INFO - 'LOGNAME': 'cltbld', 11:47:42 INFO - 'MAIL': '/var/mail/cltbld', 11:47:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:42 INFO - 'MOZ_NO_REMOTE': '1', 11:47:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:42 INFO - 'NO_EM_RESTART': '1', 11:47:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:42 INFO - 'PWD': '/builds/slave/test', 11:47:42 INFO - 'SHELL': '/bin/bash', 11:47:42 INFO - 'SHLVL': '1', 11:47:42 INFO - 'TERM': 'linux', 11:47:42 INFO - 'TMOUT': '86400', 11:47:42 INFO - 'USER': 'cltbld', 11:47:42 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1495131440.351375-1898100091', 11:47:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:42 INFO - '_': '/tools/buildbot/bin/python'} 11:47:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:43 INFO - Downloading/unpacking jsonschema==2.5.1 11:47:43 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 11:47:43 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 11:47:43 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 11:47:43 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 11:47:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:47:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:47:44 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 11:47:44 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 11:47:44 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 11:47:44 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 11:47:44 INFO - Downloading functools32-3.2.3-2.tar.gz 11:47:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:47:44 INFO - warning: no files found matching '*.txt' 11:47:44 INFO - no previously-included directories found matching 'build' 11:47:44 INFO - no previously-included directories found matching 'dist' 11:47:44 INFO - no previously-included directories found matching '.git*' 11:47:44 INFO - Installing collected packages: jsonschema, functools32 11:47:44 INFO - Running setup.py install for functools32 11:47:44 INFO - warning: no files found matching '*.txt' 11:47:44 INFO - no previously-included directories found matching 'build' 11:47:44 INFO - no previously-included directories found matching 'dist' 11:47:44 INFO - no previously-included directories found matching '.git*' 11:47:44 INFO - Successfully installed jsonschema functools32 11:47:44 INFO - Cleaning up... 11:47:44 INFO - Return code: 0 11:47:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:47:44 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')]} 11:47:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:44 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')]} 11:47:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:44 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 0xb681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe06310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe03400>, '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 0xe043b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04840>, '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': 'fa44defc139c4ba8574fe040000001db-1495131440.351375-1898100091', '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 11:47:44 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 11:47:44 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 11:47:44 INFO - Using env: {'DISPLAY': ':0', 11:47:44 INFO - 'HOME': '/home/cltbld', 11:47:44 INFO - 'LANG': 'en_US.UTF-8', 11:47:44 INFO - 'LANGUAGE': 'en_US:en', 11:47:44 INFO - 'LOGNAME': 'cltbld', 11:47:44 INFO - 'MAIL': '/var/mail/cltbld', 11:47:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:44 INFO - 'MOZ_NO_REMOTE': '1', 11:47:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:44 INFO - 'NO_EM_RESTART': '1', 11:47:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:44 INFO - 'PWD': '/builds/slave/test', 11:47:44 INFO - 'SHELL': '/bin/bash', 11:47:44 INFO - 'SHLVL': '1', 11:47:44 INFO - 'TERM': 'linux', 11:47:44 INFO - 'TMOUT': '86400', 11:47:44 INFO - 'USER': 'cltbld', 11:47:44 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1495131440.351375-1898100091', 11:47:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:44 INFO - '_': '/tools/buildbot/bin/python'} 11:47:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:47:44 INFO - Cleaning up... 11:47:44 INFO - Return code: 0 11:47:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:47:44 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')]} 11:47:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:44 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')]} 11:47:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:44 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 0xb681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe06310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe03400>, '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 0xe043b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04840>, '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': 'fa44defc139c4ba8574fe040000001db-1495131440.351375-1898100091', '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 11:47:44 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 11:47:44 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 11:47:44 INFO - Using env: {'DISPLAY': ':0', 11:47:44 INFO - 'HOME': '/home/cltbld', 11:47:44 INFO - 'LANG': 'en_US.UTF-8', 11:47:44 INFO - 'LANGUAGE': 'en_US:en', 11:47:44 INFO - 'LOGNAME': 'cltbld', 11:47:44 INFO - 'MAIL': '/var/mail/cltbld', 11:47:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:44 INFO - 'MOZ_NO_REMOTE': '1', 11:47:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:44 INFO - 'NO_EM_RESTART': '1', 11:47:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:44 INFO - 'PWD': '/builds/slave/test', 11:47:44 INFO - 'SHELL': '/bin/bash', 11:47:44 INFO - 'SHLVL': '1', 11:47:44 INFO - 'TERM': 'linux', 11:47:44 INFO - 'TMOUT': '86400', 11:47:44 INFO - 'USER': 'cltbld', 11:47:44 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1495131440.351375-1898100091', 11:47:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:44 INFO - '_': '/tools/buildbot/bin/python'} 11:47:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:45 INFO - Downloading/unpacking blobuploader==1.2.4 11:47:45 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 11:47:45 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 11:47:45 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 11:47:45 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 11:47:46 INFO - Downloading blobuploader-1.2.4.tar.gz 11:47:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:47:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:47:46 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 11:47:46 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 11:47:46 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 11:47:46 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 11:47:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:47:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:47:46 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 11:47:46 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 11:47:46 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 11:47:46 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 11:47:46 INFO - Downloading docopt-0.6.1.tar.gz 11:47:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:47:46 INFO - Installing collected packages: blobuploader, requests, docopt 11:47:46 INFO - Running setup.py install for blobuploader 11:47:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:47:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:47:46 INFO - Running setup.py install for requests 11:47:47 INFO - Running setup.py install for docopt 11:47:47 INFO - Successfully installed blobuploader requests docopt 11:47:47 INFO - Cleaning up... 11:47:47 INFO - Return code: 0 11:47:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:47:47 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')]} 11:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:47 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')]} 11:47:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:47 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 0xb681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe06310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe03400>, '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 0xe043b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04840>, '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': 'fa44defc139c4ba8574fe040000001db-1495131440.351375-1898100091', '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 11:47:47 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 11:47:47 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 11:47:47 INFO - Using env: {'DISPLAY': ':0', 11:47:47 INFO - 'HOME': '/home/cltbld', 11:47:47 INFO - 'LANG': 'en_US.UTF-8', 11:47:47 INFO - 'LANGUAGE': 'en_US:en', 11:47:47 INFO - 'LOGNAME': 'cltbld', 11:47:47 INFO - 'MAIL': '/var/mail/cltbld', 11:47:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:47 INFO - 'MOZ_NO_REMOTE': '1', 11:47:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:47 INFO - 'NO_EM_RESTART': '1', 11:47:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:47 INFO - 'PWD': '/builds/slave/test', 11:47:47 INFO - 'SHELL': '/bin/bash', 11:47:47 INFO - 'SHLVL': '1', 11:47:47 INFO - 'TERM': 'linux', 11:47:47 INFO - 'TMOUT': '86400', 11:47:47 INFO - 'USER': 'cltbld', 11:47:47 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1495131440.351375-1898100091', 11:47:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:47 INFO - '_': '/tools/buildbot/bin/python'} 11:47:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:47:47 INFO - Running setup.py (path:/tmp/pip-4MDIvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:47:47 INFO - Running setup.py (path:/tmp/pip-5Yxt4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:47:47 INFO - Running setup.py (path:/tmp/pip-UCEdct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:47:47 INFO - Running setup.py (path:/tmp/pip-8XZn9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:47:47 INFO - Running setup.py (path:/tmp/pip-8SkPpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:47:47 INFO - Running setup.py (path:/tmp/pip-hl5Z7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:47:48 INFO - Running setup.py (path:/tmp/pip-JIFhdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:47:48 INFO - Running setup.py (path:/tmp/pip-_cQcmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:47:48 INFO - Running setup.py (path:/tmp/pip-fsxodD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:47:48 INFO - Running setup.py (path:/tmp/pip-t8zw_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:47:48 INFO - Running setup.py (path:/tmp/pip-68I0rV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:47:48 INFO - Running setup.py (path:/tmp/pip-PxeGNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:47:48 INFO - Running setup.py (path:/tmp/pip-aPr3Xj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:47:48 INFO - Running setup.py (path:/tmp/pip-UQpncF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:47:48 INFO - Running setup.py (path:/tmp/pip-ZA1v6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:47:48 INFO - Running setup.py (path:/tmp/pip-wmmtPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:47:48 INFO - Running setup.py (path:/tmp/pip-1l_ijT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:47:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:47:48 INFO - Running setup.py install for manifestparser 11:47:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:47:48 INFO - Running setup.py install for mozcrash 11:47:49 INFO - Running setup.py install for mozdebug 11:47:49 INFO - Running setup.py install for mozdevice 11:47:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:47:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:47:49 INFO - Running setup.py install for mozfile 11:47:49 INFO - Running setup.py install for mozhttpd 11:47:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:47:49 INFO - Running setup.py install for mozinfo 11:47:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:47:49 INFO - Running setup.py install for mozInstall 11:47:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:47:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:47:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:47:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:47:49 INFO - Running setup.py install for mozleak 11:47:49 INFO - Running setup.py install for mozlog 11:47:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:47:49 INFO - Running setup.py install for moznetwork 11:47:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:47:49 INFO - Running setup.py install for mozprocess 11:47:50 INFO - Running setup.py install for mozprofile 11:47:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:47:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:47:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:47:50 INFO - Running setup.py install for mozrunner 11:47:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:47:50 INFO - Running setup.py install for mozscreenshot 11:47:50 INFO - Running setup.py install for moztest 11:47:50 INFO - Running setup.py install for mozversion 11:47:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:47:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:47:50 INFO - Cleaning up... 11:47:50 INFO - Return code: 0 11:47:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:47:50 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')]} 11:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:50 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')]} 11:47:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:50 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 0xb681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe06310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe03400>, '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 0xe043b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04840>, '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': 'fa44defc139c4ba8574fe040000001db-1495131440.351375-1898100091', '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 11:47:50 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 11:47:50 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 11:47:50 INFO - Using env: {'DISPLAY': ':0', 11:47:50 INFO - 'HOME': '/home/cltbld', 11:47:50 INFO - 'LANG': 'en_US.UTF-8', 11:47:50 INFO - 'LANGUAGE': 'en_US:en', 11:47:50 INFO - 'LOGNAME': 'cltbld', 11:47:50 INFO - 'MAIL': '/var/mail/cltbld', 11:47:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:50 INFO - 'MOZ_NO_REMOTE': '1', 11:47:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:50 INFO - 'NO_EM_RESTART': '1', 11:47:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:50 INFO - 'PWD': '/builds/slave/test', 11:47:50 INFO - 'SHELL': '/bin/bash', 11:47:50 INFO - 'SHLVL': '1', 11:47:50 INFO - 'TERM': 'linux', 11:47:50 INFO - 'TMOUT': '86400', 11:47:50 INFO - 'USER': 'cltbld', 11:47:50 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1495131440.351375-1898100091', 11:47:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:50 INFO - '_': '/tools/buildbot/bin/python'} 11:47:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:47:50 INFO - Running setup.py (path:/tmp/pip-3Ma5jA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:47:50 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)) 11:47:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:47:50 INFO - Running setup.py (path:/tmp/pip-zbhMyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:47:50 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)) 11:47:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:47:50 INFO - Running setup.py (path:/tmp/pip-olp0K7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:47:51 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)) 11:47:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:47:51 INFO - Running setup.py (path:/tmp/pip-jhvT6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:47:51 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)) 11:47:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:47:51 INFO - Running setup.py (path:/tmp/pip-C3IzC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:47:51 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)) 11:47:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:47:51 INFO - Running setup.py (path:/tmp/pip-qKZpQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:47:51 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)) 11:47:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:47:51 INFO - Running setup.py (path:/tmp/pip-0MSE2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:47:51 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)) 11:47:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:47:51 INFO - Running setup.py (path:/tmp/pip-7geaIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:47:51 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)) 11:47:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:47:51 INFO - Running setup.py (path:/tmp/pip-cnBUlz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:47:51 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)) 11:47:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:47:51 INFO - Running setup.py (path:/tmp/pip-mhhWTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:47:51 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)) 11:47:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:47:51 INFO - Running setup.py (path:/tmp/pip-0svw7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:47:51 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)) 11:47:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:47:51 INFO - Running setup.py (path:/tmp/pip-Ri8kD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:47:51 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)) 11:47:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:47:51 INFO - Running setup.py (path:/tmp/pip-3C4ol5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:47:51 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)) 11:47:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:47:51 INFO - Running setup.py (path:/tmp/pip-ma5E3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:47:51 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)) 11:47:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:47:51 INFO - Running setup.py (path:/tmp/pip-4F2NJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:47:51 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)) 11:47:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:47:51 INFO - Running setup.py (path:/tmp/pip-gaoWlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:47:52 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)) 11:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:47:52 INFO - Running setup.py (path:/tmp/pip-7TcjRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:47:52 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)) 11:47:52 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)) 11:47:52 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)) 11:47:52 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)) 11:47:52 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)) 11:47:52 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)) 11:47:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:47:52 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 11:47:52 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 11:47:52 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 11:47:52 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 11:47:53 INFO - Downloading blessings-1.6.tar.gz 11:47:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:47:53 INFO - Installing collected packages: blessings 11:47:53 INFO - Running setup.py install for blessings 11:47:53 INFO - Successfully installed blessings 11:47:53 INFO - Cleaning up... 11:47:53 INFO - Return code: 0 11:47:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:47:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:47:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:47:53 INFO - Reading from file tmpfile_stdout 11:47:53 INFO - Current package versions: 11:47:53 INFO - argparse == 1.2.1 11:47:53 INFO - blessings == 1.6 11:47:53 INFO - blobuploader == 1.2.4 11:47:53 INFO - docopt == 0.6.1 11:47:53 INFO - functools32 == 3.2.3-2 11:47:53 INFO - jsonschema == 2.5.1 11:47:53 INFO - manifestparser == 1.1 11:47:53 INFO - mozInstall == 1.12 11:47:53 INFO - mozcrash == 1.0 11:47:53 INFO - mozdebug == 0.1 11:47:53 INFO - mozdevice == 0.49 11:47:53 INFO - mozfile == 1.2 11:47:53 INFO - mozhttpd == 0.7 11:47:53 INFO - mozinfo == 0.9 11:47:53 INFO - mozleak == 0.1 11:47:53 INFO - mozlog == 3.4 11:47:53 INFO - moznetwork == 0.27 11:47:53 INFO - mozprocess == 0.25 11:47:53 INFO - mozprofile == 0.28 11:47:53 INFO - mozrunner == 6.13 11:47:53 INFO - mozscreenshot == 0.1 11:47:53 INFO - mozsystemmonitor == 0.3 11:47:53 INFO - moztest == 0.8 11:47:53 INFO - mozversion == 1.4 11:47:53 INFO - psutil == 3.1.1 11:47:53 INFO - requests == 1.2.3 11:47:53 INFO - wsgiref == 0.1.2 11:47:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:47:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:53 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 0xb681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe06310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe03400>, '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 0xe043b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04840>, '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': 'fa44defc139c4ba8574fe040000001db-1495131440.351375-1898100091', '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 11:47:53 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 11:47:53 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 11:47:53 INFO - Using env: {'DISPLAY': ':0', 11:47:53 INFO - 'HOME': '/home/cltbld', 11:47:53 INFO - 'LANG': 'en_US.UTF-8', 11:47:53 INFO - 'LANGUAGE': 'en_US:en', 11:47:53 INFO - 'LOGNAME': 'cltbld', 11:47:53 INFO - 'MAIL': '/var/mail/cltbld', 11:47:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:53 INFO - 'MOZ_NO_REMOTE': '1', 11:47:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:53 INFO - 'NO_EM_RESTART': '1', 11:47:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:53 INFO - 'PWD': '/builds/slave/test', 11:47:53 INFO - 'SHELL': '/bin/bash', 11:47:53 INFO - 'SHLVL': '1', 11:47:53 INFO - 'TERM': 'linux', 11:47:53 INFO - 'TMOUT': '86400', 11:47:53 INFO - 'USER': 'cltbld', 11:47:53 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1495131440.351375-1898100091', 11:47:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:53 INFO - '_': '/tools/buildbot/bin/python'} 11:47:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:53 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)) 11:47:53 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)) 11:47:53 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)) 11:47:53 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)) 11:47:53 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)) 11:47:53 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)) 11:47:53 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)) 11:47:53 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)) 11:47:53 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)) 11:47:53 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)) 11:47:53 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)) 11:47:53 INFO - Cleaning up... 11:47:53 INFO - Return code: 0 11:47:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:47:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:53 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 0xb681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe06310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe03400>, '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 0xe043b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04840>, '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': 'fa44defc139c4ba8574fe040000001db-1495131440.351375-1898100091', '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 11:47:53 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 11:47:53 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 11:47:53 INFO - Using env: {'DISPLAY': ':0', 11:47:53 INFO - 'HOME': '/home/cltbld', 11:47:53 INFO - 'LANG': 'en_US.UTF-8', 11:47:53 INFO - 'LANGUAGE': 'en_US:en', 11:47:53 INFO - 'LOGNAME': 'cltbld', 11:47:53 INFO - 'MAIL': '/var/mail/cltbld', 11:47:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:53 INFO - 'MOZ_NO_REMOTE': '1', 11:47:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:53 INFO - 'NO_EM_RESTART': '1', 11:47:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:53 INFO - 'PWD': '/builds/slave/test', 11:47:53 INFO - 'SHELL': '/bin/bash', 11:47:53 INFO - 'SHLVL': '1', 11:47:53 INFO - 'TERM': 'linux', 11:47:53 INFO - 'TMOUT': '86400', 11:47:53 INFO - 'USER': 'cltbld', 11:47:53 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1495131440.351375-1898100091', 11:47:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:53 INFO - '_': '/tools/buildbot/bin/python'} 11:47:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:47:54 INFO - Cleaning up... 11:47:54 INFO - Return code: 0 11:47:54 INFO - Running post-action listener: _resource_record_post_action 11:47:54 INFO - Running post-action listener: _start_resource_monitoring 11:47:54 INFO - Starting resource monitoring. 11:47:54 INFO - [mozharness: 2017-05-18 18:47:54.211503Z] Finished create-virtualenv step (success) 11:47:54 INFO - [mozharness: 2017-05-18 18:47:54.212020Z] Running install step. 11:47:54 INFO - Running pre-action listener: _resource_record_pre_action 11:47:54 INFO - Running main action method: install 11:47:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:47:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:47:54 INFO - Reading from file tmpfile_stdout 11:47:54 INFO - Detecting whether we're running mozinstall >=1.0... 11:47:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:47:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:47:54 INFO - Reading from file tmpfile_stdout 11:47:54 INFO - Output received: 11:47:54 INFO - Usage: mozinstall [options] installer 11:47:54 INFO - Options: 11:47:54 INFO - -h, --help show this help message and exit 11:47:54 INFO - -d DEST, --destination=DEST 11:47:54 INFO - Directory to install application into. [default: 11:47:54 INFO - "/builds/slave/test"] 11:47:54 INFO - --app=APP Application being installed. [default: firefox] 11:47:54 INFO - mkdir: /builds/slave/test/build/application 11:47:54 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'] 11:47:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:48:08 INFO - Reading from file tmpfile_stdout 11:48:08 INFO - Output received: 11:48:08 INFO - /builds/slave/test/build/application/firefox/firefox 11:48:08 INFO - Running post-action listener: _resource_record_post_action 11:48:08 INFO - [mozharness: 2017-05-18 18:48:08.602682Z] Finished install step (success) 11:48:08 INFO - [mozharness: 2017-05-18 18:48:08.602882Z] Running run-tests step. 11:48:08 INFO - Running pre-action listener: _resource_record_pre_action 11:48:08 INFO - Running main action method: run_tests 11:48:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:48:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:48:08 INFO - Python 2.7.3 11:48:08 INFO - Return code: 0 11:48:08 INFO - grabbing minidump binary from tooltool 11:48:08 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')]} 11:48:08 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 0xe03400>, '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 0xe043b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe04840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:48:08 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 11:48:08 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 11:48:08 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 11:48:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:48:08 INFO - Return code: 0 11:48:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:48:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:48:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:48:08 INFO - ENV: RUST_BACKTRACE is now 1 11:48:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:48:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:48:08 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/G1jXTk_5SVmuJadBtJ0AJQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 11:48:08 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/G1jXTk_5SVmuJadBtJ0AJQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 11:48:08 INFO - Using env: {'DISPLAY': ':0', 11:48:08 INFO - 'HOME': '/home/cltbld', 11:48:08 INFO - 'LANG': 'en_US.UTF-8', 11:48:08 INFO - 'LANGUAGE': 'en_US:en', 11:48:08 INFO - 'LOGNAME': 'cltbld', 11:48:08 INFO - 'MAIL': '/var/mail/cltbld', 11:48:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:48:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:48:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:08 INFO - 'MOZ_NO_REMOTE': '1', 11:48:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:48:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:08 INFO - 'NO_EM_RESTART': '1', 11:48:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:08 INFO - 'PWD': '/builds/slave/test', 11:48:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:48:08 INFO - 'RUST_BACKTRACE': '1', 11:48:08 INFO - 'SHELL': '/bin/bash', 11:48:08 INFO - 'SHLVL': '1', 11:48:08 INFO - 'TERM': 'linux', 11:48:08 INFO - 'TMOUT': '86400', 11:48:08 INFO - 'USER': 'cltbld', 11:48:08 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1495131440.351375-1898100091', 11:48:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:08 INFO - '_': '/tools/buildbot/bin/python'} 11:48:08 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/G1jXTk_5SVmuJadBtJ0AJQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 11:48:08 INFO - mozversion application_buildid: 20170518175637 11:48:08 INFO - mozversion application_changeset: 54f218cec92ffcc2cc8160ed80c58ffe8b6c268d 11:48:08 INFO - mozversion application_display_name: Firefox 11:48:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:48:08 INFO - mozversion application_name: Firefox 11:48:08 INFO - mozversion application_remotingname: firefox 11:48:08 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:48:08 INFO - mozversion application_vendor: Mozilla 11:48:08 INFO - mozversion application_version: 54.0 11:48:08 INFO - mozversion platform_buildid: 20170518175637 11:48:08 INFO - mozversion platform_changeset: 54f218cec92ffcc2cc8160ed80c58ffe8b6c268d 11:48:08 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:48:08 INFO - mozversion platform_version: 54.0 11:48:08 INFO - using testdate: 1495133288 11:48:08 INFO - actual date: 1495133288 11:48:08 INFO - starting webserver on 'localhost:55676' 11:48:08 INFO - SUITE-START | Running 2 tests 11:48:08 INFO - TEST-START | dromaeo_css 11:48:08 INFO - operating with platform_type : linux_ 11:48:08 INFO - Initialising browser for dromaeo_css test... 11:48:08 INFO - TEST-INFO | started process 11249 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0VRmPD/profile http://localhost:55676/getInfo.html) 11:48:13 INFO - PROCESS | 11249 | __metrics Screen width/height:1600/1200 11:48:13 INFO - PROCESS | 11249 | colorDepth:24 11:48:13 INFO - PROCESS | 11249 | Browser inner width/height: 1024/697 11:48:13 INFO - PROCESS | 11249 | __metrics 11:48:14 INFO - PROCESS | 11249 | 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" 11:48:14 INFO - PROCESS | 11249 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:48:14 INFO - PROCESS | 11249 | console.error: PushService: 11:48:14 INFO - PROCESS | 11249 | stateChangeProcessEnqueue: Error transitioning state 11:48:14 INFO - PROCESS | 11249 | UnknownError 11:48:15 INFO - TEST-INFO | 11249: exit 0 11:48:15 INFO - Browser initialized. 11:48:15 INFO - Running cycle 1/1 for dromaeo_css test... 11:48:15 INFO - TEST-INFO | started process 11345 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0VRmPD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:48:26 INFO - PROCESS | 11345 | RSS: Main: 141795328 11:48:26 INFO - PROCESS | 11345 | 11:51:28 INFO - PROCESS | 11345 | Cycle 1(1): loaded http://localhost:55676/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55676/tests/dromaeo/cssquery-ext.html) 11:51:29 INFO - PROCESS | 11345 | RSS: Main: 265146368 11:51:29 INFO - PROCESS | 11345 | 11:54:31 INFO - PROCESS | 11345 | Cycle 1(1): loaded http://localhost:55676/tests/dromaeo/cssquery-ext.html (next: http://localhost:55676/tests/dromaeo/cssquery-jquery.html) 11:54:32 INFO - PROCESS | 11345 | RSS: Main: 226066432 11:54:32 INFO - PROCESS | 11345 | 11:57:34 INFO - PROCESS | 11345 | Cycle 1(1): loaded http://localhost:55676/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55676/tests/dromaeo/cssquery-mootools.html) 11:57:35 INFO - PROCESS | 11345 | RSS: Main: 175919104 11:57:35 INFO - PROCESS | 11345 | 12:00:36 INFO - PROCESS | 11345 | Cycle 1(1): loaded http://localhost:55676/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55676/tests/dromaeo/cssquery-prototype.html) 12:00:37 INFO - PROCESS | 11345 | RSS: Main: 215683072 12:00:37 INFO - PROCESS | 11345 | 12:03:40 INFO - PROCESS | 11345 | Cycle 1(1): loaded http://localhost:55676/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55676/tests/dromaeo/cssquery-yui.html) 12:03:40 INFO - PROCESS | 11345 | RSS: Main: 174628864 12:03:40 INFO - PROCESS | 11345 | 12:06:43 INFO - PROCESS | 11345 | Cycle 1(1): loaded http://localhost:55676/tests/dromaeo/cssquery-yui.html (next: http://localhost:55676/tests/dromaeo/cssquery-dojo.html) 12:06:43 INFO - PROCESS | 11345 | RSS: Main: 266412032 12:06:43 INFO - PROCESS | 11345 | 12:06:43 INFO - PROCESS | 11345 | __start_tp_report 12:06:43 INFO - PROCESS | 11345 | _x_x_mozilla_page_load 12:06:43 INFO - PROCESS | 11345 | _x_x_mozilla_page_load_details 12:06:43 INFO - PROCESS | 11345 | |i|pagename|runs| 12:06:43 INFO - PROCESS | 11345 | |0;dojo.html;3371.6459771723967;3418.9487157692633;3435.278591495784;3451.32699123671;3469.7397695172854;5691.3739488656265;5730.512906402951;5738.713064346787;5746.683932383718;5765.077587585987;5734.283214598176;5781.075027995522;5785.132230165466;5785.942140578593;5796.913046304308;5206.999999999991;5251.921221181686;5257.842264732045;5261.763220655061;5307.73461326934;5053.469385714502;5085.821996230133;5322.973385133069;5352.330958630171;5355.303810504648;5202.843914682566;5212.8436146915465;5231.73841307935;5239.79040838366;5252.290940722992;5309.840704778863;5322.946770532303;5323.30796996388;5330.040592693333;5334.866628334323;5003.899922001576;5177.249298851683;5237.031149237403;5292.391374991887;5296.364436267672;5520.420355862657;5647.124695672177;5697.31632204134;5773.566982476331;5777.653340799566;6156.507479401637;6194.34959329273;6203.441690247854;6209;6209.16176316196;6214.65819379934;6233.438990490878;6245.906311405332;6256.1866957295715;6267.843303917393;5549.972250138723;5604.467575580314;5708.20085188074;5722.713864306768;5750.4249575042995;6335.208098987627;6337.493000559944;6339.461145802658;6347.714352854133;6350;6046.244219472566;6104.38956104386;6104.4200800923845;6110.5722599418505;6110.908336374958;5908.645481271137;5930.792422265286;6065.909011364833;6187.938120618826;6197.349278325801;6115.240341084353;6178.66017369049;6184.257889053342;6187.319394866561;6193.38066193377;5909.3204281507315;5917.467427931507;5936.168936348915;5938.584299099108;6194.535409844189;4501.369808226851;4541.795619197144;4572.359869618256;4588.77056147198;4591.977040114778;4187.539370669224;4195.475565554306;4203.159368126387;4218.831246750157;4234.513031001413;5732.598718089694;5784.537237021028;5873.530117590582;5886.3230728465915;5962.493188078975;6185.195924529782;6201.658908760061;6223.844403889939;6226.034964580497;6226.906596401058;5958.76164953397;5963.344032156459;5976;5976.193213916065;6006.939930600725;5087.872803179876;5109.642325037212;5268.894622107537;5273.182656688219;5275.182346736262;6217.222847144107;6304;6373.5857169283845;6377.1390862233;6383.2978372379;6125.111858780541;6215.720292586754;6223.315435302023;6227.408396202353;6230.563860529719;6104.236970378703;6368.23581170244;6377.17096777416;6384.265809431789;6385.680715964276;5962.761489540369;5980.102984552178;5986.580939334379;5997.6701281428195;6003.6397816131175;6131.333054409885;6173.59871608362;6173.81478555644;6185.938140618537;6188.3502232266765;6005.3694362091355;6009.729562169626;6017.15759793638;6022.126791615279;6044.395560443921;5751.396103409249;5854.853628659318;5972.671503067373;5980.700964951648;6094.299155596986;6045.395460453919;6056.848578785565;6057.454829065406;6064.363241859542;6065.2418447694035;5854.326752423355;5881.823545293648;6061;6084.908726369196;6088.025915853442;5786.913196302143;5849.502792262705;5888.852778680567;5900.970495147497;5910.881782364243 12:06:43 INFO - PROCESS | 11345 | |1;ext.html;765.7281665008921;826.921442462966;838.9412741108123;880.5773228850152;890.0698769785573;30573.69426305736;41808.581914180846;42406.151876962445;42858.78570607142;42881.35677964829;40699.59300406995;40931.386029209585;40952.795236023856;44803.77598112013;45003;7636.312731854132;7793.883091753628;9197.862032069508;9338.57976391064;10791.514381852836;10836;10907.618233361834;10957.342559446419;10957.726056848604;10959.671209863676;10982.450877456135;11029.83455248172;11033.944830275837;11074.667759967213;11077.390743509144;10854.023137917586;10880.727981800439;10921.781564368708;10960.397178155199;10984.450777461136;10705.46472676363;10819.188560857967;10824.78350432987;10830.40432776197;10843.240973131884;41910.161796763896;41922.37116443256;41926.371104433456;42137.57862421398;42202;4265.680073994432;4336.3712261722185;4367.45406824147;4445.422095127613;4566.908661826745;26707.531959287764;27114.5932811008;27269.45461090767;27679.584806227922;28075.29811754702;4425.468943726773;4458.4426946631675;4502.819887204508;4507.4591049074;4554.8861278467975;250383;250571;251397;251545.74227128932;252716;45293.77353113279;45354.31968520475;45489.77255113769;45547.77226113848;45556;46879.53120468752;46949.29576056362;46950.76524617355;46956.29565556519;47089.29366059512;15727.292271847795;15866.841331586536;15906.363745450053;15983.120928349052;16093.67812643764;11873.28760274369;11997.220180688228;12292.139550231577;13917.721645567235;13921.651958701113;12732.363381830872;12859.614211573667;12906.612801615778;12978.870211297955;13068.803967940488;5302.674331417145;5503.3395992481155;5505;5557.166425036196;5634.746436410372;1029.1818004686293;1030.0472063341379;1041.5677493839971;1044.5926088825213;1049.0872940541778;28037.158885233475;28219.858900705363;28523.71476285252;28623.427531449255;28769;1098.4507746126937;1117.0616681987008;1119.9160062995309;1136.846525719034;1145.0438883532177;14404.711905761826;15062.924685376503;15109;15269.694606107816;15299.15854627984;361340;363351;363351;363703;363868;54038;54311.18533222005;54410.183847242326;54649.72675136599;54670.453295467334;1471.8454562270808;1490.0612614052861;1519.308714534884;1553.7591673290658;1559.954830263726;25000.874995624905;27790.722092778815;28655.713442866137;29058.965872389577;29103.7089629101;35126.47310290399;35279.11802204965;35383.99999999897;35390.82304588461;35417.46873796843;321385;321508;322773;323372;323796;26094.217173484827;29310.853445732635;30149.246268843453;30168;30406.695933040388;28942.565861511674;29090;29272.26819329534;34184.48723269103;35432.291354173285;27256.198677348595;28173.295667607654;30040.3991920156;30338.393232134793;30879.382412351177;29827.403451931274;30269.848650757485;30284.697153028188;30419.239519011317;30548;33988.49017264693;34622.82688586541;34987.30025399529;34994.475082873265;35129.64870351264;28947.421051579273;29032.274193145342;29126.854365728035;29280.853595731885;29600.111996640135;23242.327132379993;24138.87930560336;24299.271021869372;24588.262352129466;24648.014079436623 12:06:43 INFO - PROCESS | 11345 | |2;jquery.html;425.6161536177372;432.59547362259025;437.97372157670543;440.27574639717665;451.0910515311647;20621.38135855923;21923.780762192393;22309.44226394341;22506.54986900261;22596.20913268036;22176.445588860246;22752.203672871452;23057.192998245064;23173.884130579365;23317.417064573394;6856.24581296057;7009.82475438113;7060.011598376232;7358.374538164236;7618.428617853656;7380.815479612999;7612.695492180306;7657.387409007294;7663.655135518915;7673.27103925129;7746.690132394698;7795.922040779605;7802.64888080035;7813.453058285922;7816.609169541529;7630;7720.07359116904;7772.106207786064;7780.80547986302;7804;7004.159500859879;7240.239774823621;7310.780676579711;7567.697292108309;7579.1662917079075;25647.102351417798;25868.870655646602;26008.479830403285;26117.347066323306;26224;3559.839807208682;3678.521792167028;3702.7222958278235;3706.962930370689;3736.9065773355883;15954.44159454425;16068.839311606851;16470.6705865882;16493.505194844172;17101.0594417307;2284.371797755614;2324.7442781294044;2335.848169868953;2398.568257713611;2420.7337192908767;102324.48837755763;110694.44652776765;113216;113697;118023.81976180214;18027.27890884376;18247.908760456114;19020.619587608446;19215.615687686448;19538.023098845002;31986.20034499156;32269.031929042165;32365.51451728179;32519.837400812845;32711.18222044468;10118.443485608363;10249.487525623688;10381.273310868317;10613.204009699304;10615.0446459819;8744.69393571222;8754.606042728092;8802.559872006503;8998.86501702475;9029.006809250977;8744.69393571222;9405.76485587852;9424.151826335663;9470.621175153054;9470.668526601536;3551.449525323579;3644.872429465009;3690.4464330350124;3750.3811871041516;3885.708571857122;978.7650963768644;984.2667212926416;988.313122379939;994.5723338964315;1001.7545701303227;20742.688859667116;21127.683084753742;21592.676109858363;21734.239301624682;22701.545969080526;1076.7738774857369;1081.9080378167787;1085.766560189563;1098.6594155811724;1107.6234080412698;11306.547738090549;11506.367149806842;11601.18791684574;11661.475233614508;11663.416829158678;724399;724503;729843;742066;743443;103658;104093.47953260185;119497.40251298688;122637;127583;1328.6346254780012;1359.5241665417025;1381.378379729126;1383.7370899529258;1399.3632897031623;19293.22827086957;19629.411117666492;19639.60720785605;19706.704399434308;19817.702734458708;52190.73904630452;53768.19347709709;53913.19130213129;54375.184372233656;55018.449815501335;67805.3219467799;68717.65641171762;68819.65590172217;69910;69979.30020699727;12577.308248046445;12958;12990.740185196431;13093.672658183621;13164.14433061848;14309.785353219502;14331.211783352015;14386.640333991734;14391.496297629532;14447.277636118362;11850.288982661068;11944.64166075019;11982.58060967862;12111.333876636869;12509.74980500403;11582;11876.049916006872;11914.702132446411;11969.222000569935;12199.207051541622;12605.306708130774;12783.744325113632;12985.545505907248;13056.412461439068;13212.933935330262;12475;12542.623721288375;12718.236905785683;12719.87280127187;12879.908821882493;12098.334591597546;12254.816177757519;12340.259584424604;12528.123031387715;12620.810687839874 12:06:43 INFO - PROCESS | 11345 | |3;mootools.html;1408.3169662713576;1525.6109692028535;1530.8163020437548;1544.1044194367269;1559.5009596928987;9289.117533834291;11300.830487542684;11597.768044639102;11647.592334268313;11652.941735291311;11677.824832627517;11785.587504437346;11786.29282243066;11786.882131178685;11789.29264244146;2038.4292398128473;2095.5075557244036;2462.679851619287;2497.9750202498017;2498.800095992325;2486.17956074495;2557.565213913639;2562.3337932137683;2565.3330134165067;2565.9230223093336;2459.6802415685934;2467.457159424933;2468.987655061731;2484.1305543059875;2487.5398051360467;2431.939201519976;2455.7175924768612;2460.729319774823;2462.3105530451503;2493.8628375439343;2321.558903808288;2322.268485427102;2325.1280769711357;2331.3122628824535;2332.6267797152373;11694.122940779476;11765.176437649368;11781.293122412597;11790.94104529472;11800.645980620595;5860.912086318666;5905.232319798399;5990.490808281302;6058.818235452899;6068.211132552784;3313.5692359993045;3451.4822776583464;3518.9120271993406;3520.190356218084;3543.8936831895085;1246.1401632873378;1262.7916393795106;1306.9281189534572;1314.599047290576;1321.5506727712527;18260.452186434428;18273;18282.451526454228;18300.35948741801;18345.082745862786;4928.852134435972;4962.751862406937;5063.1898896176435;5183.352080989876;5292.92060619091;14261.42954281817;14275.572442755642;14282.857171428153;14304.49934252317;14318.713625727427;6088.4215999479975;6096.573239873166;6103.755849766048;6107.053406721965;6107.144999700045;5499.450054994549;5517.668939863621;5564.248826408383;5577.52591029767;5590.944090559124;4153.252414565347;4246.851360202378;4333.220020396296;4467.084247729273;4469.374287599739;1122.910167186623;1132.394169119517;1150.1201580790703;1156.6298784388914;1156.919015668912;973.1582181413027;985.7194513653868;1003.9849402258972;1006.7835415385728;1008.0977525115128;7182.964085179645;7385.483016188923;7610.200928902496;7784.688612455551;7784.922150778533;1033.7570670892335;1063.6543123484744;1070.9196810239107;1084.322298563398;1096.736783172049;4726.456457507362;4767.213409787416;4838.927416088762;4897.289892965571;4958.181899986462;13743.244121573209;14144.080634758708;14152.787708184385;14541.78187327191;14702.338394772261;14473.27633618315;14498.710025799424;14524.20116893581;14566.053206541541;14591.562253132422;10866.348019118877;10940.945295273472;11009.834852477059;11166.776664466664;11203;7178.820529486805;7358.264173582599;7362.411007119525;7403.629818508945;7542;13690.151829502889;13694.726105478034;13758.862411375758;13870.722585548434;13905.930470347583;13794.103383280055;13867;13881.72236555243;14030.368633411317;14118.50585229512;9747.951260243653;9958.302918795614;9966.850497242402;10040.849387259343;10050.447225402673;10668.199885008811;10822.945885270523;10967.287126337082;10970.067544258827;11014.724631884266;9283.48940808235;9299.163075323253;9307.860382094139;9457.33798634089;9682.177014953526;9077.45535267886;9298.302627303116;9304.16262536375;9439.764005899633;9509.239260858976;8153.429259951747;8184.386171037077;8295.792605184919;8311.293540048922;8327.00075990885;6623.2383275923885;6641.900371494528;6658.400743933069;6658.500612453989;6747.291534388818;6478.384553467413;6557.901631475436;6671.933280667131;6803.081583986099;6887.380135787803 12:06:43 INFO - PROCESS | 11345 | |4;prototype.html;393.3683656339089;397.70967193948417;410.0834634591689;423.28676180635625;423.8601261583677;5232.424433312337;5276.393214780302;5281.260623512711;5294.814681486148;5321.148616221396;5086.542211200991;5131.948680513194;5225.190095535188;5233.581313494921;5262.289590905227;4397.758123303217;4418.248897687401;4422.800973956171;4433.514772551183;4462.768615692154;4479.776011199427;4492.415985921842;4497.820087196508;4514.503404625489;4547.772611369435;4327.805248763813;4426.313921342197;4456;4485.842995495158;4541.545845415465;4436.157130145294;4455.309427038814;4483.1843103543115;4495.483019452739;4504.391907092549;4182.372644103379;4185.414042034117;4198.307279298912;4201.894952626179;4276.572342765729;4893.975530122362;5061.645684802029;5091.9236211456855;5093.388793344822;5226.451222621608;5087.77893305604;5109.284700141983;5115.897682046376;5119.436861945183;5185.092608793484;5543.528800052;5551.141162301377;5582.413846546095;5583.944160558383;5595.7481913313995;4468.620167285784;4583.9541604583865;4601.976990115061;4614.700044497097;4623.2371658676275;5435.076037073707;5545.340075550158;5597.188407680904;5680.289963754531;5747.913781293242;4709.175894218498;4709.788059537329;4728.243481043085;4737.715737055788;4748.525147485224;4571.611413029863;4797.776566975399;4803.519648035169;4826.251930950708;4839.467658557556;4988.6507944444265;5035.571976382049;5064.696118232844;5114.974425127925;5174.223866420067;5551;5564.972175139179;5579.804706835242;5600.187972743929;5612.887742245214;1638.6886491566563;1652.818189999099;1654.586353411647;1674.626806019077;1681.0334057916746;1270.7649084919135;1275.5918106205925;1280.5198050730976;1290.8515520715239;1307.9215247085206;5391.164369522652;5471.534919531805;5537.224788529609;5553.222548843165;5554.972225138848;5695.772169113189;5697.236840132532;5708.315002199763;5710.65736055838;5726.911886741505;5203.985222881502;5400.83797486076;5401.891962160735;5417.566594672417;5469.371022332403;2956.2757124504205;2960.6743258241577;2981.344104297051;2985.880564777428;2990.2673844907704;5486.862828429321;5792.350818984013;5796.478316951495;5809.419058094157;5812.447817457335;5740.770369185186;5784.566157538202;5818.330891947396;5845.941540584625;5867.207926929896;5741.770329186869;5760.868478662922;5768.7980920668415;5817.621854579439;5831.70841457917;5386.245925570502;5685.800996965087;5702;5704.714764261853;5711.600187986801;5351.224072509543;5412.566994640498;5461.863453413537;5606.383297837153;5625.437456254342;5759.337676167294;5763.769449221984;5775.595708300379;5793.826185214451;5804.767809287581;4696.906061878675;4709.199436095941;4711.646626503095;4714.053716427233;4721.2918062289555;5531.3362396512675;5608.579356548356;5627.409122042291;5642.943570564242;5651.406602306699;5519.199716041071;5533.750981205936;5535.3634332050715;5550.55595552363;5587.189857470563;5261.31602891637;5488.313960754906;5504.2018907257425;5547.4758984662685;5548.389677135593;5481.314835645544;5516.834494965157;5525.922445123162;5542.7551841504255;5552.028395030934;5493.7802487900035;5520.696361700145;5531.419200983839;5543.805966791143;5578.609497335147;5336.7598458068705;5446.91061787652;5451.672899626035;5453.700046497481;5486.807961721321 12:06:43 INFO - PROCESS | 11345 | |5;yui.html;809.1099790230751;843.6372359885247;881.6189911688675;903.9231665308453;909.2771246858749;16680.666386672274;16709.331626734915;17260.482185534423;17448.651026979453;17551.297948082094;17199.656006879854;17377;17532.737008944878;17598.12009399528;17637.206325715342;877.714742708619;880.1682410122421;886.997692607356;888.995555022224;903.4985583001431;894.6421431427449;895.3642913531368;895.8656201569752;897.708244820436;897.712731925784;934.0052843721448;938.8263171313295;943.4999450291357;943.7782121201512;944.0417975754615;929.72573090938;931.6552875436064;932.2309094996621;936.0873148680016;936.4662142578733;684.9897251541231;685.5817951049855;685.8456847209338;686.9038334633156;687.6286805125277;18843;18927.24291028357;18930.148143333583;19595.90202048995;19797.40607781769;15607.765883511756;15885.682286354207;15964;16215.299428828022;16310.75533866993;14462.638434039129;14671.77992330116;14677.045992010486;14722.63193420173;14798;4116.629503344713;4148.191102734968;4153.06556024892;4177.3316269396755;4266.253405654029;67889.66055169742;87657;91438.54280728554;92712;93499;12152.57465988686;12259.080568957364;12290.139690221777;12321.137520373488;12378.257304561756;21202.78797212008;21238.78761212399;21305.78694213069;21308.467288317606;21465.78534214669;8725.650973961097;8769.605367758466;8807.07525709804;8821.751068026644;8926.910730892609;4668.183067963161;4784.330193772875;4807.375041244616;4886.804527818847;4932.506749325039;3831.4061320495366;3869.3808990561374;3901.08324543732;3999.1801680655394;4054.2094291612852;671.2046225223127;678.8302924268933;683.9042534045237;684.1824020295799;697.5744795674634;834.0866750907746;847.6100993542916;872.389327470773;875.8292133033997;878.6829717815299;11390.715232119097;11640.185187036826;11759.47082381295;11839.34883581394;11889.821652675217;670.9798706038827;686.0687165628739;686.4079309419965;689.5380095336137;693.3240090911422;5649.68926709035;5720.342160651495;5868.882622347529;5886.205362276123;5889.823305300848;77539;83585;84586.57706711427;85889;90471.54764226268;73440.2655973444;74879;76875.61562192265;78163.21836781673;78942;66622.66688666622;67015.32984670189;67481;67503.66248168825;69646;11057.06014988735;11105.944470277596;11113.166512511756;11412.429378531206;11480.483378248166;46825.531744682114;47447.76276118597;47823;47886.76056619694;48059;54193;54204.72897635487;54940;55184.17223741567;55901.72049139891;12585.93707031459;12879.35603219854;12961.15752476086;12993.155444896052;13048.217106973612;15192.392304308147;15448.753794535833;15635.609109772347;15685.372585096924;16548.42080527176;14103.647408814863;14289.928550357181;14304.642383940485;14421.639459013608;14764.114153150846;13586.116902401312;14263.71472570522;14322.785158222843;14342.211178385289;14457.855421446071;13632.318384080558;13712.65718357049;14000.649983750487;14214.928925355307;14727.55817325482;10464.790704185722;10493.790124197625;10606.787864242826;10790.460476976277;10997.450127493434;12341.259524428562;12437.75124497523;12505.93747031259;12541.874581254435;12636.87363126357 12:06:43 INFO - PROCESS | 11345 | __end_tp_report 12:06:43 INFO - PROCESS | 11345 | __start_cc_report 12:06:43 INFO - PROCESS | 11345 | _x_x_mozilla_cycle_collect,1205 12:06:43 INFO - PROCESS | 11345 | __end_cc_report 12:06:43 INFO - PROCESS | 11345 | __startTimestamp1495134403452__endTimestamp 12:06:43 INFO - PROCESS | 11345 | 12:06:43 INFO - PROCESS | 11345 | ------- Summary: start ------- 12:06:43 INFO - PROCESS | 11345 | Number of tests: 6 12:06:43 INFO - PROCESS | 11345 | 12:06:43 INFO - PROCESS | 11345 | [#0] dojo.html Cycles:165 Average:5712.52 Median:5936.17 stddev:647.21 (10.9%) stddev-sans-first:622.60 12:06:43 INFO - PROCESS | 11345 | Values: 3371.6 3418.9 3435.3 3451.3 3469.7 5691.4 5730.5 5738.7 5746.7 5765.1 5734.3 5781.1 5785.1 5785.9 5796.9 5207.0 5251.9 5257.8 5261.8 5307.7 5053.5 5085.8 5323.0 5352.3 5355.3 5202.8 5212.8 5231.7 5239.8 5252.3 5309.8 5322.9 5323.3 5330.0 5334.9 5003.9 5177.2 5237.0 5292.4 5296.4 5520.4 5647.1 5697.3 5773.6 5777.7 6156.5 6194.3 6203.4 6209.0 6209.2 6214.7 6233.4 6245.9 6256.2 6267.8 5550.0 5604.5 5708.2 5722.7 5750.4 6335.2 6337.5 6339.5 6347.7 6350.0 6046.2 6104.4 6104.4 6110.6 6110.9 5908.6 5930.8 6065.9 6187.9 6197.3 6115.2 6178.7 6184.3 6187.3 6193.4 5909.3 5917.5 5936.2 5938.6 6194.5 4501.4 4541.8 4572.4 4588.8 4592.0 4187.5 4195.5 4203.2 4218.8 4234.5 5732.6 5784.5 5873.5 5886.3 5962.5 6185.2 6201.7 6223.8 6226.0 6226.9 5958.8 5963.3 5976.0 5976.2 6006.9 5087.9 5109.6 5268.9 5273.2 5275.2 6217.2 6304.0 6373.6 6377.1 6383.3 6125.1 6215.7 6223.3 6227.4 6230.6 6104.2 6368.2 6377.2 6384.3 6385.7 5962.8 5980.1 5986.6 5997.7 6003.6 6131.3 6173.6 6173.8 6185.9 6188.4 6005.4 6009.7 6017.2 6022.1 6044.4 5751.4 5854.9 5972.7 5980.7 6094.3 6045.4 6056.8 6057.5 6064.4 6065.2 5854.3 5881.8 6061.0 6084.9 6088.0 5786.9 5849.5 5888.9 5901.0 5910.9 12:06:43 INFO - PROCESS | 11345 | 12:06:43 INFO - PROCESS | 11345 | [#1] ext.html Cycles:180 Average:46223.22 Median:29295.85 stddev:82877.54 (282.9%) stddev-sans-first:83039.75 12:06:43 INFO - PROCESS | 11345 | Values: 765.7 826.9 838.9 880.6 890.1 30573.7 41808.6 42406.2 42858.8 42881.4 40699.6 40931.4 40952.8 44803.8 45003.0 7636.3 7793.9 9197.9 9338.6 10791.5 10836.0 10907.6 10957.3 10957.7 10959.7 10982.5 11029.8 11033.9 11074.7 11077.4 10854.0 10880.7 10921.8 10960.4 10984.5 10705.5 10819.2 10824.8 10830.4 10843.2 41910.2 41922.4 41926.4 42137.6 42202.0 4265.7 4336.4 4367.5 4445.4 4566.9 26707.5 27114.6 27269.5 27679.6 28075.3 4425.5 4458.4 4502.8 4507.5 4554.9 250383.0 250571.0 251397.0 251545.7 252716.0 45293.8 45354.3 45489.8 45547.8 45556.0 46879.5 46949.3 46950.8 46956.3 47089.3 15727.3 15866.8 15906.4 15983.1 16093.7 11873.3 11997.2 12292.1 13917.7 13921.7 12732.4 12859.6 12906.6 12978.9 13068.8 5302.7 5503.3 5505.0 5557.2 5634.7 1029.2 1030.0 1041.6 1044.6 1049.1 28037.2 28219.9 28523.7 28623.4 28769.0 1098.5 1117.1 1119.9 1136.8 1145.0 14404.7 15062.9 15109.0 15269.7 15299.2 361340.0 363351.0 363351.0 363703.0 363868.0 54038.0 54311.2 54410.2 54649.7 54670.5 1471.8 1490.1 1519.3 1553.8 1560.0 25000.9 27790.7 28655.7 29059.0 29103.7 35126.5 35279.1 35384.0 35390.8 35417.5 321385.0 321508.0 322773.0 323372.0 323796.0 26094.2 29310.9 30149.2 30168.0 30406.7 28942.6 29090.0 29272.3 34184.5 35432.3 27256.2 28173.3 30040.4 30338.4 30879.4 29827.4 30269.8 30284.7 30419.2 30548.0 33988.5 34622.8 34987.3 34994.5 35129.6 28947.4 29032.3 29126.9 29280.9 29600.1 23242.3 24138.9 24299.3 24588.3 24648.0 12:06:43 INFO - PROCESS | 11345 | 12:06:43 INFO - PROCESS | 11345 | [#2] jquery.html Cycles:180 Average:40087.84 Median:22648.88 stddev:120398.24 (531.6%) stddev-sans-first:120699.15 12:06:43 INFO - PROCESS | 11345 | Values: 425.6 432.6 438.0 440.3 451.1 20621.4 21923.8 22309.4 22506.5 22596.2 22176.4 22752.2 23057.2 23173.9 23317.4 6856.2 7009.8 7060.0 7358.4 7618.4 7380.8 7612.7 7657.4 7663.7 7673.3 7746.7 7795.9 7802.6 7813.5 7816.6 7630.0 7720.1 7772.1 7780.8 7804.0 7004.2 7240.2 7310.8 7567.7 7579.2 25647.1 25868.9 26008.5 26117.3 26224.0 3559.8 3678.5 3702.7 3707.0 3736.9 15954.4 16068.8 16470.7 16493.5 17101.1 2284.4 2324.7 2335.8 2398.6 2420.7 102324.5 110694.4 113216.0 113697.0 118023.8 18027.3 18247.9 19020.6 19215.6 19538.0 31986.2 32269.0 32365.5 32519.8 32711.2 10118.4 10249.5 10381.3 10613.2 10615.0 8744.7 8754.6 8802.6 8998.9 9029.0 8744.7 9405.8 9424.2 9470.6 9470.7 3551.4 3644.9 3690.4 3750.4 3885.7 978.8 984.3 988.3 994.6 1001.8 20742.7 21127.7 21592.7 21734.2 22701.5 1076.8 1081.9 1085.8 1098.7 1107.6 11306.5 11506.4 11601.2 11661.5 11663.4 724399.0 724503.0 729843.0 742066.0 743443.0 103658.0 104093.5 119497.4 122637.0 127583.0 1328.6 1359.5 1381.4 1383.7 1399.4 19293.2 19629.4 19639.6 19706.7 19817.7 52190.7 53768.2 53913.2 54375.2 55018.4 67805.3 68717.7 68819.7 69910.0 69979.3 12577.3 12958.0 12990.7 13093.7 13164.1 14309.8 14331.2 14386.6 14391.5 14447.3 11850.3 11944.6 11982.6 12111.3 12509.7 11582.0 11876.0 11914.7 11969.2 12199.2 12605.3 12783.7 12985.5 13056.4 13212.9 12475.0 12542.6 12718.2 12719.9 12879.9 12098.3 12254.8 12340.3 12528.1 12620.8 12:06:43 INFO - PROCESS | 11345 | 12:06:43 INFO - PROCESS | 11345 | [#3] mootools.html Cycles:180 Average:7342.91 Median:2462.50 stddev:4732.37 (192.2%) stddev-sans-first:4724.63 12:06:43 INFO - PROCESS | 11345 | Values: 1408.3 1525.6 1530.8 1544.1 1559.5 9289.1 11300.8 11597.8 11647.6 11652.9 11677.8 11785.6 11786.3 11786.9 11789.3 2038.4 2095.5 2462.7 2498.0 2498.8 2486.2 2557.6 2562.3 2565.3 2565.9 2459.7 2467.5 2469.0 2484.1 2487.5 2431.9 2455.7 2460.7 2462.3 2493.9 2321.6 2322.3 2325.1 2331.3 2332.6 11694.1 11765.2 11781.3 11790.9 11800.6 5860.9 5905.2 5990.5 6058.8 6068.2 3313.6 3451.5 3518.9 3520.2 3543.9 1246.1 1262.8 1306.9 1314.6 1321.6 18260.5 18273.0 18282.5 18300.4 18345.1 4928.9 4962.8 5063.2 5183.4 5292.9 14261.4 14275.6 14282.9 14304.5 14318.7 6088.4 6096.6 6103.8 6107.1 6107.1 5499.5 5517.7 5564.2 5577.5 5590.9 4153.3 4246.9 4333.2 4467.1 4469.4 1122.9 1132.4 1150.1 1156.6 1156.9 973.2 985.7 1004.0 1006.8 1008.1 7183.0 7385.5 7610.2 7784.7 7784.9 1033.8 1063.7 1070.9 1084.3 1096.7 4726.5 4767.2 4838.9 4897.3 4958.2 13743.2 14144.1 14152.8 14541.8 14702.3 14473.3 14498.7 14524.2 14566.1 14591.6 10866.3 10940.9 11009.8 11166.8 11203.0 7178.8 7358.3 7362.4 7403.6 7542.0 13690.2 13694.7 13758.9 13870.7 13905.9 13794.1 13867.0 13881.7 14030.4 14118.5 9748.0 9958.3 9966.9 10040.8 10050.4 10668.2 10822.9 10967.3 10970.1 11014.7 9283.5 9299.2 9307.9 9457.3 9682.2 9077.5 9298.3 9304.2 9439.8 9509.2 8153.4 8184.4 8295.8 8311.3 8327.0 6623.2 6641.9 6658.4 6658.5 6747.3 6478.4 6557.9 6671.9 6803.1 6887.4 12:06:43 INFO - PROCESS | 11345 | 12:06:43 INFO - PROCESS | 11345 | [#4] prototype.html Cycles:180 Average:4822.96 Median:5307.98 stddev:1273.72 (24.0%) stddev-sans-first:1233.14 12:06:43 INFO - PROCESS | 11345 | Values: 393.4 397.7 410.1 423.3 423.9 5232.4 5276.4 5281.3 5294.8 5321.1 5086.5 5131.9 5225.2 5233.6 5262.3 4397.8 4418.2 4422.8 4433.5 4462.8 4479.8 4492.4 4497.8 4514.5 4547.8 4327.8 4426.3 4456.0 4485.8 4541.5 4436.2 4455.3 4483.2 4495.5 4504.4 4182.4 4185.4 4198.3 4201.9 4276.6 4894.0 5061.6 5091.9 5093.4 5226.5 5087.8 5109.3 5115.9 5119.4 5185.1 5543.5 5551.1 5582.4 5583.9 5595.7 4468.6 4584.0 4602.0 4614.7 4623.2 5435.1 5545.3 5597.2 5680.3 5747.9 4709.2 4709.8 4728.2 4737.7 4748.5 4571.6 4797.8 4803.5 4826.3 4839.5 4988.7 5035.6 5064.7 5115.0 5174.2 5551.0 5565.0 5579.8 5600.2 5612.9 1638.7 1652.8 1654.6 1674.6 1681.0 1270.8 1275.6 1280.5 1290.9 1307.9 5391.2 5471.5 5537.2 5553.2 5555.0 5695.8 5697.2 5708.3 5710.7 5726.9 5204.0 5400.8 5401.9 5417.6 5469.4 2956.3 2960.7 2981.3 2985.9 2990.3 5486.9 5792.4 5796.5 5809.4 5812.4 5740.8 5784.6 5818.3 5845.9 5867.2 5741.8 5760.9 5768.8 5817.6 5831.7 5386.2 5685.8 5702.0 5704.7 5711.6 5351.2 5412.6 5461.9 5606.4 5625.4 5759.3 5763.8 5775.6 5793.8 5804.8 4696.9 4709.2 4711.6 4714.1 4721.3 5531.3 5608.6 5627.4 5642.9 5651.4 5519.2 5533.8 5535.4 5550.6 5587.2 5261.3 5488.3 5504.2 5547.5 5548.4 5481.3 5516.8 5525.9 5542.8 5552.0 5493.8 5520.7 5531.4 5543.8 5578.6 5336.8 5446.9 5451.7 5453.7 5486.8 12:06:43 INFO - PROCESS | 11345 | 12:06:43 INFO - PROCESS | 11345 | [#5] yui.html Cycles:180 Average:19111.88 Median:25746.86 stddev:24259.92 (94.2%) stddev-sans-first:24289.05 12:06:43 INFO - PROCESS | 11345 | Values: 809.1 843.6 881.6 903.9 909.3 16680.7 16709.3 17260.5 17448.7 17551.3 17199.7 17377.0 17532.7 17598.1 17637.2 877.7 880.2 887.0 889.0 903.5 894.6 895.4 895.9 897.7 897.7 934.0 938.8 943.5 943.8 944.0 929.7 931.7 932.2 936.1 936.5 685.0 685.6 685.8 686.9 687.6 18843.0 18927.2 18930.1 19595.9 19797.4 15607.8 15885.7 15964.0 16215.3 16310.8 14462.6 14671.8 14677.0 14722.6 14798.0 4116.6 4148.2 4153.1 4177.3 4266.3 67889.7 87657.0 91438.5 92712.0 93499.0 12152.6 12259.1 12290.1 12321.1 12378.3 21202.8 21238.8 21305.8 21308.5 21465.8 8725.7 8769.6 8807.1 8821.8 8926.9 4668.2 4784.3 4807.4 4886.8 4932.5 3831.4 3869.4 3901.1 3999.2 4054.2 671.2 678.8 683.9 684.2 697.6 834.1 847.6 872.4 875.8 878.7 11390.7 11640.2 11759.5 11839.3 11889.8 671.0 686.1 686.4 689.5 693.3 5649.7 5720.3 5868.9 5886.2 5889.8 77539.0 83585.0 84586.6 85889.0 90471.5 73440.3 74879.0 76875.6 78163.2 78942.0 66622.7 67015.3 67481.0 67503.7 69646.0 11057.1 11105.9 11113.2 11412.4 11480.5 46825.5 47447.8 47823.0 47886.8 48059.0 54193.0 54204.7 54940.0 55184.2 55901.7 12585.9 12879.4 12961.2 12993.2 13048.2 15192.4 15448.8 15635.6 15685.4 16548.4 14103.6 14289.9 14304.6 14421.6 14764.1 13586.1 14263.7 14322.8 14342.2 14457.9 13632.3 13712.7 14000.6 14214.9 14727.6 10464.8 10493.8 10606.8 10790.5 10997.5 12341.3 12437.8 12505.9 12541.9 12636.9 12:06:43 INFO - PROCESS | 11345 | -------- Summary: end -------- 12:06:43 INFO - PROCESS | 11345 | 12:06:44 INFO - TEST-INFO | 11345: exit 0 12:06:44 INFO - TEST-OK | dromaeo_css | took 1115309ms 12:06:44 INFO - TEST-START | kraken 12:06:44 INFO - operating with platform_type : linux_ 12:06:44 INFO - Initialising browser for kraken test... 12:06:44 INFO - TEST-INFO | started process 11646 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP_H3r3/profile http://localhost:55676/getInfo.html) 12:06:48 INFO - PROCESS | 11646 | __metrics Screen width/height:1600/1200 12:06:48 INFO - PROCESS | 11646 | colorDepth:24 12:06:48 INFO - PROCESS | 11646 | Browser inner width/height: 1024/697 12:06:48 INFO - PROCESS | 11646 | __metrics 12:06:49 INFO - PROCESS | 11646 | 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:06:49 INFO - PROCESS | 11646 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:06:49 INFO - PROCESS | 11646 | console.error: PushService: 12:06:49 INFO - PROCESS | 11646 | stateChangeProcessEnqueue: Error transitioning state 12:06:49 INFO - PROCESS | 11646 | UnknownError 12:06:50 INFO - TEST-INFO | 11646: exit 0 12:06:50 INFO - Browser initialized. 12:06:50 INFO - Running cycle 1/1 for kraken test... 12:06:50 INFO - TEST-INFO | started process 11739 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP_H3r3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:07:02 INFO - PROCESS | 11739 | RSS: Main: 141611008 12:07:02 INFO - PROCESS | 11739 | 12:07:04 INFO - PROCESS | 11739 | Cycle 1(1): loaded http://localhost:55676/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55676/tests/kraken/driver.html?testName=audio-beat-detection) 12:07:05 INFO - PROCESS | 11739 | RSS: Main: 183271424 12:07:05 INFO - PROCESS | 11739 | 12:07:07 INFO - PROCESS | 11739 | Cycle 1(1): loaded http://localhost:55676/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55676/tests/kraken/driver.html?testName=audio-dft) 12:07:08 INFO - PROCESS | 11739 | RSS: Main: 173789184 12:07:08 INFO - PROCESS | 11739 | 12:07:11 INFO - PROCESS | 11739 | Cycle 1(1): loaded http://localhost:55676/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55676/tests/kraken/driver.html?testName=audio-fft) 12:07:11 INFO - PROCESS | 11739 | RSS: Main: 265461760 12:07:11 INFO - PROCESS | 11739 | 12:07:13 INFO - PROCESS | 11739 | Cycle 1(1): loaded http://localhost:55676/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55676/tests/kraken/driver.html?testName=audio-oscillator) 12:07:14 INFO - PROCESS | 11739 | RSS: Main: 171462656 12:07:14 INFO - PROCESS | 11739 | 12:07:16 INFO - PROCESS | 11739 | Cycle 1(1): loaded http://localhost:55676/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55676/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:07:17 INFO - PROCESS | 11739 | RSS: Main: 173674496 12:07:17 INFO - PROCESS | 11739 | 12:07:20 INFO - PROCESS | 11739 | Cycle 1(1): loaded http://localhost:55676/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55676/tests/kraken/driver.html?testName=imaging-darkroom) 12:07:20 INFO - PROCESS | 11739 | RSS: Main: 212434944 12:07:20 INFO - PROCESS | 11739 | 12:07:24 INFO - PROCESS | 11739 | Cycle 1(1): loaded http://localhost:55676/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55676/tests/kraken/driver.html?testName=imaging-desaturate) 12:07:24 INFO - PROCESS | 11739 | RSS: Main: 212746240 12:07:24 INFO - PROCESS | 11739 | 12:07:27 INFO - PROCESS | 11739 | Cycle 1(1): loaded http://localhost:55676/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55676/tests/kraken/driver.html?testName=json-parse-financial) 12:07:28 INFO - PROCESS | 11739 | RSS: Main: 211984384 12:07:28 INFO - PROCESS | 11739 | 12:07:29 INFO - PROCESS | 11739 | Cycle 1(1): loaded http://localhost:55676/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55676/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:07:30 INFO - PROCESS | 11739 | RSS: Main: 173903872 12:07:30 INFO - PROCESS | 11739 | 12:07:31 INFO - PROCESS | 11739 | Cycle 1(1): loaded http://localhost:55676/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55676/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:07:32 INFO - PROCESS | 11739 | RSS: Main: 180785152 12:07:32 INFO - PROCESS | 11739 | 12:07:34 INFO - PROCESS | 11739 | Cycle 1(1): loaded http://localhost:55676/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55676/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:07:35 INFO - PROCESS | 11739 | RSS: Main: 185679872 12:07:35 INFO - PROCESS | 11739 | 12:07:37 INFO - PROCESS | 11739 | Cycle 1(1): loaded http://localhost:55676/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55676/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:07:38 INFO - PROCESS | 11739 | RSS: Main: 181796864 12:07:38 INFO - PROCESS | 11739 | 12:07:40 INFO - PROCESS | 11739 | Cycle 1(1): loaded http://localhost:55676/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55676/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:07:41 INFO - PROCESS | 11739 | RSS: Main: 185143296 12:07:41 INFO - PROCESS | 11739 | 12:07:43 INFO - PROCESS | 11739 | Cycle 1(1): loaded http://localhost:55676/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55676/tests/kraken/driver.html?testName=ai-astar) 12:07:43 INFO - PROCESS | 11739 | RSS: Main: 238252032 12:07:43 INFO - PROCESS | 11739 | 12:07:43 INFO - PROCESS | 11739 | __start_tp_report 12:07:43 INFO - PROCESS | 11739 | _x_x_mozilla_page_load 12:07:43 INFO - PROCESS | 11739 | _x_x_mozilla_page_load_details 12:07:43 INFO - PROCESS | 11739 | |i|pagename|runs| 12:07:43 INFO - PROCESS | 11739 | |0;ai-astar;104;113;112;113;113;112;113;112;112;112 12:07:43 INFO - PROCESS | 11739 | |1;audio-beat-detection;143;115;119;153;116;116;115;115;136;116 12:07:43 INFO - PROCESS | 11739 | |2;audio-dft;160;161;162;167;161;161;161;160;160;162 12:07:43 INFO - PROCESS | 11739 | |3;audio-fft;76;76;76;122;78;76;75;75;89;85 12:07:43 INFO - PROCESS | 11739 | |4;audio-oscillator;82;83;102;82;82;81;95;82;83;106 12:07:43 INFO - PROCESS | 11739 | |5;imaging-gaussian-blur;113;113;112;113;113;113;113;113;113;112 12:07:43 INFO - PROCESS | 11739 | |6;imaging-darkroom;147;146;147;147;145;147;146;146;146;145 12:07:43 INFO - PROCESS | 11739 | |7;imaging-desaturate;94;94;94;93;93;94;94;93;94;93 12:07:43 INFO - PROCESS | 11739 | |8;json-parse-financial;56;54;53;53;55;54;56;53;54;54 12:07:43 INFO - PROCESS | 11739 | |9;json-stringify-tinderbox;54;53;54;54;54;53;53;54;56;54 12:07:43 INFO - PROCESS | 11739 | |10;stanford-crypto-aes;80;76;79;79;77;79;84;79;79;103 12:07:43 INFO - PROCESS | 11739 | |11;stanford-crypto-ccm;121;119;124;126;123;119;118;127;119;120 12:07:43 INFO - PROCESS | 11739 | |12;stanford-crypto-pbkdf2;160;157;156;164;160;156;158;158;159;159 12:07:43 INFO - PROCESS | 11739 | |13;stanford-crypto-sha256-iterative;61;60;59;60;58;59;59;60;58;58 12:07:43 INFO - PROCESS | 11739 | __end_tp_report 12:07:43 INFO - PROCESS | 11739 | __start_cc_report 12:07:43 INFO - PROCESS | 11739 | _x_x_mozilla_cycle_collect,1649 12:07:43 INFO - PROCESS | 11739 | __end_cc_report 12:07:43 INFO - PROCESS | 11739 | __startTimestamp1495134463371__endTimestamp 12:07:43 INFO - PROCESS | 11739 | 12:07:43 INFO - PROCESS | 11739 | ------- Summary: start ------- 12:07:43 INFO - PROCESS | 11739 | Number of tests: 14 12:07:43 INFO - PROCESS | 11739 | 12:07:43 INFO - PROCESS | 11739 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.50 stddev:2.72 (2.4%) stddev-sans-first:0.53 12:07:43 INFO - PROCESS | 11739 | Values: 104.0 113.0 112.0 113.0 113.0 112.0 113.0 112.0 112.0 112.0 12:07:43 INFO - PROCESS | 11739 | 12:07:43 INFO - PROCESS | 11739 | [#1] audio-beat-detection Cycles:10 Average:124.40 Median:117.50 stddev:14.16 (12.1%) stddev-sans-first:13.32 12:07:43 INFO - PROCESS | 11739 | Values: 143.0 115.0 119.0 153.0 116.0 116.0 115.0 115.0 136.0 116.0 12:07:43 INFO - PROCESS | 11739 | 12:07:43 INFO - PROCESS | 11739 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.00 stddev:2.07 (1.3%) stddev-sans-first:2.12 12:07:43 INFO - PROCESS | 11739 | Values: 160.0 161.0 162.0 167.0 161.0 161.0 161.0 160.0 160.0 162.0 12:07:43 INFO - PROCESS | 11739 | 12:07:43 INFO - PROCESS | 11739 | [#3] audio-fft Cycles:10 Average:82.80 Median:76.00 stddev:14.57 (19.2%) stddev-sans-first:15.24 12:07:43 INFO - PROCESS | 11739 | Values: 76.0 76.0 76.0 122.0 78.0 76.0 75.0 75.0 89.0 85.0 12:07:43 INFO - PROCESS | 11739 | 12:07:43 INFO - PROCESS | 11739 | [#4] audio-oscillator Cycles:10 Average:87.80 Median:82.00 stddev:9.50 (11.6%) stddev-sans-first:9.84 12:07:43 INFO - PROCESS | 11739 | Values: 82.0 83.0 102.0 82.0 82.0 81.0 95.0 82.0 83.0 106.0 12:07:43 INFO - PROCESS | 11739 | 12:07:43 INFO - PROCESS | 11739 | [#5] imaging-gaussian-blur Cycles:10 Average:112.80 Median:113.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 12:07:43 INFO - PROCESS | 11739 | Values: 113.0 113.0 112.0 113.0 113.0 113.0 113.0 113.0 113.0 112.0 12:07:43 INFO - PROCESS | 11739 | 12:07:43 INFO - PROCESS | 11739 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 12:07:43 INFO - PROCESS | 11739 | Values: 147.0 146.0 147.0 147.0 145.0 147.0 146.0 146.0 146.0 145.0 12:07:43 INFO - PROCESS | 11739 | 12:07:43 INFO - PROCESS | 11739 | [#7] imaging-desaturate Cycles:10 Average:93.60 Median:94.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 12:07:43 INFO - PROCESS | 11739 | Values: 94.0 94.0 94.0 93.0 93.0 94.0 94.0 93.0 94.0 93.0 12:07:43 INFO - PROCESS | 11739 | 12:07:43 INFO - PROCESS | 11739 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.00 stddev:1.14 (2.1%) stddev-sans-first:1.00 12:07:43 INFO - PROCESS | 11739 | Values: 56.0 54.0 53.0 53.0 55.0 54.0 56.0 53.0 54.0 54.0 12:07:43 INFO - PROCESS | 11739 | 12:07:43 INFO - PROCESS | 11739 | [#9] json-stringify-tinderbox Cycles:10 Average:53.90 Median:54.00 stddev:0.88 (1.6%) stddev-sans-first:0.93 12:07:43 INFO - PROCESS | 11739 | Values: 54.0 53.0 54.0 54.0 54.0 53.0 53.0 54.0 56.0 54.0 12:07:43 INFO - PROCESS | 11739 | 12:07:43 INFO - PROCESS | 11739 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:79.00 stddev:7.84 (9.9%) stddev-sans-first:8.29 12:07:43 INFO - PROCESS | 11739 | Values: 80.0 76.0 79.0 79.0 77.0 79.0 84.0 79.0 79.0 103.0 12:07:43 INFO - PROCESS | 11739 | 12:07:43 INFO - PROCESS | 11739 | [#11] stanford-crypto-ccm Cycles:10 Average:121.60 Median:122.00 stddev:3.20 (2.6%) stddev-sans-first:3.39 12:07:43 INFO - PROCESS | 11739 | Values: 121.0 119.0 124.0 126.0 123.0 119.0 118.0 127.0 119.0 120.0 12:07:43 INFO - PROCESS | 11739 | 12:07:43 INFO - PROCESS | 11739 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.70 Median:159.00 stddev:2.36 (1.5%) stddev-sans-first:2.46 12:07:43 INFO - PROCESS | 11739 | Values: 160.0 157.0 156.0 164.0 160.0 156.0 158.0 158.0 159.0 159.0 12:07:43 INFO - PROCESS | 11739 | 12:07:43 INFO - PROCESS | 11739 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.20 Median:59.50 stddev:1.03 (1.7%) stddev-sans-first:0.87 12:07:43 INFO - PROCESS | 11739 | Values: 61.0 60.0 59.0 60.0 58.0 59.0 59.0 60.0 58.0 58.0 12:07:43 INFO - PROCESS | 11739 | -------- Summary: end -------- 12:07:43 INFO - PROCESS | 11739 | 12:07:44 INFO - TEST-INFO | 11739: exit 0 12:07:44 INFO - TEST-OK | kraken | took 60269ms 12:07:44 INFO - SUITE-END | took 1175s 12:07:44 INFO - Completed test suite (00:19:35) 12:07:44 INFO - javascript benchmark 12:07:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7890.540588604792, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3371.6459771723967, 3418.9487157692633, 3435.278591495784, 3451.32699123671, 3469.7397695172854, 5691.3739488656265, 5730.512906402951, 5738.713064346787, 5746.683932383718, 5765.077587585987, 5734.283214598176, 5781.075027995522, 5785.132230165466, 5785.942140578593, 5796.913046304308, 5206.999999999991, 5251.921221181686, 5257.842264732045, 5261.763220655061, 5307.73461326934, 5053.469385714502, 5085.821996230133, 5322.973385133069, 5352.330958630171, 5355.303810504648, 5202.843914682566, 5212.8436146915465, 5231.73841307935, 5239.79040838366, 5252.290940722992, 5309.840704778863, 5322.946770532303, 5323.30796996388, 5330.040592693333, 5334.866628334323, 5003.899922001576, 5177.249298851683, 5237.031149237403, 5292.391374991887, 5296.364436267672, 5520.420355862657, 5647.124695672177, 5697.31632204134, 5773.566982476331, 5777.653340799566, 6156.507479401637, 6194.34959329273, 6203.441690247854, 6209.0, 6209.16176316196, 6214.65819379934, 6233.438990490878, 6245.906311405332, 6256.1866957295715, 6267.843303917393, 5549.972250138723, 5604.467575580314, 5708.20085188074, 5722.713864306768, 5750.4249575042995, 6335.208098987627, 6337.493000559944, 6339.461145802658, 6347.714352854133, 6350.0, 6046.244219472566, 6104.38956104386, 6104.4200800923845, 6110.5722599418505, 6110.908336374958, 5908.645481271137, 5930.792422265286, 6065.909011364833, 6187.938120618826, 6197.349278325801, 6115.240341084353, 6178.66017369049, 6184.257889053342, 6187.319394866561, 6193.38066193377, 5909.3204281507315, 5917.467427931507, 5936.168936348915, 5938.584299099108, 6194.535409844189, 4501.369808226851, 4541.795619197144, 4572.359869618256, 4588.77056147198, 4591.977040114778, 4187.539370669224, 4195.475565554306, 4203.159368126387, 4218.831246750157, 4234.513031001413, 5732.598718089694, 5784.537237021028, 5873.530117590582, 5886.3230728465915, 5962.493188078975, 6185.195924529782, 6201.658908760061, 6223.844403889939, 6226.034964580497, 6226.906596401058, 5958.76164953397, 5963.344032156459, 5976.0, 5976.193213916065, 6006.939930600725, 5087.872803179876, 5109.642325037212, 5268.894622107537, 5273.182656688219, 5275.182346736262, 6217.222847144107, 6304.0, 6373.5857169283845, 6377.1390862233, 6383.2978372379, 6125.111858780541, 6215.720292586754, 6223.315435302023, 6227.408396202353, 6230.563860529719, 6104.236970378703, 6368.23581170244, 6377.17096777416, 6384.265809431789, 6385.680715964276, 5962.761489540369, 5980.102984552178, 5986.580939334379, 5997.6701281428195, 6003.6397816131175, 6131.333054409885, 6173.59871608362, 6173.81478555644, 6185.938140618537, 6188.3502232266765, 6005.3694362091355, 6009.729562169626, 6017.15759793638, 6022.126791615279, 6044.395560443921, 5751.396103409249, 5854.853628659318, 5972.671503067373, 5980.700964951648, 6094.299155596986, 6045.395460453919, 6056.848578785565, 6057.454829065406, 6064.363241859542, 6065.2418447694035, 5854.326752423355, 5881.823545293648, 6061.0, 6084.908726369196, 6088.025915853442, 5786.913196302143, 5849.502792262705, 5888.852778680567, 5900.970495147497, 5910.881782364243], "value": 5669.68736815113, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [765.7281665008921, 826.921442462966, 838.9412741108123, 880.5773228850152, 890.0698769785573, 30573.69426305736, 41808.581914180846, 42406.151876962445, 42858.78570607142, 42881.35677964829, 40699.59300406995, 40931.386029209585, 40952.795236023856, 44803.77598112013, 45003.0, 7636.312731854132, 7793.883091753628, 9197.862032069508, 9338.57976391064, 10791.514381852836, 10836.0, 10907.618233361834, 10957.342559446419, 10957.726056848604, 10959.671209863676, 10982.450877456135, 11029.83455248172, 11033.944830275837, 11074.667759967213, 11077.390743509144, 10854.023137917586, 10880.727981800439, 10921.781564368708, 10960.397178155199, 10984.450777461136, 10705.46472676363, 10819.188560857967, 10824.78350432987, 10830.40432776197, 10843.240973131884, 41910.161796763896, 41922.37116443256, 41926.371104433456, 42137.57862421398, 42202.0, 4265.680073994432, 4336.3712261722185, 4367.45406824147, 4445.422095127613, 4566.908661826745, 26707.531959287764, 27114.5932811008, 27269.45461090767, 27679.584806227922, 28075.29811754702, 4425.468943726773, 4458.4426946631675, 4502.819887204508, 4507.4591049074, 4554.8861278467975, 250383.0, 250571.0, 251397.0, 251545.74227128932, 252716.0, 45293.77353113279, 45354.31968520475, 45489.77255113769, 45547.77226113848, 45556.0, 46879.53120468752, 46949.29576056362, 46950.76524617355, 46956.29565556519, 47089.29366059512, 15727.292271847795, 15866.841331586536, 15906.363745450053, 15983.120928349052, 16093.67812643764, 11873.28760274369, 11997.220180688228, 12292.139550231577, 13917.721645567235, 13921.651958701113, 12732.363381830872, 12859.614211573667, 12906.612801615778, 12978.870211297955, 13068.803967940488, 5302.674331417145, 5503.3395992481155, 5505.0, 5557.166425036196, 5634.746436410372, 1029.1818004686293, 1030.0472063341379, 1041.5677493839971, 1044.5926088825213, 1049.0872940541778, 28037.158885233475, 28219.858900705363, 28523.71476285252, 28623.427531449255, 28769.0, 1098.4507746126937, 1117.0616681987008, 1119.9160062995309, 1136.846525719034, 1145.0438883532177, 14404.711905761826, 15062.924685376503, 15109.0, 15269.694606107816, 15299.15854627984, 361340.0, 363351.0, 363351.0, 363703.0, 363868.0, 54038.0, 54311.18533222005, 54410.183847242326, 54649.72675136599, 54670.453295467334, 1471.8454562270808, 1490.0612614052861, 1519.308714534884, 1553.7591673290658, 1559.954830263726, 25000.874995624905, 27790.722092778815, 28655.713442866137, 29058.965872389577, 29103.7089629101, 35126.47310290399, 35279.11802204965, 35383.99999999897, 35390.82304588461, 35417.46873796843, 321385.0, 321508.0, 322773.0, 323372.0, 323796.0, 26094.217173484827, 29310.853445732635, 30149.246268843453, 30168.0, 30406.695933040388, 28942.565861511674, 29090.0, 29272.26819329534, 34184.48723269103, 35432.291354173285, 27256.198677348595, 28173.295667607654, 30040.3991920156, 30338.393232134793, 30879.382412351177, 29827.403451931274, 30269.848650757485, 30284.697153028188, 30419.239519011317, 30548.0, 33988.49017264693, 34622.82688586541, 34987.30025399529, 34994.475082873265, 35129.64870351264, 28947.421051579273, 29032.274193145342, 29126.854365728035, 29280.853595731885, 29600.111996640135, 23242.327132379993, 24138.87930560336, 24299.271021869372, 24588.262352129466, 24648.014079436623], "value": 18345.35415733105, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.6161536177372, 432.59547362259025, 437.97372157670543, 440.27574639717665, 451.0910515311647, 20621.38135855923, 21923.780762192393, 22309.44226394341, 22506.54986900261, 22596.20913268036, 22176.445588860246, 22752.203672871452, 23057.192998245064, 23173.884130579365, 23317.417064573394, 6856.24581296057, 7009.82475438113, 7060.011598376232, 7358.374538164236, 7618.428617853656, 7380.815479612999, 7612.695492180306, 7657.387409007294, 7663.655135518915, 7673.27103925129, 7746.690132394698, 7795.922040779605, 7802.64888080035, 7813.453058285922, 7816.609169541529, 7630.0, 7720.07359116904, 7772.106207786064, 7780.80547986302, 7804.0, 7004.159500859879, 7240.239774823621, 7310.780676579711, 7567.697292108309, 7579.1662917079075, 25647.102351417798, 25868.870655646602, 26008.479830403285, 26117.347066323306, 26224.0, 3559.839807208682, 3678.521792167028, 3702.7222958278235, 3706.962930370689, 3736.9065773355883, 15954.44159454425, 16068.839311606851, 16470.6705865882, 16493.505194844172, 17101.0594417307, 2284.371797755614, 2324.7442781294044, 2335.848169868953, 2398.568257713611, 2420.7337192908767, 102324.48837755763, 110694.44652776765, 113216.0, 113697.0, 118023.81976180214, 18027.27890884376, 18247.908760456114, 19020.619587608446, 19215.615687686448, 19538.023098845002, 31986.20034499156, 32269.031929042165, 32365.51451728179, 32519.837400812845, 32711.18222044468, 10118.443485608363, 10249.487525623688, 10381.273310868317, 10613.204009699304, 10615.0446459819, 8744.69393571222, 8754.606042728092, 8802.559872006503, 8998.86501702475, 9029.006809250977, 8744.69393571222, 9405.76485587852, 9424.151826335663, 9470.621175153054, 9470.668526601536, 3551.449525323579, 3644.872429465009, 3690.4464330350124, 3750.3811871041516, 3885.708571857122, 978.7650963768644, 984.2667212926416, 988.313122379939, 994.5723338964315, 1001.7545701303227, 20742.688859667116, 21127.683084753742, 21592.676109858363, 21734.239301624682, 22701.545969080526, 1076.7738774857369, 1081.9080378167787, 1085.766560189563, 1098.6594155811724, 1107.6234080412698, 11306.547738090549, 11506.367149806842, 11601.18791684574, 11661.475233614508, 11663.416829158678, 724399.0, 724503.0, 729843.0, 742066.0, 743443.0, 103658.0, 104093.47953260185, 119497.40251298688, 122637.0, 127583.0, 1328.6346254780012, 1359.5241665417025, 1381.378379729126, 1383.7370899529258, 1399.3632897031623, 19293.22827086957, 19629.411117666492, 19639.60720785605, 19706.704399434308, 19817.702734458708, 52190.73904630452, 53768.19347709709, 53913.19130213129, 54375.184372233656, 55018.449815501335, 67805.3219467799, 68717.65641171762, 68819.65590172217, 69910.0, 69979.30020699727, 12577.308248046445, 12958.0, 12990.740185196431, 13093.672658183621, 13164.14433061848, 14309.785353219502, 14331.211783352015, 14386.640333991734, 14391.496297629532, 14447.277636118362, 11850.288982661068, 11944.64166075019, 11982.58060967862, 12111.333876636869, 12509.74980500403, 11582.0, 11876.049916006872, 11914.702132446411, 11969.222000569935, 12199.207051541622, 12605.306708130774, 12783.744325113632, 12985.545505907248, 13056.412461439068, 13212.933935330262, 12475.0, 12542.623721288375, 12718.236905785683, 12719.87280127187, 12879.908821882493, 12098.334591597546, 12254.816177757519, 12340.259584424604, 12528.123031387715, 12620.810687839874], "value": 11900.824613766597, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1408.3169662713576, 1525.6109692028535, 1530.8163020437548, 1544.1044194367269, 1559.5009596928987, 9289.117533834291, 11300.830487542684, 11597.768044639102, 11647.592334268313, 11652.941735291311, 11677.824832627517, 11785.587504437346, 11786.29282243066, 11786.882131178685, 11789.29264244146, 2038.4292398128473, 2095.5075557244036, 2462.679851619287, 2497.9750202498017, 2498.800095992325, 2486.17956074495, 2557.565213913639, 2562.3337932137683, 2565.3330134165067, 2565.9230223093336, 2459.6802415685934, 2467.457159424933, 2468.987655061731, 2484.1305543059875, 2487.5398051360467, 2431.939201519976, 2455.7175924768612, 2460.729319774823, 2462.3105530451503, 2493.8628375439343, 2321.558903808288, 2322.268485427102, 2325.1280769711357, 2331.3122628824535, 2332.6267797152373, 11694.122940779476, 11765.176437649368, 11781.293122412597, 11790.94104529472, 11800.645980620595, 5860.912086318666, 5905.232319798399, 5990.490808281302, 6058.818235452899, 6068.211132552784, 3313.5692359993045, 3451.4822776583464, 3518.9120271993406, 3520.190356218084, 3543.8936831895085, 1246.1401632873378, 1262.7916393795106, 1306.9281189534572, 1314.599047290576, 1321.5506727712527, 18260.452186434428, 18273.0, 18282.451526454228, 18300.35948741801, 18345.082745862786, 4928.852134435972, 4962.751862406937, 5063.1898896176435, 5183.352080989876, 5292.92060619091, 14261.42954281817, 14275.572442755642, 14282.857171428153, 14304.49934252317, 14318.713625727427, 6088.4215999479975, 6096.573239873166, 6103.755849766048, 6107.053406721965, 6107.144999700045, 5499.450054994549, 5517.668939863621, 5564.248826408383, 5577.52591029767, 5590.944090559124, 4153.252414565347, 4246.851360202378, 4333.220020396296, 4467.084247729273, 4469.374287599739, 1122.910167186623, 1132.394169119517, 1150.1201580790703, 1156.6298784388914, 1156.919015668912, 973.1582181413027, 985.7194513653868, 1003.9849402258972, 1006.7835415385728, 1008.0977525115128, 7182.964085179645, 7385.483016188923, 7610.200928902496, 7784.688612455551, 7784.922150778533, 1033.7570670892335, 1063.6543123484744, 1070.9196810239107, 1084.322298563398, 1096.736783172049, 4726.456457507362, 4767.213409787416, 4838.927416088762, 4897.289892965571, 4958.181899986462, 13743.244121573209, 14144.080634758708, 14152.787708184385, 14541.78187327191, 14702.338394772261, 14473.27633618315, 14498.710025799424, 14524.20116893581, 14566.053206541541, 14591.562253132422, 10866.348019118877, 10940.945295273472, 11009.834852477059, 11166.776664466664, 11203.0, 7178.820529486805, 7358.264173582599, 7362.411007119525, 7403.629818508945, 7542.0, 13690.151829502889, 13694.726105478034, 13758.862411375758, 13870.722585548434, 13905.930470347583, 13794.103383280055, 13867.0, 13881.72236555243, 14030.368633411317, 14118.50585229512, 9747.951260243653, 9958.302918795614, 9966.850497242402, 10040.849387259343, 10050.447225402673, 10668.199885008811, 10822.945885270523, 10967.287126337082, 10970.067544258827, 11014.724631884266, 9283.48940808235, 9299.163075323253, 9307.860382094139, 9457.33798634089, 9682.177014953526, 9077.45535267886, 9298.302627303116, 9304.16262536375, 9439.764005899633, 9509.239260858976, 8153.429259951747, 8184.386171037077, 8295.792605184919, 8311.293540048922, 8327.00075990885, 6623.2383275923885, 6641.900371494528, 6658.400743933069, 6658.500612453989, 6747.291534388818, 6478.384553467413, 6557.901631475436, 6671.933280667131, 6803.081583986099, 6887.380135787803], "value": 5519.99367340877, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.3683656339089, 397.70967193948417, 410.0834634591689, 423.28676180635625, 423.8601261583677, 5232.424433312337, 5276.393214780302, 5281.260623512711, 5294.814681486148, 5321.148616221396, 5086.542211200991, 5131.948680513194, 5225.190095535188, 5233.581313494921, 5262.289590905227, 4397.758123303217, 4418.248897687401, 4422.800973956171, 4433.514772551183, 4462.768615692154, 4479.776011199427, 4492.415985921842, 4497.820087196508, 4514.503404625489, 4547.772611369435, 4327.805248763813, 4426.313921342197, 4456.0, 4485.842995495158, 4541.545845415465, 4436.157130145294, 4455.309427038814, 4483.1843103543115, 4495.483019452739, 4504.391907092549, 4182.372644103379, 4185.414042034117, 4198.307279298912, 4201.894952626179, 4276.572342765729, 4893.975530122362, 5061.645684802029, 5091.9236211456855, 5093.388793344822, 5226.451222621608, 5087.77893305604, 5109.284700141983, 5115.897682046376, 5119.436861945183, 5185.092608793484, 5543.528800052, 5551.141162301377, 5582.413846546095, 5583.944160558383, 5595.7481913313995, 4468.620167285784, 4583.9541604583865, 4601.976990115061, 4614.700044497097, 4623.2371658676275, 5435.076037073707, 5545.340075550158, 5597.188407680904, 5680.289963754531, 5747.913781293242, 4709.175894218498, 4709.788059537329, 4728.243481043085, 4737.715737055788, 4748.525147485224, 4571.611413029863, 4797.776566975399, 4803.519648035169, 4826.251930950708, 4839.467658557556, 4988.6507944444265, 5035.571976382049, 5064.696118232844, 5114.974425127925, 5174.223866420067, 5551.0, 5564.972175139179, 5579.804706835242, 5600.187972743929, 5612.887742245214, 1638.6886491566563, 1652.818189999099, 1654.586353411647, 1674.626806019077, 1681.0334057916746, 1270.7649084919135, 1275.5918106205925, 1280.5198050730976, 1290.8515520715239, 1307.9215247085206, 5391.164369522652, 5471.534919531805, 5537.224788529609, 5553.222548843165, 5554.972225138848, 5695.772169113189, 5697.236840132532, 5708.315002199763, 5710.65736055838, 5726.911886741505, 5203.985222881502, 5400.83797486076, 5401.891962160735, 5417.566594672417, 5469.371022332403, 2956.2757124504205, 2960.6743258241577, 2981.344104297051, 2985.880564777428, 2990.2673844907704, 5486.862828429321, 5792.350818984013, 5796.478316951495, 5809.419058094157, 5812.447817457335, 5740.770369185186, 5784.566157538202, 5818.330891947396, 5845.941540584625, 5867.207926929896, 5741.770329186869, 5760.868478662922, 5768.7980920668415, 5817.621854579439, 5831.70841457917, 5386.245925570502, 5685.800996965087, 5702.0, 5704.714764261853, 5711.600187986801, 5351.224072509543, 5412.566994640498, 5461.863453413537, 5606.383297837153, 5625.437456254342, 5759.337676167294, 5763.769449221984, 5775.595708300379, 5793.826185214451, 5804.767809287581, 4696.906061878675, 4709.199436095941, 4711.646626503095, 4714.053716427233, 4721.2918062289555, 5531.3362396512675, 5608.579356548356, 5627.409122042291, 5642.943570564242, 5651.406602306699, 5519.199716041071, 5533.750981205936, 5535.3634332050715, 5550.55595552363, 5587.189857470563, 5261.31602891637, 5488.313960754906, 5504.2018907257425, 5547.4758984662685, 5548.389677135593, 5481.314835645544, 5516.834494965157, 5525.922445123162, 5542.7551841504255, 5552.028395030934, 5493.7802487900035, 5520.696361700145, 5531.419200983839, 5543.805966791143, 5578.609497335147, 5336.7598458068705, 5446.91061787652, 5451.672899626035, 5453.700046497481, 5486.807961721321], "value": 4450.308733583624, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [809.1099790230751, 843.6372359885247, 881.6189911688675, 903.9231665308453, 909.2771246858749, 16680.666386672274, 16709.331626734915, 17260.482185534423, 17448.651026979453, 17551.297948082094, 17199.656006879854, 17377.0, 17532.737008944878, 17598.12009399528, 17637.206325715342, 877.714742708619, 880.1682410122421, 886.997692607356, 888.995555022224, 903.4985583001431, 894.6421431427449, 895.3642913531368, 895.8656201569752, 897.708244820436, 897.712731925784, 934.0052843721448, 938.8263171313295, 943.4999450291357, 943.7782121201512, 944.0417975754615, 929.72573090938, 931.6552875436064, 932.2309094996621, 936.0873148680016, 936.4662142578733, 684.9897251541231, 685.5817951049855, 685.8456847209338, 686.9038334633156, 687.6286805125277, 18843.0, 18927.24291028357, 18930.148143333583, 19595.90202048995, 19797.40607781769, 15607.765883511756, 15885.682286354207, 15964.0, 16215.299428828022, 16310.75533866993, 14462.638434039129, 14671.77992330116, 14677.045992010486, 14722.63193420173, 14798.0, 4116.629503344713, 4148.191102734968, 4153.06556024892, 4177.3316269396755, 4266.253405654029, 67889.66055169742, 87657.0, 91438.54280728554, 92712.0, 93499.0, 12152.57465988686, 12259.080568957364, 12290.139690221777, 12321.137520373488, 12378.257304561756, 21202.78797212008, 21238.78761212399, 21305.78694213069, 21308.467288317606, 21465.78534214669, 8725.650973961097, 8769.605367758466, 8807.07525709804, 8821.751068026644, 8926.910730892609, 4668.183067963161, 4784.330193772875, 4807.375041244616, 4886.804527818847, 4932.506749325039, 3831.4061320495366, 3869.3808990561374, 3901.08324543732, 3999.1801680655394, 4054.2094291612852, 671.2046225223127, 678.8302924268933, 683.9042534045237, 684.1824020295799, 697.5744795674634, 834.0866750907746, 847.6100993542916, 872.389327470773, 875.8292133033997, 878.6829717815299, 11390.715232119097, 11640.185187036826, 11759.47082381295, 11839.34883581394, 11889.821652675217, 670.9798706038827, 686.0687165628739, 686.4079309419965, 689.5380095336137, 693.3240090911422, 5649.68926709035, 5720.342160651495, 5868.882622347529, 5886.205362276123, 5889.823305300848, 77539.0, 83585.0, 84586.57706711427, 85889.0, 90471.54764226268, 73440.2655973444, 74879.0, 76875.61562192265, 78163.21836781673, 78942.0, 66622.66688666622, 67015.32984670189, 67481.0, 67503.66248168825, 69646.0, 11057.06014988735, 11105.944470277596, 11113.166512511756, 11412.429378531206, 11480.483378248166, 46825.531744682114, 47447.76276118597, 47823.0, 47886.76056619694, 48059.0, 54193.0, 54204.72897635487, 54940.0, 55184.17223741567, 55901.72049139891, 12585.93707031459, 12879.35603219854, 12961.15752476086, 12993.155444896052, 13048.217106973612, 15192.392304308147, 15448.753794535833, 15635.609109772347, 15685.372585096924, 16548.42080527176, 14103.647408814863, 14289.928550357181, 14304.642383940485, 14421.639459013608, 14764.114153150846, 13586.116902401312, 14263.71472570522, 14322.785158222843, 14342.211178385289, 14457.855421446071, 13632.318384080558, 13712.65718357049, 14000.649983750487, 14214.928925355307, 14727.55817325482, 10464.790704185722, 10493.790124197625, 10606.787864242826, 10790.460476976277, 10997.450127493434, 12341.259524428562, 12437.75124497523, 12505.93747031259, 12541.874581254435, 12636.87363126357], "value": 7936.190008916036, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1449.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 112.0, 113.0, 113.0, 112.0, 113.0, 112.0, 112.0, 112.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 115.0, 119.0, 153.0, 116.0, 116.0, 115.0, 115.0, 136.0, 116.0], "value": 124.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 162.0, 167.0, 161.0, 161.0, 161.0, 160.0, 160.0, 162.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 122.0, 78.0, 76.0, 75.0, 75.0, 89.0, 85.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 102.0, 82.0, 82.0, 81.0, 95.0, 82.0, 83.0, 106.0], "value": 87.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 112.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 112.0], "value": 112.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 147.0, 145.0, 147.0, 146.0, 146.0, 146.0, 145.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 93.0, 93.0, 94.0, 94.0, 93.0, 94.0, 93.0], "value": 93.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 53.0, 53.0, 55.0, 54.0, 56.0, 53.0, 54.0, 54.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 54.0, 54.0, 53.0, 53.0, 54.0, 56.0, 54.0], "value": 53.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 76.0, 79.0, 79.0, 77.0, 79.0, 84.0, 79.0, 79.0, 103.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 119.0, 124.0, 126.0, 123.0, 119.0, 118.0, 127.0, 119.0, 120.0], "value": 121.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 157.0, 156.0, 164.0, 160.0, 156.0, 158.0, 158.0, 159.0, 159.0], "value": 158.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 59.0, 60.0, 58.0, 59.0, 59.0, 60.0, 58.0, 58.0], "value": 59.2, "unit": "score"}]}]} 12:07:44 INFO - Return code: 0 12:07:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:07:44 INFO - # TBPL SUCCESS # 12:07:44 INFO - Running post-action listener: _resource_record_post_action 12:07:44 INFO - [mozharness: 2017-05-18 19:07:44.700187Z] Finished run-tests step (success) 12:07:44 INFO - Running post-run listener: _resource_record_post_run 12:07:44 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 325672960; Read time: 40; Write time: 233760 12:07:44 INFO - TinderboxPrint: CPU usage
13.1% 12:07:44 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 40 12:07:44 INFO - TinderboxPrint: I/O write bytes / time
325,672,960 / 233,760 12:07:44 INFO - TinderboxPrint: CPU idle
8,253.6 (86.9%) 12:07:44 INFO - TinderboxPrint: CPU user
1,197.7 (12.6%) 12:07:44 INFO - TinderboxPrint: Swap in / out
0 / 0 12:07:44 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 66011136; Read time: 0; Write time: 43164 12:07:44 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 226721792; Read time: 0; Write time: 128120 12:07:45 INFO - Running post-run listener: _upload_blobber_files 12:07:45 INFO - Blob upload gear active. 12:07:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:07:45 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 12:07:45 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'] 12:07:45 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 12:07:45 INFO - (blobuploader) - INFO - Open directory for files ... 12:07:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:07:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:07:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:07:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:07:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:07:49 INFO - (blobuploader) - INFO - Done attempting. 12:07:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:07:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:07:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:07:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:07:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:07:50 INFO - (blobuploader) - INFO - Done attempting. 12:07:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:07:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:07:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:07:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:07:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:07:51 INFO - (blobuploader) - INFO - Done attempting. 12:07:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:07:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:07:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:07:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:07:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:07:51 INFO - (blobuploader) - INFO - Done attempting. 12:07:51 INFO - (blobuploader) - INFO - Iteration through files over. 12:07:51 INFO - Return code: 0 12:07:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:07:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:07:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1a320d6e4a306c042f5161761999f1376c8a82222261369f882bd24f423244da08c795aa044c82c45c53e6bd29e1615a47da834f43ce9c48a4a456e8f95bbb28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/76c3576a0118635aa601451915cd6b6a7893981cfeb6704b2298070a8c763a4ae1fffed92f81f7ec65421350a049eb2e4ba0ab58f5f6d2ae0c27152ce6376f87", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/77a95a343b748af421caadf35c4f7b4231815792eabe265f595c9618b1f7692c76f026437df4198020490e551a3fcb9e0763f1f959ef523c83b67e009f0f66fb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d262cb642dcc5d78cdb7f8e8aa5abca510cf798d7cf3074e88660ac530b0f5c18aa91f42f3fb20d2462b531baa0a305a4f901d70794ca237afbf9992b142bbc1"} 12:07:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:07:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:07:51 INFO - Contents: 12:07:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1a320d6e4a306c042f5161761999f1376c8a82222261369f882bd24f423244da08c795aa044c82c45c53e6bd29e1615a47da834f43ce9c48a4a456e8f95bbb28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/76c3576a0118635aa601451915cd6b6a7893981cfeb6704b2298070a8c763a4ae1fffed92f81f7ec65421350a049eb2e4ba0ab58f5f6d2ae0c27152ce6376f87", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/77a95a343b748af421caadf35c4f7b4231815792eabe265f595c9618b1f7692c76f026437df4198020490e551a3fcb9e0763f1f959ef523c83b67e009f0f66fb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d262cb642dcc5d78cdb7f8e8aa5abca510cf798d7cf3074e88660ac530b0f5c18aa91f42f3fb20d2462b531baa0a305a4f901d70794ca237afbf9992b142bbc1"} 12:07:51 INFO - Running post-run listener: copy_logs_to_upload_dir 12:07:51 INFO - Copying logs to upload dir... 12:07:51 INFO - mkdir: /builds/slave/test/build/upload/logs 12:07:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.108148 ========= master_lag: 0.62 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-05-18 12:07:52.189397) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-18 12:07:52.196122) ========= 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=fa44defc139c4ba8574fe040000001db-1495131440.351375-1898100091 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/1a320d6e4a306c042f5161761999f1376c8a82222261369f882bd24f423244da08c795aa044c82c45c53e6bd29e1615a47da834f43ce9c48a4a456e8f95bbb28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/76c3576a0118635aa601451915cd6b6a7893981cfeb6704b2298070a8c763a4ae1fffed92f81f7ec65421350a049eb2e4ba0ab58f5f6d2ae0c27152ce6376f87", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/77a95a343b748af421caadf35c4f7b4231815792eabe265f595c9618b1f7692c76f026437df4198020490e551a3fcb9e0763f1f959ef523c83b67e009f0f66fb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d262cb642dcc5d78cdb7f8e8aa5abca510cf798d7cf3074e88660ac530b0f5c18aa91f42f3fb20d2462b531baa0a305a4f901d70794ca237afbf9992b142bbc1"} build_url:https://queue.taskcluster.net/v1/task/G1jXTk_5SVmuJadBtJ0AJQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011245 build_url: 'https://queue.taskcluster.net/v1/task/G1jXTk_5SVmuJadBtJ0AJQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1a320d6e4a306c042f5161761999f1376c8a82222261369f882bd24f423244da08c795aa044c82c45c53e6bd29e1615a47da834f43ce9c48a4a456e8f95bbb28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/76c3576a0118635aa601451915cd6b6a7893981cfeb6704b2298070a8c763a4ae1fffed92f81f7ec65421350a049eb2e4ba0ab58f5f6d2ae0c27152ce6376f87", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/77a95a343b748af421caadf35c4f7b4231815792eabe265f595c9618b1f7692c76f026437df4198020490e551a3fcb9e0763f1f959ef523c83b67e009f0f66fb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d262cb642dcc5d78cdb7f8e8aa5abca510cf798d7cf3074e88660ac530b0f5c18aa91f42f3fb20d2462b531baa0a305a4f901d70794ca237afbf9992b142bbc1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-18 12:07:52.219956) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 12:07:52.220311) ========= 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=fa44defc139c4ba8574fe040000001db-1495131440.351375-1898100091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.15 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 12:07:52.371325) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-18 12:07:52.371690) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-18 12:07:52.372014) ========= ========= Total master_lag: 0.94 =========