builder: mozilla-beta_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-079 starttime: 1496320286.89 results: success (0) revision: 86339b41e6e98b5e0580ae19ffbe6c85a54bfc9f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-01 05:31:26.885506) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-01 05:31:26.885954) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-01 05:31:26.886240) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-01 05:31:26.972420) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 05:31:26.972685) ========= 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=1258088b6da462a47ba2cd90000001a2-1496307261.131646-1847580301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-01 05:31:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 87.6M=0s 2017-06-01 05:31:27 (87.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.214106 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 05:31:27.232122) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 05:31:27.232471) ========= 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=1258088b6da462a47ba2cd90000001a2-1496307261.131646-1847580301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019495 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 05:31:27.288205) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 05:31:27.288531) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 86339b41e6e98b5e0580ae19ffbe6c85a54bfc9f --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 86339b41e6e98b5e0580ae19ffbe6c85a54bfc9f --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=1258088b6da462a47ba2cd90000001a2-1496307261.131646-1847580301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-01 05:31:27,639 truncating revision to first 12 chars 2017-06-01 05:31:27,639 Setting DEBUG logging. 2017-06-01 05:31:27,639 attempt 1/10 2017-06-01 05:31:27,639 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/86339b41e6e9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-01 05:31:28,114 unpacking tar archive at: mozilla-beta-86339b41e6e9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.799839 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 05:31:28.101323) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-01 05:31:28.101669) ========= script_repo_revision: 86339b41e6e98b5e0580ae19ffbe6c85a54bfc9f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-01 05:31:28.102318) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-01 05:31:28.102590) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-01 05:31:28.111164) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-06-01 05:31:28.111649) ========= /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=1258088b6da462a47ba2cd90000001a2-1496307261.131646-1847580301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:31:28 INFO - MultiFileLogger online at 20170601 05:31:28 in /builds/slave/test 05:31:28 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 05:31:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:31:28 INFO - {'append_to_log': False, 05:31:28 INFO - 'base_work_dir': '/builds/slave/test', 05:31:28 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 05:31:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:31:28 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 05:31:28 INFO - 'buildbot_json_path': 'buildprops.json', 05:31:28 INFO - 'config_files': ('talos/linux_config.py',), 05:31:28 INFO - 'default_actions': ('clobber', 05:31:28 INFO - 'read-buildbot-config', 05:31:28 INFO - 'download-and-extract', 05:31:28 INFO - 'populate-webroot', 05:31:28 INFO - 'create-virtualenv', 05:31:28 INFO - 'install', 05:31:28 INFO - 'run-tests'), 05:31:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:31:28 INFO - 'download_minidump_stackwalk': True, 05:31:28 INFO - 'download_symbols': 'ondemand', 05:31:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:31:28 INFO - 'tooltool.py': '/tools/tooltool.py', 05:31:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:31:28 INFO - '/tools/misc-python/virtualenv.py')}, 05:31:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:31:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:31:28 INFO - 'gecko_profile': False, 05:31:28 INFO - 'gecko_profile_interval': 0, 05:31:28 INFO - 'installer_path': 'installer.exe', 05:31:28 INFO - 'log_level': 'info', 05:31:28 INFO - 'log_name': 'talos', 05:31:28 INFO - 'log_to_console': True, 05:31:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:31:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:31:28 INFO - 'opt_config_files': (), 05:31:28 INFO - 'pip_index': False, 05:31:28 INFO - 'suite': 'dromaeojs', 05:31:28 INFO - 'system_bits': '32', 05:31:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:31:28 INFO - 'title': 'talos-linux64-ix-079', 05:31:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:31:28 INFO - 'use_talos_json': True, 05:31:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:31:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:31:28 INFO - 'work_dir': 'build'} 05:31:28 INFO - [mozharness: 2017-06-01 12:31:28.686653Z] Running clobber step. 05:31:28 INFO - Running pre-action listener: _resource_record_pre_action 05:31:28 INFO - Running main action method: clobber 05:31:28 INFO - rmtree: /builds/slave/test/build 05:31:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:31:29 INFO - Running post-action listener: _resource_record_post_action 05:31:29 INFO - [mozharness: 2017-06-01 12:31:29.700429Z] Finished clobber step (success) 05:31:29 INFO - [mozharness: 2017-06-01 12:31:29.700529Z] Running read-buildbot-config step. 05:31:29 INFO - Running pre-action listener: _resource_record_pre_action 05:31:29 INFO - Running main action method: read_buildbot_config 05:31:29 INFO - Using buildbot properties: 05:31:29 INFO - { 05:31:29 INFO - "project": "", 05:31:29 INFO - "product": "firefox", 05:31:29 INFO - "who": "gijskruitbosch@gmail.com", 05:31:29 INFO - "installer_path": "public/build/target.tar.bz2", 05:31:29 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 05:31:29 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta/", 05:31:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs", 05:31:29 INFO - "stage_platform": "linux64", 05:31:29 INFO - "basedir": "/builds/slave/test", 05:31:29 INFO - "buildnumber": 66, 05:31:29 INFO - "platform": "ubuntu64_hw", 05:31:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:31:29 INFO - "slavebuilddir": "test", 05:31:29 INFO - "taskId": "Uz-3on_0Sy2w8W0nJgkdXg", 05:31:29 INFO - "branch": "mozilla-beta", 05:31:29 INFO - "script_repo_revision": "production", 05:31:29 INFO - "revision": "86339b41e6e98b5e0580ae19ffbe6c85a54bfc9f", 05:31:29 INFO - "slavename": "talos-linux64-ix-079", 05:31:29 INFO - "repo_path": "releases/mozilla-beta" 05:31:29 INFO - } 05:31:29 INFO - Finding installer, test and symbols from parent task. 05:31:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Uz-3on_0Sy2w8W0nJgkdXg'}, attempt #1 05:31:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Uz-3on_0Sy2w8W0nJgkdXg'}, attempt #1 05:31:30 INFO - Task dependencies: JMorGhSRTqevz7bidjkOhw 05:31:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JMorGhSRTqevz7bidjkOhw'}, attempt #1 05:31:31 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/JMorGhSRTqevz7bidjkOhw/artifacts/public/build/target.tar.bz2 05:31:31 INFO - Set test_url: https://queue.taskcluster.net/v1/task/JMorGhSRTqevz7bidjkOhw/artifacts/public/build/test_packages.json 05:31:31 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/JMorGhSRTqevz7bidjkOhw/artifacts/public/build/target.crashreporter-symbols.zip 05:31:31 INFO - Running post-action listener: _resource_record_post_action 05:31:31 INFO - [mozharness: 2017-06-01 12:31:31.065395Z] Finished read-buildbot-config step (success) 05:31:31 INFO - [mozharness: 2017-06-01 12:31:31.065614Z] Running download-and-extract step. 05:31:31 INFO - Running pre-action listener: _resource_record_pre_action 05:31:31 INFO - Running main action method: download_and_extract 05:31:31 INFO - mkdir: /builds/slave/test/build/tests 05:31:31 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')]} 05:31:31 INFO - trying https://queue.taskcluster.net/v1/task/JMorGhSRTqevz7bidjkOhw/artifacts/public/build/target.test_packages.json 05:31:31 INFO - Downloading https://queue.taskcluster.net/v1/task/JMorGhSRTqevz7bidjkOhw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:31:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JMorGhSRTqevz7bidjkOhw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:31:31 INFO - Downloaded 986 bytes. 05:31:31 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:31:31 INFO - Using the following test package requirements: 05:31:31 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:31:31 INFO - u'common': [u'target.common.tests.zip'], 05:31:31 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:31:31 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:31:31 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:31:31 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:31:31 INFO - u'mozbase': [u'target.common.tests.zip'], 05:31:31 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:31:31 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:31:31 INFO - u'web-platform': [u'target.common.tests.zip', 05:31:31 INFO - u'target.web-platform.tests.zip'], 05:31:31 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:31:31 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:31:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JMorGhSRTqevz7bidjkOhw/artifacts/public/build/target.common.tests.zip 05:31:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JMorGhSRTqevz7bidjkOhw/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:31:31 INFO - Fetch https://queue.taskcluster.net/v1/task/JMorGhSRTqevz7bidjkOhw/artifacts/public/build/target.common.tests.zip into memory 05:31:34 INFO - Expected file size: 59712194 05:31:34 INFO - Obtained file size: 59712194 05:31:44 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:31:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JMorGhSRTqevz7bidjkOhw/artifacts/public/build/target.common.tests.zip 05:31:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JMorGhSRTqevz7bidjkOhw/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:31:44 INFO - Fetch https://queue.taskcluster.net/v1/task/JMorGhSRTqevz7bidjkOhw/artifacts/public/build/target.common.tests.zip into memory 05:31:45 INFO - Expected file size: 59712194 05:31:45 INFO - Obtained file size: 59712194 05:31:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JMorGhSRTqevz7bidjkOhw/artifacts/public/build/target.talos.tests.zip 05:31:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JMorGhSRTqevz7bidjkOhw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:31:56 INFO - Fetch https://queue.taskcluster.net/v1/task/JMorGhSRTqevz7bidjkOhw/artifacts/public/build/target.talos.tests.zip into memory 05:31:57 INFO - Expected file size: 14404461 05:31:57 INFO - Obtained file size: 14404461 05:31:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:31:57 INFO - trying https://queue.taskcluster.net/v1/task/JMorGhSRTqevz7bidjkOhw/artifacts/public/build/target.tar.bz2 05:31:57 INFO - Downloading https://queue.taskcluster.net/v1/task/JMorGhSRTqevz7bidjkOhw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:31:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JMorGhSRTqevz7bidjkOhw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:31:59 INFO - Downloaded 59825032 bytes. 05:31:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JMorGhSRTqevz7bidjkOhw/artifacts/public/build/target.tar.bz2 05:31:59 INFO - mkdir: /builds/slave/test/properties 05:31:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:31:59 INFO - Writing to file /builds/slave/test/properties/build_url 05:31:59 INFO - Contents: 05:31:59 INFO - build_url:https://queue.taskcluster.net/v1/task/JMorGhSRTqevz7bidjkOhw/artifacts/public/build/target.tar.bz2 05:31:59 INFO - Running post-action listener: _resource_record_post_action 05:31:59 INFO - Running post-action listener: set_extra_try_arguments 05:31:59 INFO - [mozharness: 2017-06-01 12:31:59.728401Z] Finished download-and-extract step (success) 05:31:59 INFO - [mozharness: 2017-06-01 12:31:59.728626Z] Running populate-webroot step. 05:31:59 INFO - Running pre-action listener: _resource_record_pre_action 05:31:59 INFO - Running main action method: populate_webroot 05:31:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:31:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:31:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:31:59 INFO - '--tppagecycles', 05:31:59 INFO - '7'], 05:31:59 INFO - 'tests': ['tsvgm']}}, 05:31:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:31:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:31:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:31:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:31:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:31:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:31:59 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:31:59 INFO - 'talos_options': ['--disable-e10s'], 05:31:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:31:59 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:31:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:31:59 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:31:59 INFO - 'talos_options': ['--disable-e10s'], 05:31:59 INFO - 'tests': ['damp', 'tps']}, 05:31:59 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:31:59 INFO - 'tests': ['damp', 'tps']}, 05:31:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:31:59 INFO - 'tests': ['dromaeo_dom']}, 05:31:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:31:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:31:59 INFO - 'tests': ['basic_compositor_video']}, 05:31:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:31:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:31:59 INFO - 'tests': ['a11yr', 05:31:59 INFO - 'ts_paint', 05:31:59 INFO - 'tpaint', 05:31:59 INFO - 'sessionrestore', 05:31:59 INFO - 'sessionrestore_no_auto_restore', 05:31:59 INFO - 'tabpaint']}, 05:31:59 INFO - 'other-e10s': {'tests': ['a11yr', 05:31:59 INFO - 'ts_paint', 05:31:59 INFO - 'tpaint', 05:31:59 INFO - 'sessionrestore', 05:31:59 INFO - 'sessionrestore_no_auto_restore', 05:31:59 INFO - 'tabpaint']}, 05:31:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:31:59 INFO - 'ts_paint', 05:31:59 INFO - 'tpaint', 05:31:59 INFO - 'sessionrestore', 05:31:59 INFO - 'sessionrestore_no_auto_restore', 05:31:59 INFO - 'tabpaint']}, 05:31:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:31:59 INFO - 'ts_paint', 05:31:59 INFO - 'tpaint', 05:31:59 INFO - 'sessionrestore', 05:31:59 INFO - 'sessionrestore_no_auto_restore', 05:31:59 INFO - 'tabpaint']}, 05:31:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:31:59 INFO - 'tests': ['a11yr', 05:31:59 INFO - 'ts_paint', 05:31:59 INFO - 'tpaint', 05:31:59 INFO - 'sessionrestore', 05:31:59 INFO - 'sessionrestore_no_auto_restore', 05:31:59 INFO - 'tabpaint']}, 05:31:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:31:59 INFO - 'tests': ['a11yr', 05:31:59 INFO - 'ts_paint', 05:31:59 INFO - 'tpaint', 05:31:59 INFO - 'sessionrestore', 05:31:59 INFO - 'sessionrestore_no_auto_restore', 05:31:59 INFO - 'tabpaint']}, 05:31:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:31:59 INFO - 'tests': ['tsvgx', 05:31:59 INFO - 'tsvgr_opacity', 05:31:59 INFO - 'tart', 05:31:59 INFO - 'tscrollx', 05:31:59 INFO - 'cart', 05:31:59 INFO - 'tsvg_static']}, 05:31:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:31:59 INFO - 'tsvgr_opacity', 05:31:59 INFO - 'tart', 05:31:59 INFO - 'tscrollx', 05:31:59 INFO - 'cart', 05:31:59 INFO - 'tsvg_static']}, 05:31:59 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:31:59 INFO - 'talos_options': ['--disable-e10s'], 05:31:59 INFO - 'tests': ['tp5o']}, 05:31:59 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:31:59 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:31:59 INFO - 'talos_options': ['--disable-e10s', 05:31:59 INFO - '--xperf_path', 05:31:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:31:59 INFO - 'tests': ['tp5n']}, 05:31:59 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:31:59 INFO - 'talos_options': ['--xperf_path', 05:31:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:31:59 INFO - 'tests': ['tp5n']}}, 05:31:59 INFO - 'talos.zip': {'path': '', 05:31:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:31:59 INFO - Running post-action listener: _resource_record_post_action 05:31:59 INFO - [mozharness: 2017-06-01 12:31:59.748571Z] Finished populate-webroot step (success) 05:31:59 INFO - [mozharness: 2017-06-01 12:31:59.748660Z] Running create-virtualenv step. 05:31:59 INFO - Running pre-action listener: _resource_record_pre_action 05:31:59 INFO - Running main action method: create_virtualenv 05:31:59 INFO - Creating virtualenv /builds/slave/test/build/venv 05:31:59 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 05:31:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:31:59 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:31:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:31:59 INFO - Using real prefix '/usr' 05:31:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:32:00 INFO - Installing distribute.............................................................................................................................................................................................done. 05:32:02 INFO - Installing pip.................done. 05:32:02 INFO - Return code: 0 05:32:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:32:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:32:02 INFO - Reading from file tmpfile_stdout 05:32:02 INFO - Output received: 05:32:02 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) 05:32:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1536310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1533400>, '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 0x15343b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1534840>, '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': '1258088b6da462a47ba2cd90000001a2-1496307261.131646-1847580301', '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 05:32:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:32:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:32:02 INFO - Using env: {'DISPLAY': ':0', 05:32:02 INFO - 'HOME': '/home/cltbld', 05:32:02 INFO - 'LANG': 'en_US.UTF-8', 05:32:02 INFO - 'LANGUAGE': 'en_US:en', 05:32:02 INFO - 'LOGNAME': 'cltbld', 05:32:02 INFO - 'MAIL': '/var/mail/cltbld', 05:32:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:02 INFO - 'MOZ_NO_REMOTE': '1', 05:32:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:02 INFO - 'NO_EM_RESTART': '1', 05:32:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:02 INFO - 'PWD': '/builds/slave/test', 05:32:02 INFO - 'SHELL': '/bin/bash', 05:32:02 INFO - 'SHLVL': '1', 05:32:02 INFO - 'TERM': 'linux', 05:32:02 INFO - 'TMOUT': '86400', 05:32:02 INFO - 'USER': 'cltbld', 05:32:02 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1496307261.131646-1847580301', 05:32:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:02 INFO - '_': '/tools/buildbot/bin/python'} 05:32:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:02 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 05:32:02 INFO - Cleaning up... 05:32:02 INFO - Return code: 0 05:32:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x12981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1536310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1533400>, '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 0x15343b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1534840>, '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': '1258088b6da462a47ba2cd90000001a2-1496307261.131646-1847580301', '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 05:32:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:32:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:32:02 INFO - Using env: {'DISPLAY': ':0', 05:32:02 INFO - 'HOME': '/home/cltbld', 05:32:02 INFO - 'LANG': 'en_US.UTF-8', 05:32:02 INFO - 'LANGUAGE': 'en_US:en', 05:32:02 INFO - 'LOGNAME': 'cltbld', 05:32:02 INFO - 'MAIL': '/var/mail/cltbld', 05:32:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:02 INFO - 'MOZ_NO_REMOTE': '1', 05:32:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:02 INFO - 'NO_EM_RESTART': '1', 05:32:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:02 INFO - 'PWD': '/builds/slave/test', 05:32:02 INFO - 'SHELL': '/bin/bash', 05:32:02 INFO - 'SHLVL': '1', 05:32:02 INFO - 'TERM': 'linux', 05:32:02 INFO - 'TMOUT': '86400', 05:32:02 INFO - 'USER': 'cltbld', 05:32:02 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1496307261.131646-1847580301', 05:32:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:02 INFO - '_': '/tools/buildbot/bin/python'} 05:32:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:03 INFO - Downloading/unpacking psutil>=3.1.1 05:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:32:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:04 INFO - Installing collected packages: psutil 05:32:04 INFO - Running setup.py install for psutil 05:32:04 INFO - building 'psutil._psutil_linux' extension 05:32:04 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 05:32:05 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 05:32:05 INFO - building 'psutil._psutil_posix' extension 05:32:05 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 05:32:05 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 05:32:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:05 INFO - Successfully installed psutil 05:32:05 INFO - Cleaning up... 05:32:05 INFO - Return code: 0 05:32:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:05 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 0x12981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1536310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1533400>, '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 0x15343b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1534840>, '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': '1258088b6da462a47ba2cd90000001a2-1496307261.131646-1847580301', '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 05:32:05 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 05:32:05 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 05:32:05 INFO - Using env: {'DISPLAY': ':0', 05:32:05 INFO - 'HOME': '/home/cltbld', 05:32:05 INFO - 'LANG': 'en_US.UTF-8', 05:32:05 INFO - 'LANGUAGE': 'en_US:en', 05:32:05 INFO - 'LOGNAME': 'cltbld', 05:32:05 INFO - 'MAIL': '/var/mail/cltbld', 05:32:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:05 INFO - 'MOZ_NO_REMOTE': '1', 05:32:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:05 INFO - 'NO_EM_RESTART': '1', 05:32:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:05 INFO - 'PWD': '/builds/slave/test', 05:32:05 INFO - 'SHELL': '/bin/bash', 05:32:05 INFO - 'SHLVL': '1', 05:32:05 INFO - 'TERM': 'linux', 05:32:05 INFO - 'TMOUT': '86400', 05:32:05 INFO - 'USER': 'cltbld', 05:32:05 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1496307261.131646-1847580301', 05:32:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:05 INFO - '_': '/tools/buildbot/bin/python'} 05:32:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:32:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:32:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:32:06 INFO - Installing collected packages: mozsystemmonitor 05:32:06 INFO - Running setup.py install for mozsystemmonitor 05:32:07 INFO - Successfully installed mozsystemmonitor 05:32:07 INFO - Cleaning up... 05:32:07 INFO - Return code: 0 05:32:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:32:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x12981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1536310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1533400>, '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 0x15343b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1534840>, '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': '1258088b6da462a47ba2cd90000001a2-1496307261.131646-1847580301', '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 05:32:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:32:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:32:07 INFO - Using env: {'DISPLAY': ':0', 05:32:07 INFO - 'HOME': '/home/cltbld', 05:32:07 INFO - 'LANG': 'en_US.UTF-8', 05:32:07 INFO - 'LANGUAGE': 'en_US:en', 05:32:07 INFO - 'LOGNAME': 'cltbld', 05:32:07 INFO - 'MAIL': '/var/mail/cltbld', 05:32:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:07 INFO - 'MOZ_NO_REMOTE': '1', 05:32:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:07 INFO - 'NO_EM_RESTART': '1', 05:32:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:07 INFO - 'PWD': '/builds/slave/test', 05:32:07 INFO - 'SHELL': '/bin/bash', 05:32:07 INFO - 'SHLVL': '1', 05:32:07 INFO - 'TERM': 'linux', 05:32:07 INFO - 'TMOUT': '86400', 05:32:07 INFO - 'USER': 'cltbld', 05:32:07 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1496307261.131646-1847580301', 05:32:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:07 INFO - '_': '/tools/buildbot/bin/python'} 05:32:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:07 INFO - Downloading/unpacking jsonschema==2.5.1 05:32:07 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 05:32:07 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 05:32:07 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 05:32:07 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 05:32:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:32:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:08 INFO - Downloading functools32-3.2.3-2.tar.gz 05:32:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:32:08 INFO - warning: no files found matching '*.txt' 05:32:08 INFO - no previously-included directories found matching 'build' 05:32:08 INFO - no previously-included directories found matching 'dist' 05:32:08 INFO - no previously-included directories found matching '.git*' 05:32:08 INFO - Installing collected packages: jsonschema, functools32 05:32:08 INFO - Running setup.py install for functools32 05:32:08 INFO - warning: no files found matching '*.txt' 05:32:08 INFO - no previously-included directories found matching 'build' 05:32:08 INFO - no previously-included directories found matching 'dist' 05:32:08 INFO - no previously-included directories found matching '.git*' 05:32:08 INFO - Successfully installed jsonschema functools32 05:32:08 INFO - Cleaning up... 05:32:08 INFO - Return code: 0 05:32:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:32: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')]} 05:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32: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')]} 05:32:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:08 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 0x12981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1536310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1533400>, '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 0x15343b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1534840>, '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': '1258088b6da462a47ba2cd90000001a2-1496307261.131646-1847580301', '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 05:32:08 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 05:32:08 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 05:32:08 INFO - Using env: {'DISPLAY': ':0', 05:32:08 INFO - 'HOME': '/home/cltbld', 05:32:08 INFO - 'LANG': 'en_US.UTF-8', 05:32:08 INFO - 'LANGUAGE': 'en_US:en', 05:32:08 INFO - 'LOGNAME': 'cltbld', 05:32:08 INFO - 'MAIL': '/var/mail/cltbld', 05:32:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:08 INFO - 'MOZ_NO_REMOTE': '1', 05:32:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:08 INFO - 'NO_EM_RESTART': '1', 05:32:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:08 INFO - 'PWD': '/builds/slave/test', 05:32:08 INFO - 'SHELL': '/bin/bash', 05:32:08 INFO - 'SHLVL': '1', 05:32:08 INFO - 'TERM': 'linux', 05:32:08 INFO - 'TMOUT': '86400', 05:32:08 INFO - 'USER': 'cltbld', 05:32:08 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1496307261.131646-1847580301', 05:32:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:08 INFO - '_': '/tools/buildbot/bin/python'} 05:32:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:32:08 INFO - Cleaning up... 05:32:08 INFO - Return code: 0 05:32:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:32: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')]} 05:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32: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')]} 05:32:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:08 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 0x12981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1536310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1533400>, '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 0x15343b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1534840>, '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': '1258088b6da462a47ba2cd90000001a2-1496307261.131646-1847580301', '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 05:32:08 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 05:32:08 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 05:32:08 INFO - Using env: {'DISPLAY': ':0', 05:32:08 INFO - 'HOME': '/home/cltbld', 05:32:08 INFO - 'LANG': 'en_US.UTF-8', 05:32:08 INFO - 'LANGUAGE': 'en_US:en', 05:32:08 INFO - 'LOGNAME': 'cltbld', 05:32:08 INFO - 'MAIL': '/var/mail/cltbld', 05:32:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:08 INFO - 'MOZ_NO_REMOTE': '1', 05:32:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:08 INFO - 'NO_EM_RESTART': '1', 05:32:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:08 INFO - 'PWD': '/builds/slave/test', 05:32:08 INFO - 'SHELL': '/bin/bash', 05:32:08 INFO - 'SHLVL': '1', 05:32:08 INFO - 'TERM': 'linux', 05:32:08 INFO - 'TMOUT': '86400', 05:32:08 INFO - 'USER': 'cltbld', 05:32:08 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1496307261.131646-1847580301', 05:32:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:08 INFO - '_': '/tools/buildbot/bin/python'} 05:32:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:09 INFO - Downloading/unpacking blobuploader==1.2.4 05:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:10 INFO - Downloading blobuploader-1.2.4.tar.gz 05:32:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:32:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:32:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:10 INFO - Downloading docopt-0.6.1.tar.gz 05:32:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:32:10 INFO - Installing collected packages: blobuploader, requests, docopt 05:32:10 INFO - Running setup.py install for blobuploader 05:32:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:32:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:32:10 INFO - Running setup.py install for requests 05:32:11 INFO - Running setup.py install for docopt 05:32:11 INFO - Successfully installed blobuploader requests docopt 05:32:11 INFO - Cleaning up... 05:32:11 INFO - Return code: 0 05:32:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:11 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 0x12981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1536310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1533400>, '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 0x15343b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1534840>, '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': '1258088b6da462a47ba2cd90000001a2-1496307261.131646-1847580301', '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 05:32:11 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 05:32:11 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 05:32:11 INFO - Using env: {'DISPLAY': ':0', 05:32:11 INFO - 'HOME': '/home/cltbld', 05:32:11 INFO - 'LANG': 'en_US.UTF-8', 05:32:11 INFO - 'LANGUAGE': 'en_US:en', 05:32:11 INFO - 'LOGNAME': 'cltbld', 05:32:11 INFO - 'MAIL': '/var/mail/cltbld', 05:32:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:11 INFO - 'MOZ_NO_REMOTE': '1', 05:32:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:11 INFO - 'NO_EM_RESTART': '1', 05:32:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:11 INFO - 'PWD': '/builds/slave/test', 05:32:11 INFO - 'SHELL': '/bin/bash', 05:32:11 INFO - 'SHLVL': '1', 05:32:11 INFO - 'TERM': 'linux', 05:32:11 INFO - 'TMOUT': '86400', 05:32:11 INFO - 'USER': 'cltbld', 05:32:11 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1496307261.131646-1847580301', 05:32:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:11 INFO - '_': '/tools/buildbot/bin/python'} 05:32:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:32:11 INFO - Running setup.py (path:/tmp/pip-rlBlku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:32:11 INFO - Running setup.py (path:/tmp/pip-8BbYQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:32:11 INFO - Running setup.py (path:/tmp/pip-LL3KMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:32:11 INFO - Running setup.py (path:/tmp/pip-XVIBHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:32:11 INFO - Running setup.py (path:/tmp/pip-ULjV_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:32:12 INFO - Running setup.py (path:/tmp/pip-QHAVhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:32:12 INFO - Running setup.py (path:/tmp/pip-oGy5JU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:32:12 INFO - Running setup.py (path:/tmp/pip-43TVpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:32:12 INFO - Running setup.py (path:/tmp/pip-GGQ_B6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:32:12 INFO - Running setup.py (path:/tmp/pip-iBwzCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:32:12 INFO - Running setup.py (path:/tmp/pip-Gsa1HL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:32:12 INFO - Running setup.py (path:/tmp/pip-cNoQUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:32:12 INFO - Running setup.py (path:/tmp/pip-v7oxQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:32:12 INFO - Running setup.py (path:/tmp/pip-nBD0D0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:12 INFO - Running setup.py (path:/tmp/pip-vi499X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:32:12 INFO - Running setup.py (path:/tmp/pip-7KxKP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:32:12 INFO - Running setup.py (path:/tmp/pip-OEl4Xt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:32:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:32:12 INFO - Running setup.py install for manifestparser 05:32:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:32:12 INFO - Running setup.py install for mozcrash 05:32:13 INFO - Running setup.py install for mozdebug 05:32:13 INFO - Running setup.py install for mozdevice 05:32:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:32:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:32:13 INFO - Running setup.py install for mozfile 05:32:13 INFO - Running setup.py install for mozhttpd 05:32:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:32:13 INFO - Running setup.py install for mozinfo 05:32:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:32:13 INFO - Running setup.py install for mozInstall 05:32:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:32:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:32:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:32:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:32:13 INFO - Running setup.py install for mozleak 05:32:13 INFO - Running setup.py install for mozlog 05:32:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:32:13 INFO - Running setup.py install for moznetwork 05:32:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:32:14 INFO - Running setup.py install for mozprocess 05:32:14 INFO - Running setup.py install for mozprofile 05:32:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:32:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:32:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:32:14 INFO - Running setup.py install for mozrunner 05:32:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:32:14 INFO - Running setup.py install for mozscreenshot 05:32:14 INFO - Running setup.py install for moztest 05:32:14 INFO - Running setup.py install for mozversion 05:32:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:32:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:32:14 INFO - Cleaning up... 05:32:14 INFO - Return code: 0 05:32:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:14 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')]} 05:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:14 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')]} 05:32:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:14 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 0x12981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1536310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1533400>, '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 0x15343b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1534840>, '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': '1258088b6da462a47ba2cd90000001a2-1496307261.131646-1847580301', '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 05:32:14 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 05:32:14 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 05:32:14 INFO - Using env: {'DISPLAY': ':0', 05:32:14 INFO - 'HOME': '/home/cltbld', 05:32:14 INFO - 'LANG': 'en_US.UTF-8', 05:32:14 INFO - 'LANGUAGE': 'en_US:en', 05:32:14 INFO - 'LOGNAME': 'cltbld', 05:32:14 INFO - 'MAIL': '/var/mail/cltbld', 05:32:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:14 INFO - 'MOZ_NO_REMOTE': '1', 05:32:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:14 INFO - 'NO_EM_RESTART': '1', 05:32:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:14 INFO - 'PWD': '/builds/slave/test', 05:32:14 INFO - 'SHELL': '/bin/bash', 05:32:14 INFO - 'SHLVL': '1', 05:32:14 INFO - 'TERM': 'linux', 05:32:14 INFO - 'TMOUT': '86400', 05:32:14 INFO - 'USER': 'cltbld', 05:32:14 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1496307261.131646-1847580301', 05:32:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:14 INFO - '_': '/tools/buildbot/bin/python'} 05:32:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:32:14 INFO - Running setup.py (path:/tmp/pip-Xnx2_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:32:14 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)) 05:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:32:14 INFO - Running setup.py (path:/tmp/pip-KiG_xx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:32:15 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)) 05:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:32:15 INFO - Running setup.py (path:/tmp/pip-jpNbyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:32:15 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)) 05:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:32:15 INFO - Running setup.py (path:/tmp/pip-yLgXKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:32:15 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)) 05:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:32:15 INFO - Running setup.py (path:/tmp/pip-8Gf5d3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:32:15 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)) 05:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:32:15 INFO - Running setup.py (path:/tmp/pip-LmyTc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:32:15 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)) 05:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:32:15 INFO - Running setup.py (path:/tmp/pip-VXUTgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:32:15 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)) 05:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:32:15 INFO - Running setup.py (path:/tmp/pip-cZUgqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:32:15 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)) 05:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:32:15 INFO - Running setup.py (path:/tmp/pip-FK6zpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:32:15 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)) 05:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:32:15 INFO - Running setup.py (path:/tmp/pip-2bqRb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:32:15 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)) 05:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:32:15 INFO - Running setup.py (path:/tmp/pip-yIsclW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:32:15 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)) 05:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:32:15 INFO - Running setup.py (path:/tmp/pip-HhRVCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:32:15 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)) 05:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:32:15 INFO - Running setup.py (path:/tmp/pip-brbCeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:32:15 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)) 05:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:32:15 INFO - Running setup.py (path:/tmp/pip-f7oj0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:32:15 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)) 05:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:15 INFO - Running setup.py (path:/tmp/pip-C53lDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:16 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)) 05:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:32:16 INFO - Running setup.py (path:/tmp/pip-cCy7Wz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:32:16 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)) 05:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:32:16 INFO - Running setup.py (path:/tmp/pip-_kcEpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:32:16 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)) 05:32:16 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)) 05:32:16 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)) 05:32:16 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)) 05:32:16 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)) 05:32:16 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)) 05:32:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:32:16 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 05:32:16 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 05:32:16 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 05:32:16 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 05:32:17 INFO - Downloading blessings-1.6.tar.gz 05:32:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:32:17 INFO - Installing collected packages: blessings 05:32:17 INFO - Running setup.py install for blessings 05:32:17 INFO - Successfully installed blessings 05:32:17 INFO - Cleaning up... 05:32:17 INFO - Return code: 0 05:32:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:32:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:32:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:32:17 INFO - Reading from file tmpfile_stdout 05:32:17 INFO - Current package versions: 05:32:17 INFO - argparse == 1.2.1 05:32:17 INFO - blessings == 1.6 05:32:17 INFO - blobuploader == 1.2.4 05:32:17 INFO - docopt == 0.6.1 05:32:17 INFO - functools32 == 3.2.3-2 05:32:17 INFO - jsonschema == 2.5.1 05:32:17 INFO - manifestparser == 1.1 05:32:17 INFO - mozInstall == 1.12 05:32:17 INFO - mozcrash == 1.0 05:32:17 INFO - mozdebug == 0.1 05:32:17 INFO - mozdevice == 0.49 05:32:17 INFO - mozfile == 1.2 05:32:17 INFO - mozhttpd == 0.7 05:32:17 INFO - mozinfo == 0.9 05:32:17 INFO - mozleak == 0.1 05:32:17 INFO - mozlog == 3.4 05:32:17 INFO - moznetwork == 0.27 05:32:17 INFO - mozprocess == 0.25 05:32:17 INFO - mozprofile == 0.28 05:32:17 INFO - mozrunner == 6.13 05:32:17 INFO - mozscreenshot == 0.1 05:32:17 INFO - mozsystemmonitor == 0.3 05:32:17 INFO - moztest == 0.8 05:32:17 INFO - mozversion == 1.4 05:32:17 INFO - psutil == 3.1.1 05:32:17 INFO - requests == 1.2.3 05:32:17 INFO - wsgiref == 0.1.2 05:32:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:17 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 0x12981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1536310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1533400>, '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 0x15343b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1534840>, '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': '1258088b6da462a47ba2cd90000001a2-1496307261.131646-1847580301', '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 05:32:17 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 05:32:17 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 05:32:17 INFO - Using env: {'DISPLAY': ':0', 05:32:17 INFO - 'HOME': '/home/cltbld', 05:32:17 INFO - 'LANG': 'en_US.UTF-8', 05:32:17 INFO - 'LANGUAGE': 'en_US:en', 05:32:17 INFO - 'LOGNAME': 'cltbld', 05:32:17 INFO - 'MAIL': '/var/mail/cltbld', 05:32:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:17 INFO - 'MOZ_NO_REMOTE': '1', 05:32:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:17 INFO - 'NO_EM_RESTART': '1', 05:32:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:17 INFO - 'PWD': '/builds/slave/test', 05:32:17 INFO - 'SHELL': '/bin/bash', 05:32:17 INFO - 'SHLVL': '1', 05:32:17 INFO - 'TERM': 'linux', 05:32:17 INFO - 'TMOUT': '86400', 05:32:17 INFO - 'USER': 'cltbld', 05:32:17 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1496307261.131646-1847580301', 05:32:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:17 INFO - '_': '/tools/buildbot/bin/python'} 05:32:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:18 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)) 05:32:18 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)) 05:32:18 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)) 05:32:18 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)) 05:32:18 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)) 05:32:18 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)) 05:32:18 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)) 05:32:18 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)) 05:32:18 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)) 05:32:18 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)) 05:32:18 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)) 05:32:18 INFO - Cleaning up... 05:32:18 INFO - Return code: 0 05:32:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:32:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:18 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 0x12981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1536310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1533400>, '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 0x15343b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1534840>, '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': '1258088b6da462a47ba2cd90000001a2-1496307261.131646-1847580301', '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 05:32:18 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 05:32:18 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 05:32:18 INFO - Using env: {'DISPLAY': ':0', 05:32:18 INFO - 'HOME': '/home/cltbld', 05:32:18 INFO - 'LANG': 'en_US.UTF-8', 05:32:18 INFO - 'LANGUAGE': 'en_US:en', 05:32:18 INFO - 'LOGNAME': 'cltbld', 05:32:18 INFO - 'MAIL': '/var/mail/cltbld', 05:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:18 INFO - 'MOZ_NO_REMOTE': '1', 05:32:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:18 INFO - 'NO_EM_RESTART': '1', 05:32:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:18 INFO - 'PWD': '/builds/slave/test', 05:32:18 INFO - 'SHELL': '/bin/bash', 05:32:18 INFO - 'SHLVL': '1', 05:32:18 INFO - 'TERM': 'linux', 05:32:18 INFO - 'TMOUT': '86400', 05:32:18 INFO - 'USER': 'cltbld', 05:32:18 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1496307261.131646-1847580301', 05:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:18 INFO - '_': '/tools/buildbot/bin/python'} 05:32:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:32:18 INFO - Cleaning up... 05:32:18 INFO - Return code: 0 05:32:18 INFO - Running post-action listener: _resource_record_post_action 05:32:18 INFO - Running post-action listener: _start_resource_monitoring 05:32:18 INFO - Starting resource monitoring. 05:32:18 INFO - [mozharness: 2017-06-01 12:32:18.273169Z] Finished create-virtualenv step (success) 05:32:18 INFO - [mozharness: 2017-06-01 12:32:18.273639Z] Running install step. 05:32:18 INFO - Running pre-action listener: _resource_record_pre_action 05:32:18 INFO - Running main action method: install 05:32:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:32:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:32:18 INFO - Reading from file tmpfile_stdout 05:32:18 INFO - Detecting whether we're running mozinstall >=1.0... 05:32:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:32:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:32:18 INFO - Reading from file tmpfile_stdout 05:32:18 INFO - Output received: 05:32:18 INFO - Usage: mozinstall [options] installer 05:32:18 INFO - Options: 05:32:18 INFO - -h, --help show this help message and exit 05:32:18 INFO - -d DEST, --destination=DEST 05:32:18 INFO - Directory to install application into. [default: 05:32:18 INFO - "/builds/slave/test"] 05:32:18 INFO - --app=APP Application being installed. [default: firefox] 05:32:18 INFO - mkdir: /builds/slave/test/build/application 05:32:18 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'] 05:32:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:32:32 INFO - Reading from file tmpfile_stdout 05:32:32 INFO - Output received: 05:32:32 INFO - /builds/slave/test/build/application/firefox/firefox 05:32:32 INFO - Running post-action listener: _resource_record_post_action 05:32:32 INFO - [mozharness: 2017-06-01 12:32:32.571433Z] Finished install step (success) 05:32:32 INFO - [mozharness: 2017-06-01 12:32:32.571751Z] Running run-tests step. 05:32:32 INFO - Running pre-action listener: _resource_record_pre_action 05:32:32 INFO - Running main action method: run_tests 05:32:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:32:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:32:32 INFO - Python 2.7.3 05:32:32 INFO - Return code: 0 05:32:32 INFO - grabbing minidump binary from tooltool 05:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:32 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 0x1533400>, '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 0x15343b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1534840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:32:32 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 05:32:32 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 05:32:32 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 05:32:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:32:32 INFO - Return code: 0 05:32:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:32:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:32:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:32:32 INFO - ENV: RUST_BACKTRACE is now 1 05:32:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:32:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:32:32 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/JMorGhSRTqevz7bidjkOhw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-079', '--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 05:32:32 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/JMorGhSRTqevz7bidjkOhw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-079 --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 05:32:32 INFO - Using env: {'DISPLAY': ':0', 05:32:32 INFO - 'HOME': '/home/cltbld', 05:32:32 INFO - 'LANG': 'en_US.UTF-8', 05:32:32 INFO - 'LANGUAGE': 'en_US:en', 05:32:32 INFO - 'LOGNAME': 'cltbld', 05:32:32 INFO - 'MAIL': '/var/mail/cltbld', 05:32:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:32:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:32 INFO - 'MOZ_NO_REMOTE': '1', 05:32:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:32:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:32 INFO - 'NO_EM_RESTART': '1', 05:32:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:32 INFO - 'PWD': '/builds/slave/test', 05:32:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:32:32 INFO - 'RUST_BACKTRACE': '1', 05:32:32 INFO - 'SHELL': '/bin/bash', 05:32:32 INFO - 'SHLVL': '1', 05:32:32 INFO - 'TERM': 'linux', 05:32:32 INFO - 'TMOUT': '86400', 05:32:32 INFO - 'USER': 'cltbld', 05:32:32 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1496307261.131646-1847580301', 05:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:32 INFO - '_': '/tools/buildbot/bin/python'} 05:32:32 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/JMorGhSRTqevz7bidjkOhw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-079', '--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 05:32:33 INFO - mozversion application_buildid: 20170601111941 05:32:33 INFO - mozversion application_changeset: 86339b41e6e98b5e0580ae19ffbe6c85a54bfc9f 05:32:33 INFO - mozversion application_display_name: Firefox 05:32:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:32:33 INFO - mozversion application_name: Firefox 05:32:33 INFO - mozversion application_remotingname: firefox 05:32:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:32:33 INFO - mozversion application_vendor: Mozilla 05:32:33 INFO - mozversion application_version: 54.0 05:32:33 INFO - mozversion platform_buildid: 20170601111941 05:32:33 INFO - mozversion platform_changeset: 86339b41e6e98b5e0580ae19ffbe6c85a54bfc9f 05:32:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:32:33 INFO - mozversion platform_version: 54.0 05:32:33 INFO - using testdate: 1496320353 05:32:33 INFO - actual date: 1496320353 05:32:33 INFO - starting webserver on 'localhost:33633' 05:32:33 INFO - SUITE-START | Running 2 tests 05:32:33 INFO - TEST-START | dromaeo_css 05:32:33 INFO - operating with platform_type : linux_ 05:32:33 INFO - Initialising browser for dromaeo_css test... 05:32:33 INFO - TEST-INFO | started process 3428 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdkBmCN/profile http://localhost:33633/getInfo.html) 05:32:38 INFO - PROCESS | 3428 | __metrics Screen width/height:1600/1200 05:32:38 INFO - PROCESS | 3428 | colorDepth:24 05:32:38 INFO - PROCESS | 3428 | Browser inner width/height: 1024/697 05:32:38 INFO - PROCESS | 3428 | __metrics 05:32:39 INFO - PROCESS | 3428 | 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" 05:32:39 INFO - PROCESS | 3428 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:32:39 INFO - PROCESS | 3428 | console.error: PushService: 05:32:39 INFO - PROCESS | 3428 | stateChangeProcessEnqueue: Error transitioning state 05:32:39 INFO - PROCESS | 3428 | UnknownError 05:32:39 INFO - TEST-INFO | 3428: exit 0 05:32:39 INFO - Browser initialized. 05:32:39 INFO - Running cycle 1/1 for dromaeo_css test... 05:32:39 INFO - TEST-INFO | started process 3523 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdkBmCN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:32:51 INFO - PROCESS | 3523 | RSS: Main: 141496320 05:32:51 INFO - PROCESS | 3523 | 05:35:53 INFO - PROCESS | 3523 | Cycle 1(1): loaded http://localhost:33633/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33633/tests/dromaeo/cssquery-ext.html) 05:35:54 INFO - PROCESS | 3523 | RSS: Main: 276283392 05:35:54 INFO - PROCESS | 3523 | 05:38:57 INFO - PROCESS | 3523 | Cycle 1(1): loaded http://localhost:33633/tests/dromaeo/cssquery-ext.html (next: http://localhost:33633/tests/dromaeo/cssquery-jquery.html) 05:38:57 INFO - PROCESS | 3523 | RSS: Main: 225603584 05:38:57 INFO - PROCESS | 3523 | 05:41:59 INFO - PROCESS | 3523 | Cycle 1(1): loaded http://localhost:33633/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33633/tests/dromaeo/cssquery-mootools.html) 05:42:00 INFO - PROCESS | 3523 | RSS: Main: 195252224 05:42:00 INFO - PROCESS | 3523 | 05:45:02 INFO - PROCESS | 3523 | Cycle 1(1): loaded http://localhost:33633/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33633/tests/dromaeo/cssquery-prototype.html) 05:45:02 INFO - PROCESS | 3523 | RSS: Main: 206016512 05:45:02 INFO - PROCESS | 3523 | 05:48:05 INFO - PROCESS | 3523 | Cycle 1(1): loaded http://localhost:33633/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33633/tests/dromaeo/cssquery-yui.html) 05:48:05 INFO - PROCESS | 3523 | RSS: Main: 174362624 05:48:05 INFO - PROCESS | 3523 | 05:51:08 INFO - PROCESS | 3523 | Cycle 1(1): loaded http://localhost:33633/tests/dromaeo/cssquery-yui.html (next: http://localhost:33633/tests/dromaeo/cssquery-dojo.html) 05:51:08 INFO - PROCESS | 3523 | RSS: Main: 259948544 05:51:08 INFO - PROCESS | 3523 | 05:51:08 INFO - PROCESS | 3523 | __start_tp_report 05:51:08 INFO - PROCESS | 3523 | _x_x_mozilla_page_load 05:51:08 INFO - PROCESS | 3523 | _x_x_mozilla_page_load_details 05:51:08 INFO - PROCESS | 3523 | |i|pagename|runs| 05:51:08 INFO - PROCESS | 3523 | |0;dojo.html;3361.243720162965;3369.1408690783846;3414.061133188372;3417.0773891049403;3460.619331873495;5627.606067575266;5700.8859822803515;5702.971485142569;5724;5726.997775389311;5691.51622112121;5739.110437882135;5742.569307301948;5747.741351639176;5754.4533269339345;5185.784813415678;5217.478252174771;5235.607329450288;5238.7642556084875;5279.947200528003;5061.670991385548;5085.745712714368;5304.602154838402;5312.548433383147;5317.548008419289;5175.922361164586;5188.558972487343;5203.167493201088;5212.582993360541;5219.373675158968;5286.629935904488;5286.814961476368;5292.047431462373;5292.285541451932;5293.100172970604;5016.172331565287;5152.690838549662;5216.478352164753;5265.262863199156;5271.815486457994;5568.554515638739;5606.159076138571;5665.971670141664;5681.091025435951;5688.061469857468;6119.296280927706;6164.537659675542;6173.104899789505;6174.413430724074;6176.536759743038;6189.711412810351;6213.285472170713;6221.253449586034;6222.5644204905675;6232.719527621268;5568.7215639217875;5600.327960644708;5653.830385088454;5669.206311116447;5670.291213598301;6195.101710251988;6195.4424101831055;6203.8138855834395;6209.192804935329;6210.254769427697;5958.6424814511265;5971.193888824953;5976.432238937294;5981.162637230791;5985.221921150222;5895.35151133375;5982.611130276518;5992.400759923973;6079.878402431927;6113.052476866093;6109.327973922865;6109.602875813058;6114.633122012693;6117.066276512122;6133.662648554372;5904.468597826216;5941.494972927349;5942.138389933435;6032.125341825411;6135.969320153371;4604.7927843247135;4699.506551812079;4706.8117275308605;4712.787924543404;4713.929291060636;4077.836886524565;4084.6732261419015;4173.83304667816;4182.059036716714;4215.578442155821;5772.6536407815665;5781.82654520365;5838.12428135783;5876.382979787061;5895.20414744004;6120.938790612126;6124.448799608057;6132.877342453126;6139.754409823557;6149.661768602769;5624.831255062355;5840.065589505743;5849.6782676952325;5851.882962340815;5855.648661080264;5072.365954255718;5128.640995130305;5157.277981082651;5224.451432599599;5228.607854410934;6363.58636688623;6396.072569477493;6404;6410.61536307823;6416.967915160394;6100.969495152496;6113.5414843886;6121.785737499166;6152.907706384497;6159.969200153971;6126.029144987462;6132.9386706134155;6263.09185168139;6323.146375239284;6397.744090236339;6099.75600975956;6101.420365065312;6104.084387341934;6122.510199184144;6141.201643786279;6155.182050463032;6174.536909731698;6183.598066125687;6192.411720886508;6196.318404975539;5776.855578610568;5814.970925145347;5884;5897.852553686193;5988.311344195299;5976.312724036791;5987.550933679904;5992;6014.338422773579;6015.72929218195;5977.760889564369;5984.072468767348;5987.161797348288;6001.2498437695285;6006.699665016819;5816.70916454184;5860.267466566679;5864.912026319694;5957.3446920837805;5980.5514586405325;5849.210356601804;5850.151727999501;5860.765569377178;5881.05903055509;5882.205902203148 05:51:08 INFO - PROCESS | 3523 | |1;ext.html;770.7957391291305;842.1704620948366;861.3324673378131;917.2891009467666;933.4352716606448;34209.315813683745;43215.35176972344;43998.34002489961;49199.26201106986;49225.753871230685;47050.29424558626;47058.294125588145;47151.764241178746;47152.292715609205;47181;7741.535507869546;7902.130765615778;9087.863682044775;9222.492762898039;9224.492652904088;10624.36253824773;10818.783624327509;10825.67522974312;10828.079613232885;10840.241183117185;11003.559857605685;11047.944760276187;11051.72370690735;11053.668389948314;11055.72360690981;10949.945250273737;10958.28771129878;10974.286671366335;10977.066949309357;10992.945035274852;10720;10755.354678719303;10765.784684306349;10769.62306319275;10771.192160587909;44232.557674423486;44411.333829992254;44465.55534444647;44473;44635.107297854185;4375.124975005012;4406.405135306724;4427.977860110679;4543.204939135638;4545.522720114406;30576.2355941101;30809.99735017217;31286.843565782026;31439.84280078585;33163.33673326544;4277.508086570053;4285.721428107163;4316.2446571849805;4332.523422423531;4393.011572396217;243919;246725;247123;247561;247581;56348.15477767837;56398.15402768962;56472;56575;56656.15015774767;58353.4164658348;58391.12413313804;58406.70796645989;58407.70796145992;58486.415135848096;16841.57896052584;17239.31042758301;17299.13504324779;17302.307907683553;17310.826891731173;11498.425078746197;11598.246114002732;15241.390344386322;15258.771118433233;15438.614034649223;14028.298585070706;14098;14113.647158821112;14141.151530907973;14192.787108193384;5550.361708403505;5557.110862262019;5576.107822748422;5717.399673034354;5757.424257574293;985.4186030242191;993.3841018568534;997.9550920208463;1000.8648832407678;1025.3642741500319;28642.856785716354;28656.426871462452;28700;29080.85459572731;29127;1060.4114716332356;1066.3495267886583;1071.769569542552;1092.6612750047511;1105.0441368216595;15059.472918447802;15340;15391.846081539265;15405.15271660047;15577.844221557865;300937;302551;303398;305555;305575;54844.72577637086;54863;54887.17669234965;55051.44948550463;55291.894162116536;1487.9256037198313;1498.3482185249452;1513.1677577332423;1515.121229686779;1558.2598265823642;28505.144845654664;28534.1452805567;29615.407691845612;29819.850900745358;29959.251018724706;38828.6117138825;38894.41658375183;38968.2206355877;38969.80515097406;39007.219855603296;289849;293056;293443;295126;295619;26029.609555857056;26512.204633861016;29787.851060744557;30233;31123.533147003265;40733.59266407298;40843.59156408517;41163.794181028905;41228;41316.1736765269;31534.211644709067;31772.68227317697;31809;32051.83974080208;32412;31418.37163256768;31460.842695786374;31476.685233147375;31692.366152677278;32139.35721285608;35554.46668299926;35758.4636230462;36032.459513107846;36251.09372265715;36439.63560364363;29737.405251894408;29930.85034574813;29984.700152999063;30234;30407.54388684216;24318.75681243165;24365;24432.755672443047;24503.50992980166;24509.21479333155 05:51:08 INFO - PROCESS | 3523 | |2;jquery.html;454.3616219212008;463.23797353353734;473.29715372671575;477.357953552472;492.22720329083336;20352.1859125635;21304.36086917391;21517.46206344842;21561;21773.23793667222;22221.777782222172;22360.776392236112;22896.427589310275;23120.537589248204;23149.76850231497;6808.829779255521;7074.045003924456;7493.700251989914;7771.689132434696;7818.80452988677;7343.485955983083;7642.426817988645;7807.063152421717;7846;7848.332891704212;7822.843543129134;7825.647845846951;7825.960870195641;7827.178146294643;7833.843323133534;7236.312550307713;7525.623718814065;7566.205548417392;7585.886211706828;7587.734429295004;7414.295641914009;7544.886826697604;7595.582242976634;7630.122535908386;7645.235476452366;25803.74196258051;25969.22092337233;26415.225878416208;26424.603630945552;26779.196624101307;3160.3047329587453;3324.4680851063713;3343.799372037661;3412.897613071587;3413.6586341365914;15631.296591653403;15887.60280992973;16526.256318465697;17020.319187232497;17213;2278.931632051041;2302.6661134135625;2313.2597568777996;2346.5424242272766;2358.988205058981;80620.59689701573;82879;84828.15171848264;108105.99999999921;109853.45073274663;18096;18360.632787344177;18489.630207395778;18887.716684249746;19005.524861878286;32311;32357.51463728046;32384.83807580994;32458.83770581179;32488;9879.407235565888;10225;10263.435511046815;10269.589216431408;10405.323653962469;8321.459105158145;8339.416240863082;8475.067742548315;8612.612432440555;8616.956915215509;8993.32550058735;9148.130927561871;9306.97423391361;9489.193418559362;9540.761480963032;3382.644822293673;3849.2493963676816;3894.5796520948925;3895.96104038956;3899.1123403660677;907.6913849291141;910.3127139010005;924.4129977464358;935.5602866652663;935.7754139006726;20363.08366123528;21181.36455906325;22628.208952255987;23013.654795178085;23056;1082.3073233130804;1086.1310951238977;1086.7337502311984;1104.447776111944;1121.5569849909402;11437.942810286062;11628.543966852478;11776.70558236051;11844.170908036527;11852.288862668267;664175;664609;676318;690866;702988;80511.59744201241;95033.52483237677;113735;116837;121554.3922280383;1350.9392077356542;1362.4958765256918;1400.544822932551;1402.9088109272864;1403.8385585657577;19393;19657.508562286057;19675.212991480752;19894.90052549728;20032.79803211812;52282;52301.47698522966;52533.47466525438;53162.202566960754;53549;69270.30729692639;69824.65087674529;69964.30035699578;70452.64773676099;70897;12224.327661978676;12655.683607909508;12759.596444391294;12908.870911290767;13048.608541743763;13328.067035307824;13543.119697219649;13731.519396821062;13924.164550127025;14028.789568156282;11401.942990284995;11642.592509262135;11670.591529296435;11835.46740396667;12037.759244814879;11202.15983801202;11213.887861121611;11305.547778088785;11492.827607585725;11805.350705711267;11569.19015668895;11706.297622142698;11834;11912.821307680566;12558.309292988608;11860.288382697066;11963.461644226205;11967.880321197024;12151.453184606891;12309.076819238413;11607.6517704469;11769.411529423323;11882.643520694393;11900.940495297467;12198 05:51:08 INFO - PROCESS | 3523 | |3;mootools.html;1570.7879436276107;1580;1619.7003554342448;1625.146797931086;1626.8942518736278;10847.403392813401;11616.825747613793;11618.186726929118;11623.302601843896;11624.418779061045;10964.890351096486;11252.15608829337;11256.268342557749;11293.378864162467;11416.657500274985;2470.7899828514596;2499.387650025737;2503.699556053276;2508.197376839403;2510.0336370497307;2341.356127065054;2357.6581395697613;2385.403649087728;2390.1514962188435;2395.9520809583796;2322.8722420266877;2372.489914668346;2374.263978166774;2431.222008957134;2436.47615762611;2241.8766967816764;2316.4787922717423;2338.263447014185;2342.6837376954063;2345.0502546468706;2293.094227780034;2326.93019209424;2342.5197834443898;2350.142198097682;2352.600057990129;11177.66467005991;11294.435278236055;11351.602693905674;11360.091192704564;11371.829422558669;5983.820485385445;6048.0625503047095;6080.361562035967;6085.756569737206;6088.421599948042;3366.141633883344;3460.7923524588605;3520.119970007498;3549.0772399176144;3560.9109772255642;1301.2062641788502;1305.6344223617402;1314.53334066406;1344.3412727763423;1368.5278578890268;13799.655008624864;14107.435702571885;16106.114163721108;16593.91703041489;16748.58128546784;4841.298011788271;4936.333594964705;4946.975265123651;4951.108800415887;4961.231009193581;10700.678979630467;13052.54316098932;13071;13074.673133171556;13075.411606477732;4966.404031516241;5725.312962444534;5844.970775146097;5863.413658634103;5869.178315035899;5467.480589344006;5474.534664553478;5490.066688662937;5533.335999679984;5575.219469274305;4110.157417729359;4150.896227594334;4186.748795072305;4229.830806767756;4235.915281694349;1084.452351562456;1089.6349722842936;1095.9397233152094;1119.3004372267333;1119.3060302612432;921.5208091792231;939.8496240601471;940.1256831147099;949.7055912667096;1105.8617672790901;7110.857782844418;7179.676914538858;7230.819229519304;7257.673404696801;7327.340539351484;1118.2228351295935;1119.7928383249125;1123.803334416474;1135.5684839761004;1145.524607287983;4717.339572459859;4758.881027974328;4768.928466073012;4830.782614782343;4944.975275123601;14290.928545357414;14859.405623775145;14889.255537223096;14893.18087505176;14900.776488352683;14699.118052916645;14744.262786860614;14748.336324865406;14811.11133331982;14855.405783768745;10432.530536125892;10581.682549523526;10609.098226650667;10664;10664.146868250522;7256.854862902818;7311.159216690149;7333.889991650236;7335.963320183365;7417.92582074194;10995.285306455055;12057.638270851889;12638.431270592662;12768.361581921052;12811.231326120462;12842.67893302675;12914.483420663068;12942.288174150135;12962.22226666403;13099.083064185797;9195.356325057182;9271.072892710945;9351.672691455766;9352.251819854531;9353.906460935576;10694.62568810088;10823.67528974132;10843.969822866815;10861.076808471369;10872;9285.35002549815;9311.301652375963;9345.766355841159;9350.579223934803;9497.810043799223;9118.361714679908;9138.771530711785;9290.953545232502;9568;9581.850177978687;8580.914190858011;8639.438436501607;8690.217880390795;8743.606537705691;8760.255378292917;5869.325027621708;5989.460948514655;6120.663363514871;6183.474404675653;6253.280872699698;6470.417662410217;6608.603483790988;6629.569078009914;6660.500462465431;6810.353016463428 05:51:08 INFO - PROCESS | 3523 | |4;prototype.html;426.9743815371076;437.43789230838377;439.652674387234;456.0354849493323;457.3071796228712;5246.5278124968745;5280.70956097415;5308.522232999029;5310.76101575429;5319.723266416061;5111.923321150186;5198.504717735489;5220.504052115043;5221.817236396727;5232.424433312332;4432.512423633398;4443.84446544371;4448.088141930904;4448.510663826993;4491.483479399862;4501.572350626701;4501.736241225119;4514.909701805962;4514.954850451502;4551.68138230324;4294.269974104394;4429.42417485728;4451.866444006685;4459.598636122749;4521.253993091136;4440.977795111036;4443.2224360736745;4444.622207112399;4446.799894004777;4470.932936005979;4236.957630423687;4253.255680255943;4261.722988005769;4274.636655884223;4290.356446533014;4930.778114984834;5119.948800512022;5124.461931497213;5134.871628209325;5248.21276808478;5170.5346518813485;5172.2241663750365;5174.586033117342;5175.327207463006;5200.92198617021;5562.193481945095;5576.609637325389;5621.634593751393;5663.122216056477;5693.231413759131;4367.759773212472;4609.861704148847;4625.409770528515;4651.48833628304;4684.203685373461;5478.424765399655;5534.869075405957;5659.104874283756;5711.314642242916;5716.056231041017;4756.809727610926;4765.69023013503;4782.928256076161;4797;4800.951990480051;4551.2464958700175;4661.743604101739;4797.136515427256;4852.636052296092;4863.416390033148;4780.521947805261;4922.483139270396;4946.925796113062;5064.240363945438;5111.974440127776;5474.972625136928;5493.258410114663;5503.724813759296;5513.704279494315;5520.309961254843;1601.6786151425122;1660.3441640551914;1660.9086500242602;1667.7741859733087;1670.323518974817;1266.8779793845272;1276.8723127687158;1298.0653929170983;1298.5519995601503;1306.9738605227842;5389.703566303812;5413.296271484682;5427.945720542823;5439;5445;5719.8570035749435;5723.856903577361;5752.28096487939;5775.768969241268;5779.826605201766;5296.232046353257;5332.786688532493;5364.544013758874;5421.322334708161;5501.642393244426;2907.25864904448;2965.377270773162;2968.881244750186;2971.9554206686917;2988.716071973159;5626.634268772516;5884.676342801187;5905.379935106752;5914.64512129265;5916.319623243382;5678;5700.25896633435;5724.255846739898;5772.249607550992;5791.247137872134;5869.413058694182;5884.176215329857;5902.380250073767;5949.643021418815;5966.120671988309;5361.839144825662;5665.801696940587;5685.914711279252;5686.630369026;5733.483986441073;5598.580106491948;5604.719764011702;5634.74643641029;5645.463680950304;5663.292088488939;5651.265335506358;5713.685747283939;5800.970995144998;5931.495822855106;5964.582479226586;4744.667873248977;4786.9521304787895;4787.42550893895;4802.423709154924;4830.130576496264;5517.393086760373;5685.175649530712;5704.344000439836;5783.624064435967;5786.218860453785;5440.836774896759;5442.673439593637;5456.945430545644;5529.529989950899;5531.391546929754;5447.918281225864;5525.640833345819;5550.250716153268;5567;5579.386267510652;5417.972910135424;5502.724863756716;5562.721863906708;5582.246396736388;5600.93582219377;5530.529904958124;5543.1685247213245;5576.609637325349;5580.581456390706;5585.301837270341;5167.173252279617;5383.300170977748;5408.269883565668;5447.455254474521;5472.945270547403 05:51:08 INFO - PROCESS | 3523 | |5;yui.html;854.239726643288;898.31727886806;917.2249449215415;939.8439918899753;963.971080867574;17679.734803977935;18339.266429342828;18749.156287967042;18759.249630014816;19404.90297548514;19068.33260835871;19220.327288544904;19350.225990960378;19389.806101938975;19412.708809367836;888.1828717579842;888.5335199020534;909.1635695160435;922.7646950027734;923.7090316550265;918.8392031394512;920.728385126386;922.0825278847523;922.1746536849515;923.187594916476;972.6060945317158;973.1728031173482;974.3423189347197;975.3708857786723;975.6146322202726;964.4309857184295;968.4431451915177;969.3844408800427;970.898055704148;971.1647982734878;715.2918610575545;715.5420530860254;720.9819754506127;721.239092757141;722.3210182428501;18688.906555467136;18720.719189212035;18810.717839232424;19063.61872762537;19290.4212873614;16023.839761602352;16297.755533667005;16351;16358.918205408896;16659.16704164799;13591;13885.930570347084;13907.652308692263;14396.280185990763;14445.92777036108;4063.857764978241;4099.118689481776;4136.875893723163;4147.3778933159965;4275.230458517465;53791.19313210305;54760;66961;77422.22577774206;77462.45075098523;12920.455899289265;13007.804882926765;13087.541936032194;13227.867721322664;13299.601011969657;24260.51478970446;24306.756932430802;24339.513209736062;24475.26574202777;24625.507489850104;8760.51817150063;8829.11708829112;9053.094690530894;9303.883533975966;9532.237421006303;5155.510226528474;5205.557527610195;5253.185756207794;5295.205719142159;5402.216678581583;3722.3485889969147;3799.6200379962333;3835.0987517933263;3855.248226595843;3885.0870045539277;656.540421704799;656.8325077105308;660.6135410784744;662.3409707341226;662.8011596521121;784.3881772217679;790.3992965346379;812.4312980913267;817.4604760857924;833.7790485521342;11169.888301116885;11435.256708313933;11676.76646467066;11768.293902365886;12077.75844483123;819.0744458761561;823.5388182617753;828.1221904780951;828.3083625172927;835.0855812884881;5037.5214354636255;5539.279893613804;5652.463016013472;5659.349174844863;5680.5455563554815;81461.77807332895;84666.57666711751;85110.5744471286;85846.57076714576;86198.56900715457;50264.24603630949;58830.411695882496;60882.08676869851;61512.38487615067;76084;63729;63790.04314935187;64228.357716423176;64617.67691161514;65115.348846510926;11844.170908036354;12109.576164834189;12199.207051541976;12269.38653067361;12343.69140771488;40304.39543406793;40362.798186010055;42246;42758.78620606877;43775.12449751051;45162.548374515834;45720.77139614281;46416.535834641225;54881.72559137338;55983.72008139933;15890.205489725236;16401;16570.58573535671;16971.575710607332;17038.14809259557;17183.57041073983;17497.12514374302;17500.82499174992;18864.811351886307;19194.328198512983;15364.343783407325;15747.055176689435;16062;16076.196190190678;16228.594285142966;16305.347786088898;16333.918330408273;16647.66704665924;17004.489865304062;17213.483595492155;16165.75751363754;16443.506694799176;16563.254653540862;16671.749618778398;16725.080120593484;11405.942970285096;11464;12037.759244814879;12471.376431178587;12713.93643031816;14445.78331325052;14565.708685826436;14643.56069317922;14710.705785884436;14736.852631473548 05:51:08 INFO - PROCESS | 3523 | __end_tp_report 05:51:08 INFO - PROCESS | 3523 | __start_cc_report 05:51:08 INFO - PROCESS | 3523 | _x_x_mozilla_cycle_collect,1310 05:51:08 INFO - PROCESS | 3523 | __end_cc_report 05:51:08 INFO - PROCESS | 3523 | __startTimestamp1496321468944__endTimestamp 05:51:08 INFO - PROCESS | 3523 | 05:51:08 INFO - PROCESS | 3523 | ------- Summary: start ------- 05:51:08 INFO - PROCESS | 3523 | Number of tests: 6 05:51:08 INFO - PROCESS | 3523 | 05:51:08 INFO - PROCESS | 3523 | [#0] dojo.html Cycles:165 Average:5677.83 Median:5881.06 stddev:635.25 (10.8%) stddev-sans-first:610.65 05:51:08 INFO - PROCESS | 3523 | Values: 3361.2 3369.1 3414.1 3417.1 3460.6 5627.6 5700.9 5703.0 5724.0 5727.0 5691.5 5739.1 5742.6 5747.7 5754.5 5185.8 5217.5 5235.6 5238.8 5279.9 5061.7 5085.7 5304.6 5312.5 5317.5 5175.9 5188.6 5203.2 5212.6 5219.4 5286.6 5286.8 5292.0 5292.3 5293.1 5016.2 5152.7 5216.5 5265.3 5271.8 5568.6 5606.2 5666.0 5681.1 5688.1 6119.3 6164.5 6173.1 6174.4 6176.5 6189.7 6213.3 6221.3 6222.6 6232.7 5568.7 5600.3 5653.8 5669.2 5670.3 6195.1 6195.4 6203.8 6209.2 6210.3 5958.6 5971.2 5976.4 5981.2 5985.2 5895.4 5982.6 5992.4 6079.9 6113.1 6109.3 6109.6 6114.6 6117.1 6133.7 5904.5 5941.5 5942.1 6032.1 6136.0 4604.8 4699.5 4706.8 4712.8 4713.9 4077.8 4084.7 4173.8 4182.1 4215.6 5772.7 5781.8 5838.1 5876.4 5895.2 6120.9 6124.4 6132.9 6139.8 6149.7 5624.8 5840.1 5849.7 5851.9 5855.6 5072.4 5128.6 5157.3 5224.5 5228.6 6363.6 6396.1 6404.0 6410.6 6417.0 6101.0 6113.5 6121.8 6152.9 6160.0 6126.0 6132.9 6263.1 6323.1 6397.7 6099.8 6101.4 6104.1 6122.5 6141.2 6155.2 6174.5 6183.6 6192.4 6196.3 5776.9 5815.0 5884.0 5897.9 5988.3 5976.3 5987.6 5992.0 6014.3 6015.7 5977.8 5984.1 5987.2 6001.2 6006.7 5816.7 5860.3 5864.9 5957.3 5980.6 5849.2 5850.2 5860.8 5881.1 5882.2 05:51:08 INFO - PROCESS | 3523 | 05:51:08 INFO - PROCESS | 3523 | [#1] ext.html Cycles:180 Average:45358.85 Median:168075.62 stddev:73590.56 (43.8%) stddev-sans-first:73720.85 05:51:08 INFO - PROCESS | 3523 | Values: 770.8 842.2 861.3 917.3 933.4 34209.3 43215.4 43998.3 49199.3 49225.8 47050.3 47058.3 47151.8 47152.3 47181.0 7741.5 7902.1 9087.9 9222.5 9224.5 10624.4 10818.8 10825.7 10828.1 10840.2 11003.6 11047.9 11051.7 11053.7 11055.7 10949.9 10958.3 10974.3 10977.1 10992.9 10720.0 10755.4 10765.8 10769.6 10771.2 44232.6 44411.3 44465.6 44473.0 44635.1 4375.1 4406.4 4428.0 4543.2 4545.5 30576.2 30810.0 31286.8 31439.8 33163.3 4277.5 4285.7 4316.2 4332.5 4393.0 243919.0 246725.0 247123.0 247561.0 247581.0 56348.2 56398.2 56472.0 56575.0 56656.2 58353.4 58391.1 58406.7 58407.7 58486.4 16841.6 17239.3 17299.1 17302.3 17310.8 11498.4 11598.2 15241.4 15258.8 15438.6 14028.3 14098.0 14113.6 14141.2 14192.8 5550.4 5557.1 5576.1 5717.4 5757.4 985.4 993.4 998.0 1000.9 1025.4 28642.9 28656.4 28700.0 29080.9 29127.0 1060.4 1066.3 1071.8 1092.7 1105.0 15059.5 15340.0 15391.8 15405.2 15577.8 300937.0 302551.0 303398.0 305555.0 305575.0 54844.7 54863.0 54887.2 55051.4 55291.9 1487.9 1498.3 1513.2 1515.1 1558.3 28505.1 28534.1 29615.4 29819.9 29959.3 38828.6 38894.4 38968.2 38969.8 39007.2 289849.0 293056.0 293443.0 295126.0 295619.0 26029.6 26512.2 29787.9 30233.0 31123.5 40733.6 40843.6 41163.8 41228.0 41316.2 31534.2 31772.7 31809.0 32051.8 32412.0 31418.4 31460.8 31476.7 31692.4 32139.4 35554.5 35758.5 36032.5 36251.1 36439.6 29737.4 29930.9 29984.7 30234.0 30407.5 24318.8 24365.0 24432.8 24503.5 24509.2 05:51:08 INFO - PROCESS | 3523 | 05:51:08 INFO - PROCESS | 3523 | [#2] jquery.html Cycles:180 Average:37703.72 Median:12731.51 stddev:111500.46 (875.8%) stddev-sans-first:111778.17 05:51:08 INFO - PROCESS | 3523 | Values: 454.4 463.2 473.3 477.4 492.2 20352.2 21304.4 21517.5 21561.0 21773.2 22221.8 22360.8 22896.4 23120.5 23149.8 6808.8 7074.0 7493.7 7771.7 7818.8 7343.5 7642.4 7807.1 7846.0 7848.3 7822.8 7825.6 7826.0 7827.2 7833.8 7236.3 7525.6 7566.2 7585.9 7587.7 7414.3 7544.9 7595.6 7630.1 7645.2 25803.7 25969.2 26415.2 26424.6 26779.2 3160.3 3324.5 3343.8 3412.9 3413.7 15631.3 15887.6 16526.3 17020.3 17213.0 2278.9 2302.7 2313.3 2346.5 2359.0 80620.6 82879.0 84828.2 108106.0 109853.5 18096.0 18360.6 18489.6 18887.7 19005.5 32311.0 32357.5 32384.8 32458.8 32488.0 9879.4 10225.0 10263.4 10269.6 10405.3 8321.5 8339.4 8475.1 8612.6 8617.0 8993.3 9148.1 9307.0 9489.2 9540.8 3382.6 3849.2 3894.6 3896.0 3899.1 907.7 910.3 924.4 935.6 935.8 20363.1 21181.4 22628.2 23013.7 23056.0 1082.3 1086.1 1086.7 1104.4 1121.6 11437.9 11628.5 11776.7 11844.2 11852.3 664175.0 664609.0 676318.0 690866.0 702988.0 80511.6 95033.5 113735.0 116837.0 121554.4 1350.9 1362.5 1400.5 1402.9 1403.8 19393.0 19657.5 19675.2 19894.9 20032.8 52282.0 52301.5 52533.5 53162.2 53549.0 69270.3 69824.7 69964.3 70452.6 70897.0 12224.3 12655.7 12759.6 12908.9 13048.6 13328.1 13543.1 13731.5 13924.2 14028.8 11401.9 11642.6 11670.6 11835.5 12037.8 11202.2 11213.9 11305.5 11492.8 11805.4 11569.2 11706.3 11834.0 11912.8 12558.3 11860.3 11963.5 11967.9 12151.5 12309.1 11607.7 11769.4 11882.6 11900.9 12198.0 05:51:08 INFO - PROCESS | 3523 | 05:51:08 INFO - PROCESS | 3523 | [#3] mootools.html Cycles:180 Average:7079.41 Median:2379.83 stddev:4428.52 (186.1%) stddev-sans-first:4421.60 05:51:08 INFO - PROCESS | 3523 | Values: 1570.8 1580.0 1619.7 1625.1 1626.9 10847.4 11616.8 11618.2 11623.3 11624.4 10964.9 11252.2 11256.3 11293.4 11416.7 2470.8 2499.4 2503.7 2508.2 2510.0 2341.4 2357.7 2385.4 2390.2 2396.0 2322.9 2372.5 2374.3 2431.2 2436.5 2241.9 2316.5 2338.3 2342.7 2345.1 2293.1 2326.9 2342.5 2350.1 2352.6 11177.7 11294.4 11351.6 11360.1 11371.8 5983.8 6048.1 6080.4 6085.8 6088.4 3366.1 3460.8 3520.1 3549.1 3560.9 1301.2 1305.6 1314.5 1344.3 1368.5 13799.7 14107.4 16106.1 16593.9 16748.6 4841.3 4936.3 4947.0 4951.1 4961.2 10700.7 13052.5 13071.0 13074.7 13075.4 4966.4 5725.3 5845.0 5863.4 5869.2 5467.5 5474.5 5490.1 5533.3 5575.2 4110.2 4150.9 4186.7 4229.8 4235.9 1084.5 1089.6 1095.9 1119.3 1119.3 921.5 939.8 940.1 949.7 1105.9 7110.9 7179.7 7230.8 7257.7 7327.3 1118.2 1119.8 1123.8 1135.6 1145.5 4717.3 4758.9 4768.9 4830.8 4945.0 14290.9 14859.4 14889.3 14893.2 14900.8 14699.1 14744.3 14748.3 14811.1 14855.4 10432.5 10581.7 10609.1 10664.0 10664.1 7256.9 7311.2 7333.9 7336.0 7417.9 10995.3 12057.6 12638.4 12768.4 12811.2 12842.7 12914.5 12942.3 12962.2 13099.1 9195.4 9271.1 9351.7 9352.3 9353.9 10694.6 10823.7 10844.0 10861.1 10872.0 9285.4 9311.3 9345.8 9350.6 9497.8 9118.4 9138.8 9291.0 9568.0 9581.9 8580.9 8639.4 8690.2 8743.6 8760.3 5869.3 5989.5 6120.7 6183.5 6253.3 6470.4 6608.6 6629.6 6660.5 6810.4 05:51:08 INFO - PROCESS | 3523 | 05:51:08 INFO - PROCESS | 3523 | [#4] prototype.html Cycles:180 Average:4837.72 Median:5315.24 stddev:1278.41 (24.1%) stddev-sans-first:1238.39 05:51:08 INFO - PROCESS | 3523 | Values: 427.0 437.4 439.7 456.0 457.3 5246.5 5280.7 5308.5 5310.8 5319.7 5111.9 5198.5 5220.5 5221.8 5232.4 4432.5 4443.8 4448.1 4448.5 4491.5 4501.6 4501.7 4514.9 4515.0 4551.7 4294.3 4429.4 4451.9 4459.6 4521.3 4441.0 4443.2 4444.6 4446.8 4470.9 4237.0 4253.3 4261.7 4274.6 4290.4 4930.8 5119.9 5124.5 5134.9 5248.2 5170.5 5172.2 5174.6 5175.3 5200.9 5562.2 5576.6 5621.6 5663.1 5693.2 4367.8 4609.9 4625.4 4651.5 4684.2 5478.4 5534.9 5659.1 5711.3 5716.1 4756.8 4765.7 4782.9 4797.0 4801.0 4551.2 4661.7 4797.1 4852.6 4863.4 4780.5 4922.5 4946.9 5064.2 5112.0 5475.0 5493.3 5503.7 5513.7 5520.3 1601.7 1660.3 1660.9 1667.8 1670.3 1266.9 1276.9 1298.1 1298.6 1307.0 5389.7 5413.3 5427.9 5439.0 5445.0 5719.9 5723.9 5752.3 5775.8 5779.8 5296.2 5332.8 5364.5 5421.3 5501.6 2907.3 2965.4 2968.9 2972.0 2988.7 5626.6 5884.7 5905.4 5914.6 5916.3 5678.0 5700.3 5724.3 5772.2 5791.2 5869.4 5884.2 5902.4 5949.6 5966.1 5361.8 5665.8 5685.9 5686.6 5733.5 5598.6 5604.7 5634.7 5645.5 5663.3 5651.3 5713.7 5801.0 5931.5 5964.6 4744.7 4787.0 4787.4 4802.4 4830.1 5517.4 5685.2 5704.3 5783.6 5786.2 5440.8 5442.7 5456.9 5529.5 5531.4 5447.9 5525.6 5550.3 5567.0 5579.4 5418.0 5502.7 5562.7 5582.2 5600.9 5530.5 5543.2 5576.6 5580.6 5585.3 5167.2 5383.3 5408.3 5447.5 5472.9 05:51:08 INFO - PROCESS | 3523 | 05:51:08 INFO - PROCESS | 3523 | [#5] yui.html Cycles:180 Average:18401.07 Median:23196.69 stddev:21284.55 (91.8%) stddev-sans-first:21303.47 05:51:08 INFO - PROCESS | 3523 | Values: 854.2 898.3 917.2 939.8 964.0 17679.7 18339.3 18749.2 18759.2 19404.9 19068.3 19220.3 19350.2 19389.8 19412.7 888.2 888.5 909.2 922.8 923.7 918.8 920.7 922.1 922.2 923.2 972.6 973.2 974.3 975.4 975.6 964.4 968.4 969.4 970.9 971.2 715.3 715.5 721.0 721.2 722.3 18688.9 18720.7 18810.7 19063.6 19290.4 16023.8 16297.8 16351.0 16358.9 16659.2 13591.0 13885.9 13907.7 14396.3 14445.9 4063.9 4099.1 4136.9 4147.4 4275.2 53791.2 54760.0 66961.0 77422.2 77462.5 12920.5 13007.8 13087.5 13227.9 13299.6 24260.5 24306.8 24339.5 24475.3 24625.5 8760.5 8829.1 9053.1 9303.9 9532.2 5155.5 5205.6 5253.2 5295.2 5402.2 3722.3 3799.6 3835.1 3855.2 3885.1 656.5 656.8 660.6 662.3 662.8 784.4 790.4 812.4 817.5 833.8 11169.9 11435.3 11676.8 11768.3 12077.8 819.1 823.5 828.1 828.3 835.1 5037.5 5539.3 5652.5 5659.3 5680.5 81461.8 84666.6 85110.6 85846.6 86198.6 50264.2 58830.4 60882.1 61512.4 76084.0 63729.0 63790.0 64228.4 64617.7 65115.3 11844.2 12109.6 12199.2 12269.4 12343.7 40304.4 40362.8 42246.0 42758.8 43775.1 45162.5 45720.8 46416.5 54881.7 55983.7 15890.2 16401.0 16570.6 16971.6 17038.1 17183.6 17497.1 17500.8 18864.8 19194.3 15364.3 15747.1 16062.0 16076.2 16228.6 16305.3 16333.9 16647.7 17004.5 17213.5 16165.8 16443.5 16563.3 16671.7 16725.1 11405.9 11464.0 12037.8 12471.4 12713.9 14445.8 14565.7 14643.6 14710.7 14736.9 05:51:08 INFO - PROCESS | 3523 | -------- Summary: end -------- 05:51:08 INFO - PROCESS | 3523 | 05:51:09 INFO - TEST-INFO | 3523: exit 0 05:51:09 INFO - TEST-OK | dromaeo_css | took 1116337ms 05:51:09 INFO - TEST-START | kraken 05:51:09 INFO - operating with platform_type : linux_ 05:51:09 INFO - Initialising browser for kraken test... 05:51:09 INFO - TEST-INFO | started process 3826 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPWPctc/profile http://localhost:33633/getInfo.html) 05:51:13 INFO - PROCESS | 3826 | __metrics Screen width/height:1600/1200 05:51:13 INFO - PROCESS | 3826 | colorDepth:24 05:51:13 INFO - PROCESS | 3826 | Browser inner width/height: 1024/697 05:51:13 INFO - PROCESS | 3826 | __metrics 05:51:14 INFO - PROCESS | 3826 | 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" 05:51:14 INFO - PROCESS | 3826 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:51:15 INFO - PROCESS | 3826 | console.error: PushService: 05:51:15 INFO - PROCESS | 3826 | stateChangeProcessEnqueue: Error transitioning state 05:51:15 INFO - PROCESS | 3826 | UnknownError 05:51:15 INFO - TEST-INFO | 3826: exit 0 05:51:15 INFO - Browser initialized. 05:51:15 INFO - Running cycle 1/1 for kraken test... 05:51:15 INFO - TEST-INFO | started process 3919 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPWPctc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:51:27 INFO - PROCESS | 3919 | RSS: Main: 141860864 05:51:27 INFO - PROCESS | 3919 | 05:51:29 INFO - PROCESS | 3919 | Cycle 1(1): loaded http://localhost:33633/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33633/tests/kraken/driver.html?testName=audio-beat-detection) 05:51:30 INFO - PROCESS | 3919 | RSS: Main: 184172544 05:51:30 INFO - PROCESS | 3919 | 05:51:33 INFO - PROCESS | 3919 | Cycle 1(1): loaded http://localhost:33633/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33633/tests/kraken/driver.html?testName=audio-dft) 05:51:33 INFO - PROCESS | 3919 | RSS: Main: 174313472 05:51:33 INFO - PROCESS | 3919 | 05:51:36 INFO - PROCESS | 3919 | Cycle 1(1): loaded http://localhost:33633/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33633/tests/kraken/driver.html?testName=audio-fft) 05:51:37 INFO - PROCESS | 3919 | RSS: Main: 265826304 05:51:37 INFO - PROCESS | 3919 | 05:51:39 INFO - PROCESS | 3919 | Cycle 1(1): loaded http://localhost:33633/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33633/tests/kraken/driver.html?testName=audio-oscillator) 05:51:39 INFO - PROCESS | 3919 | RSS: Main: 171638784 05:51:39 INFO - PROCESS | 3919 | 05:51:41 INFO - PROCESS | 3919 | Cycle 1(1): loaded http://localhost:33633/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33633/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:51:42 INFO - PROCESS | 3919 | RSS: Main: 175005696 05:51:42 INFO - PROCESS | 3919 | 05:51:45 INFO - PROCESS | 3919 | Cycle 1(1): loaded http://localhost:33633/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33633/tests/kraken/driver.html?testName=imaging-darkroom) 05:51:45 INFO - PROCESS | 3919 | RSS: Main: 209854464 05:51:45 INFO - PROCESS | 3919 | 05:51:49 INFO - PROCESS | 3919 | Cycle 1(1): loaded http://localhost:33633/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33633/tests/kraken/driver.html?testName=imaging-desaturate) 05:51:49 INFO - PROCESS | 3919 | RSS: Main: 211501056 05:51:49 INFO - PROCESS | 3919 | 05:51:52 INFO - PROCESS | 3919 | Cycle 1(1): loaded http://localhost:33633/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33633/tests/kraken/driver.html?testName=json-parse-financial) 05:51:53 INFO - PROCESS | 3919 | RSS: Main: 211189760 05:51:53 INFO - PROCESS | 3919 | 05:51:54 INFO - PROCESS | 3919 | Cycle 1(1): loaded http://localhost:33633/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33633/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:51:55 INFO - PROCESS | 3919 | RSS: Main: 173821952 05:51:55 INFO - PROCESS | 3919 | 05:51:56 INFO - PROCESS | 3919 | Cycle 1(1): loaded http://localhost:33633/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33633/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:51:57 INFO - PROCESS | 3919 | RSS: Main: 180887552 05:51:57 INFO - PROCESS | 3919 | 05:51:59 INFO - PROCESS | 3919 | Cycle 1(1): loaded http://localhost:33633/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33633/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:52:00 INFO - PROCESS | 3919 | RSS: Main: 190087168 05:52:00 INFO - PROCESS | 3919 | 05:52:02 INFO - PROCESS | 3919 | Cycle 1(1): loaded http://localhost:33633/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33633/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:52:03 INFO - PROCESS | 3919 | RSS: Main: 197963776 05:52:03 INFO - PROCESS | 3919 | 05:52:06 INFO - PROCESS | 3919 | Cycle 1(1): loaded http://localhost:33633/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33633/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:52:06 INFO - PROCESS | 3919 | RSS: Main: 195629056 05:52:06 INFO - PROCESS | 3919 | 05:52:08 INFO - PROCESS | 3919 | Cycle 1(1): loaded http://localhost:33633/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33633/tests/kraken/driver.html?testName=ai-astar) 05:52:08 INFO - PROCESS | 3919 | RSS: Main: 245600256 05:52:08 INFO - PROCESS | 3919 | 05:52:08 INFO - PROCESS | 3919 | __start_tp_report 05:52:08 INFO - PROCESS | 3919 | _x_x_mozilla_page_load 05:52:08 INFO - PROCESS | 3919 | _x_x_mozilla_page_load_details 05:52:08 INFO - PROCESS | 3919 | |i|pagename|runs| 05:52:08 INFO - PROCESS | 3919 | |0;ai-astar;103;113;111;112;112;113;111;113;111;111 05:52:08 INFO - PROCESS | 3919 | |1;audio-beat-detection;137;114;116;148;115;116;115;115;136;114 05:52:08 INFO - PROCESS | 3919 | |2;audio-dft;160;159;159;160;159;158;161;162;159;159 05:52:08 INFO - PROCESS | 3919 | |3;audio-fft;74;74;74;104;77;75;75;76;95;77 05:52:08 INFO - PROCESS | 3919 | |4;audio-oscillator;82;82;111;82;82;83;106;82;81;107 05:52:08 INFO - PROCESS | 3919 | |5;imaging-gaussian-blur;113;112;112;112;113;113;113;113;112;112 05:52:08 INFO - PROCESS | 3919 | |6;imaging-darkroom;146;147;146;146;146;145;145;146;145;146 05:52:08 INFO - PROCESS | 3919 | |7;imaging-desaturate;93;94;94;94;93;93;94;94;94;93 05:52:08 INFO - PROCESS | 3919 | |8;json-parse-financial;55;56;55;53;54;59;55;52;54;54 05:52:08 INFO - PROCESS | 3919 | |9;json-stringify-tinderbox;53;53;53;52;53;53;53;53;53;53 05:52:08 INFO - PROCESS | 3919 | |10;stanford-crypto-aes;76;81;79;81;76;83;77;84;79;79 05:52:08 INFO - PROCESS | 3919 | |11;stanford-crypto-ccm;122;119;118;119;118;119;126;120;164;126 05:52:08 INFO - PROCESS | 3919 | |12;stanford-crypto-pbkdf2;162;161;160;161;165;160;164;159;157;158 05:52:08 INFO - PROCESS | 3919 | |13;stanford-crypto-sha256-iterative;63;61;59;60;61;60;61;59;62;58 05:52:08 INFO - PROCESS | 3919 | __end_tp_report 05:52:08 INFO - PROCESS | 3919 | __start_cc_report 05:52:08 INFO - PROCESS | 3919 | _x_x_mozilla_cycle_collect,1698 05:52:08 INFO - PROCESS | 3919 | __end_cc_report 05:52:08 INFO - PROCESS | 3919 | __startTimestamp1496321528587__endTimestamp 05:52:08 INFO - PROCESS | 3919 | 05:52:08 INFO - PROCESS | 3919 | ------- Summary: start ------- 05:52:08 INFO - PROCESS | 3919 | Number of tests: 14 05:52:08 INFO - PROCESS | 3919 | 05:52:08 INFO - PROCESS | 3919 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:2.94 (2.6%) stddev-sans-first:0.93 05:52:08 INFO - PROCESS | 3919 | Values: 103.0 113.0 111.0 112.0 112.0 113.0 111.0 113.0 111.0 111.0 05:52:08 INFO - PROCESS | 3919 | 05:52:08 INFO - PROCESS | 3919 | [#1] audio-beat-detection Cycles:10 Average:122.60 Median:116.00 stddev:12.65 (10.9%) stddev-sans-first:12.30 05:52:08 INFO - PROCESS | 3919 | Values: 137.0 114.0 116.0 148.0 115.0 116.0 115.0 115.0 136.0 114.0 05:52:08 INFO - PROCESS | 3919 | 05:52:08 INFO - PROCESS | 3919 | [#2] audio-dft Cycles:10 Average:159.60 Median:159.50 stddev:1.17 (0.7%) stddev-sans-first:1.24 05:52:08 INFO - PROCESS | 3919 | Values: 160.0 159.0 159.0 160.0 159.0 158.0 161.0 162.0 159.0 159.0 05:52:08 INFO - PROCESS | 3919 | 05:52:08 INFO - PROCESS | 3919 | [#3] audio-fft Cycles:10 Average:80.10 Median:75.50 stddev:10.50 (13.9%) stddev-sans-first:10.91 05:52:08 INFO - PROCESS | 3919 | Values: 74.0 74.0 74.0 104.0 77.0 75.0 75.0 76.0 95.0 77.0 05:52:08 INFO - PROCESS | 3919 | 05:52:08 INFO - PROCESS | 3919 | [#4] audio-oscillator Cycles:10 Average:89.80 Median:82.00 stddev:12.63 (15.4%) stddev-sans-first:13.08 05:52:08 INFO - PROCESS | 3919 | Values: 82.0 82.0 111.0 82.0 82.0 83.0 106.0 82.0 81.0 107.0 05:52:08 INFO - PROCESS | 3919 | 05:52:08 INFO - PROCESS | 3919 | [#5] imaging-gaussian-blur Cycles:10 Average:112.50 Median:113.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 05:52:08 INFO - PROCESS | 3919 | Values: 113.0 112.0 112.0 112.0 113.0 113.0 113.0 113.0 112.0 112.0 05:52:08 INFO - PROCESS | 3919 | 05:52:08 INFO - PROCESS | 3919 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 05:52:08 INFO - PROCESS | 3919 | Values: 146.0 147.0 146.0 146.0 146.0 145.0 145.0 146.0 145.0 146.0 05:52:08 INFO - PROCESS | 3919 | 05:52:08 INFO - PROCESS | 3919 | [#7] imaging-desaturate Cycles:10 Average:93.60 Median:94.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 05:52:08 INFO - PROCESS | 3919 | Values: 93.0 94.0 94.0 94.0 93.0 93.0 94.0 94.0 94.0 93.0 05:52:08 INFO - PROCESS | 3919 | 05:52:08 INFO - PROCESS | 3919 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:1.89 (3.4%) stddev-sans-first:2.00 05:52:08 INFO - PROCESS | 3919 | Values: 55.0 56.0 55.0 53.0 54.0 59.0 55.0 52.0 54.0 54.0 05:52:08 INFO - PROCESS | 3919 | 05:52:08 INFO - PROCESS | 3919 | [#9] json-stringify-tinderbox Cycles:10 Average:52.90 Median:53.00 stddev:0.32 (0.6%) stddev-sans-first:0.33 05:52:08 INFO - PROCESS | 3919 | Values: 53.0 53.0 53.0 52.0 53.0 53.0 53.0 53.0 53.0 53.0 05:52:08 INFO - PROCESS | 3919 | 05:52:08 INFO - PROCESS | 3919 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:80.00 stddev:2.76 (3.4%) stddev-sans-first:2.62 05:52:08 INFO - PROCESS | 3919 | Values: 76.0 81.0 79.0 81.0 76.0 83.0 77.0 84.0 79.0 79.0 05:52:08 INFO - PROCESS | 3919 | 05:52:08 INFO - PROCESS | 3919 | [#11] stanford-crypto-ccm Cycles:10 Average:125.10 Median:121.00 stddev:14.00 (11.6%) stddev-sans-first:14.80 05:52:08 INFO - PROCESS | 3919 | Values: 122.0 119.0 118.0 119.0 118.0 119.0 126.0 120.0 164.0 126.0 05:52:08 INFO - PROCESS | 3919 | 05:52:08 INFO - PROCESS | 3919 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.70 Median:161.00 stddev:2.50 (1.6%) stddev-sans-first:2.60 05:52:08 INFO - PROCESS | 3919 | Values: 162.0 161.0 160.0 161.0 165.0 160.0 164.0 159.0 157.0 158.0 05:52:08 INFO - PROCESS | 3919 | 05:52:08 INFO - PROCESS | 3919 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.40 Median:61.00 stddev:1.51 (2.5%) stddev-sans-first:1.27 05:52:08 INFO - PROCESS | 3919 | Values: 63.0 61.0 59.0 60.0 61.0 60.0 61.0 59.0 62.0 58.0 05:52:08 INFO - PROCESS | 3919 | -------- Summary: end -------- 05:52:08 INFO - PROCESS | 3919 | 05:52:09 INFO - TEST-INFO | 3919: exit 0 05:52:09 INFO - TEST-OK | kraken | took 59998ms 05:52:09 INFO - SUITE-END | took 1176s 05:52:09 INFO - Completed test suite (00:19:36) 05:52:09 INFO - javascript benchmark 05:52:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7918.394911860624, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3361.243720162965, 3369.1408690783846, 3414.061133188372, 3417.0773891049403, 3460.619331873495, 5627.606067575266, 5700.8859822803515, 5702.971485142569, 5724.0, 5726.997775389311, 5691.51622112121, 5739.110437882135, 5742.569307301948, 5747.741351639176, 5754.4533269339345, 5185.784813415678, 5217.478252174771, 5235.607329450288, 5238.7642556084875, 5279.947200528003, 5061.670991385548, 5085.745712714368, 5304.602154838402, 5312.548433383147, 5317.548008419289, 5175.922361164586, 5188.558972487343, 5203.167493201088, 5212.582993360541, 5219.373675158968, 5286.629935904488, 5286.814961476368, 5292.047431462373, 5292.285541451932, 5293.100172970604, 5016.172331565287, 5152.690838549662, 5216.478352164753, 5265.262863199156, 5271.815486457994, 5568.554515638739, 5606.159076138571, 5665.971670141664, 5681.091025435951, 5688.061469857468, 6119.296280927706, 6164.537659675542, 6173.104899789505, 6174.413430724074, 6176.536759743038, 6189.711412810351, 6213.285472170713, 6221.253449586034, 6222.5644204905675, 6232.719527621268, 5568.7215639217875, 5600.327960644708, 5653.830385088454, 5669.206311116447, 5670.291213598301, 6195.101710251988, 6195.4424101831055, 6203.8138855834395, 6209.192804935329, 6210.254769427697, 5958.6424814511265, 5971.193888824953, 5976.432238937294, 5981.162637230791, 5985.221921150222, 5895.35151133375, 5982.611130276518, 5992.400759923973, 6079.878402431927, 6113.052476866093, 6109.327973922865, 6109.602875813058, 6114.633122012693, 6117.066276512122, 6133.662648554372, 5904.468597826216, 5941.494972927349, 5942.138389933435, 6032.125341825411, 6135.969320153371, 4604.7927843247135, 4699.506551812079, 4706.8117275308605, 4712.787924543404, 4713.929291060636, 4077.836886524565, 4084.6732261419015, 4173.83304667816, 4182.059036716714, 4215.578442155821, 5772.6536407815665, 5781.82654520365, 5838.12428135783, 5876.382979787061, 5895.20414744004, 6120.938790612126, 6124.448799608057, 6132.877342453126, 6139.754409823557, 6149.661768602769, 5624.831255062355, 5840.065589505743, 5849.6782676952325, 5851.882962340815, 5855.648661080264, 5072.365954255718, 5128.640995130305, 5157.277981082651, 5224.451432599599, 5228.607854410934, 6363.58636688623, 6396.072569477493, 6404.0, 6410.61536307823, 6416.967915160394, 6100.969495152496, 6113.5414843886, 6121.785737499166, 6152.907706384497, 6159.969200153971, 6126.029144987462, 6132.9386706134155, 6263.09185168139, 6323.146375239284, 6397.744090236339, 6099.75600975956, 6101.420365065312, 6104.084387341934, 6122.510199184144, 6141.201643786279, 6155.182050463032, 6174.536909731698, 6183.598066125687, 6192.411720886508, 6196.318404975539, 5776.855578610568, 5814.970925145347, 5884.0, 5897.852553686193, 5988.311344195299, 5976.312724036791, 5987.550933679904, 5992.0, 6014.338422773579, 6015.72929218195, 5977.760889564369, 5984.072468767348, 5987.161797348288, 6001.2498437695285, 6006.699665016819, 5816.70916454184, 5860.267466566679, 5864.912026319694, 5957.3446920837805, 5980.5514586405325, 5849.210356601804, 5850.151727999501, 5860.765569377178, 5881.05903055509, 5882.205902203148], "value": 5636.090681456362, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [770.7957391291305, 842.1704620948366, 861.3324673378131, 917.2891009467666, 933.4352716606448, 34209.315813683745, 43215.35176972344, 43998.34002489961, 49199.26201106986, 49225.753871230685, 47050.29424558626, 47058.294125588145, 47151.764241178746, 47152.292715609205, 47181.0, 7741.535507869546, 7902.130765615778, 9087.863682044775, 9222.492762898039, 9224.492652904088, 10624.36253824773, 10818.783624327509, 10825.67522974312, 10828.079613232885, 10840.241183117185, 11003.559857605685, 11047.944760276187, 11051.72370690735, 11053.668389948314, 11055.72360690981, 10949.945250273737, 10958.28771129878, 10974.286671366335, 10977.066949309357, 10992.945035274852, 10720.0, 10755.354678719303, 10765.784684306349, 10769.62306319275, 10771.192160587909, 44232.557674423486, 44411.333829992254, 44465.55534444647, 44473.0, 44635.107297854185, 4375.124975005012, 4406.405135306724, 4427.977860110679, 4543.204939135638, 4545.522720114406, 30576.2355941101, 30809.99735017217, 31286.843565782026, 31439.84280078585, 33163.33673326544, 4277.508086570053, 4285.721428107163, 4316.2446571849805, 4332.523422423531, 4393.011572396217, 243919.0, 246725.0, 247123.0, 247561.0, 247581.0, 56348.15477767837, 56398.15402768962, 56472.0, 56575.0, 56656.15015774767, 58353.4164658348, 58391.12413313804, 58406.70796645989, 58407.70796145992, 58486.415135848096, 16841.57896052584, 17239.31042758301, 17299.13504324779, 17302.307907683553, 17310.826891731173, 11498.425078746197, 11598.246114002732, 15241.390344386322, 15258.771118433233, 15438.614034649223, 14028.298585070706, 14098.0, 14113.647158821112, 14141.151530907973, 14192.787108193384, 5550.361708403505, 5557.110862262019, 5576.107822748422, 5717.399673034354, 5757.424257574293, 985.4186030242191, 993.3841018568534, 997.9550920208463, 1000.8648832407678, 1025.3642741500319, 28642.856785716354, 28656.426871462452, 28700.0, 29080.85459572731, 29127.0, 1060.4114716332356, 1066.3495267886583, 1071.769569542552, 1092.6612750047511, 1105.0441368216595, 15059.472918447802, 15340.0, 15391.846081539265, 15405.15271660047, 15577.844221557865, 300937.0, 302551.0, 303398.0, 305555.0, 305575.0, 54844.72577637086, 54863.0, 54887.17669234965, 55051.44948550463, 55291.894162116536, 1487.9256037198313, 1498.3482185249452, 1513.1677577332423, 1515.121229686779, 1558.2598265823642, 28505.144845654664, 28534.1452805567, 29615.407691845612, 29819.850900745358, 29959.251018724706, 38828.6117138825, 38894.41658375183, 38968.2206355877, 38969.80515097406, 39007.219855603296, 289849.0, 293056.0, 293443.0, 295126.0, 295619.0, 26029.609555857056, 26512.204633861016, 29787.851060744557, 30233.0, 31123.533147003265, 40733.59266407298, 40843.59156408517, 41163.794181028905, 41228.0, 41316.1736765269, 31534.211644709067, 31772.68227317697, 31809.0, 32051.83974080208, 32412.0, 31418.37163256768, 31460.842695786374, 31476.685233147375, 31692.366152677278, 32139.35721285608, 35554.46668299926, 35758.4636230462, 36032.459513107846, 36251.09372265715, 36439.63560364363, 29737.405251894408, 29930.85034574813, 29984.700152999063, 30234.0, 30407.54388684216, 24318.75681243165, 24365.0, 24432.755672443047, 24503.50992980166, 24509.21479333155], "value": 19031.589575909686, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [454.3616219212008, 463.23797353353734, 473.29715372671575, 477.357953552472, 492.22720329083336, 20352.1859125635, 21304.36086917391, 21517.46206344842, 21561.0, 21773.23793667222, 22221.777782222172, 22360.776392236112, 22896.427589310275, 23120.537589248204, 23149.76850231497, 6808.829779255521, 7074.045003924456, 7493.700251989914, 7771.689132434696, 7818.80452988677, 7343.485955983083, 7642.426817988645, 7807.063152421717, 7846.0, 7848.332891704212, 7822.843543129134, 7825.647845846951, 7825.960870195641, 7827.178146294643, 7833.843323133534, 7236.312550307713, 7525.623718814065, 7566.205548417392, 7585.886211706828, 7587.734429295004, 7414.295641914009, 7544.886826697604, 7595.582242976634, 7630.122535908386, 7645.235476452366, 25803.74196258051, 25969.22092337233, 26415.225878416208, 26424.603630945552, 26779.196624101307, 3160.3047329587453, 3324.4680851063713, 3343.799372037661, 3412.897613071587, 3413.6586341365914, 15631.296591653403, 15887.60280992973, 16526.256318465697, 17020.319187232497, 17213.0, 2278.931632051041, 2302.6661134135625, 2313.2597568777996, 2346.5424242272766, 2358.988205058981, 80620.59689701573, 82879.0, 84828.15171848264, 108105.99999999921, 109853.45073274663, 18096.0, 18360.632787344177, 18489.630207395778, 18887.716684249746, 19005.524861878286, 32311.0, 32357.51463728046, 32384.83807580994, 32458.83770581179, 32488.0, 9879.407235565888, 10225.0, 10263.435511046815, 10269.589216431408, 10405.323653962469, 8321.459105158145, 8339.416240863082, 8475.067742548315, 8612.612432440555, 8616.956915215509, 8993.32550058735, 9148.130927561871, 9306.97423391361, 9489.193418559362, 9540.761480963032, 3382.644822293673, 3849.2493963676816, 3894.5796520948925, 3895.96104038956, 3899.1123403660677, 907.6913849291141, 910.3127139010005, 924.4129977464358, 935.5602866652663, 935.7754139006726, 20363.08366123528, 21181.36455906325, 22628.208952255987, 23013.654795178085, 23056.0, 1082.3073233130804, 1086.1310951238977, 1086.7337502311984, 1104.447776111944, 1121.5569849909402, 11437.942810286062, 11628.543966852478, 11776.70558236051, 11844.170908036527, 11852.288862668267, 664175.0, 664609.0, 676318.0, 690866.0, 702988.0, 80511.59744201241, 95033.52483237677, 113735.0, 116837.0, 121554.3922280383, 1350.9392077356542, 1362.4958765256918, 1400.544822932551, 1402.9088109272864, 1403.8385585657577, 19393.0, 19657.508562286057, 19675.212991480752, 19894.90052549728, 20032.79803211812, 52282.0, 52301.47698522966, 52533.47466525438, 53162.202566960754, 53549.0, 69270.30729692639, 69824.65087674529, 69964.30035699578, 70452.64773676099, 70897.0, 12224.327661978676, 12655.683607909508, 12759.596444391294, 12908.870911290767, 13048.608541743763, 13328.067035307824, 13543.119697219649, 13731.519396821062, 13924.164550127025, 14028.789568156282, 11401.942990284995, 11642.592509262135, 11670.591529296435, 11835.46740396667, 12037.759244814879, 11202.15983801202, 11213.887861121611, 11305.547778088785, 11492.827607585725, 11805.350705711267, 11569.19015668895, 11706.297622142698, 11834.0, 11912.821307680566, 12558.309292988608, 11860.288382697066, 11963.461644226205, 11967.880321197024, 12151.453184606891, 12309.076819238413, 11607.6517704469, 11769.411529423323, 11882.643520694393, 11900.940495297467, 12198.0], "value": 11656.53422619692, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1570.7879436276107, 1580.0, 1619.7003554342448, 1625.146797931086, 1626.8942518736278, 10847.403392813401, 11616.825747613793, 11618.186726929118, 11623.302601843896, 11624.418779061045, 10964.890351096486, 11252.15608829337, 11256.268342557749, 11293.378864162467, 11416.657500274985, 2470.7899828514596, 2499.387650025737, 2503.699556053276, 2508.197376839403, 2510.0336370497307, 2341.356127065054, 2357.6581395697613, 2385.403649087728, 2390.1514962188435, 2395.9520809583796, 2322.8722420266877, 2372.489914668346, 2374.263978166774, 2431.222008957134, 2436.47615762611, 2241.8766967816764, 2316.4787922717423, 2338.263447014185, 2342.6837376954063, 2345.0502546468706, 2293.094227780034, 2326.93019209424, 2342.5197834443898, 2350.142198097682, 2352.600057990129, 11177.66467005991, 11294.435278236055, 11351.602693905674, 11360.091192704564, 11371.829422558669, 5983.820485385445, 6048.0625503047095, 6080.361562035967, 6085.756569737206, 6088.421599948042, 3366.141633883344, 3460.7923524588605, 3520.119970007498, 3549.0772399176144, 3560.9109772255642, 1301.2062641788502, 1305.6344223617402, 1314.53334066406, 1344.3412727763423, 1368.5278578890268, 13799.655008624864, 14107.435702571885, 16106.114163721108, 16593.91703041489, 16748.58128546784, 4841.298011788271, 4936.333594964705, 4946.975265123651, 4951.108800415887, 4961.231009193581, 10700.678979630467, 13052.54316098932, 13071.0, 13074.673133171556, 13075.411606477732, 4966.404031516241, 5725.312962444534, 5844.970775146097, 5863.413658634103, 5869.178315035899, 5467.480589344006, 5474.534664553478, 5490.066688662937, 5533.335999679984, 5575.219469274305, 4110.157417729359, 4150.896227594334, 4186.748795072305, 4229.830806767756, 4235.915281694349, 1084.452351562456, 1089.6349722842936, 1095.9397233152094, 1119.3004372267333, 1119.3060302612432, 921.5208091792231, 939.8496240601471, 940.1256831147099, 949.7055912667096, 1105.8617672790901, 7110.857782844418, 7179.676914538858, 7230.819229519304, 7257.673404696801, 7327.340539351484, 1118.2228351295935, 1119.7928383249125, 1123.803334416474, 1135.5684839761004, 1145.524607287983, 4717.339572459859, 4758.881027974328, 4768.928466073012, 4830.782614782343, 4944.975275123601, 14290.928545357414, 14859.405623775145, 14889.255537223096, 14893.18087505176, 14900.776488352683, 14699.118052916645, 14744.262786860614, 14748.336324865406, 14811.11133331982, 14855.405783768745, 10432.530536125892, 10581.682549523526, 10609.098226650667, 10664.0, 10664.146868250522, 7256.854862902818, 7311.159216690149, 7333.889991650236, 7335.963320183365, 7417.92582074194, 10995.285306455055, 12057.638270851889, 12638.431270592662, 12768.361581921052, 12811.231326120462, 12842.67893302675, 12914.483420663068, 12942.288174150135, 12962.22226666403, 13099.083064185797, 9195.356325057182, 9271.072892710945, 9351.672691455766, 9352.251819854531, 9353.906460935576, 10694.62568810088, 10823.67528974132, 10843.969822866815, 10861.076808471369, 10872.0, 9285.35002549815, 9311.301652375963, 9345.766355841159, 9350.579223934803, 9497.810043799223, 9118.361714679908, 9138.771530711785, 9290.953545232502, 9568.0, 9581.850177978687, 8580.914190858011, 8639.438436501607, 8690.217880390795, 8743.606537705691, 8760.255378292917, 5869.325027621708, 5989.460948514655, 6120.663363514871, 6183.474404675653, 6253.280872699698, 6470.417662410217, 6608.603483790988, 6629.569078009914, 6660.500462465431, 6810.353016463428], "value": 5391.017897172315, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [426.9743815371076, 437.43789230838377, 439.652674387234, 456.0354849493323, 457.3071796228712, 5246.5278124968745, 5280.70956097415, 5308.522232999029, 5310.76101575429, 5319.723266416061, 5111.923321150186, 5198.504717735489, 5220.504052115043, 5221.817236396727, 5232.424433312332, 4432.512423633398, 4443.84446544371, 4448.088141930904, 4448.510663826993, 4491.483479399862, 4501.572350626701, 4501.736241225119, 4514.909701805962, 4514.954850451502, 4551.68138230324, 4294.269974104394, 4429.42417485728, 4451.866444006685, 4459.598636122749, 4521.253993091136, 4440.977795111036, 4443.2224360736745, 4444.622207112399, 4446.799894004777, 4470.932936005979, 4236.957630423687, 4253.255680255943, 4261.722988005769, 4274.636655884223, 4290.356446533014, 4930.778114984834, 5119.948800512022, 5124.461931497213, 5134.871628209325, 5248.21276808478, 5170.5346518813485, 5172.2241663750365, 5174.586033117342, 5175.327207463006, 5200.92198617021, 5562.193481945095, 5576.609637325389, 5621.634593751393, 5663.122216056477, 5693.231413759131, 4367.759773212472, 4609.861704148847, 4625.409770528515, 4651.48833628304, 4684.203685373461, 5478.424765399655, 5534.869075405957, 5659.104874283756, 5711.314642242916, 5716.056231041017, 4756.809727610926, 4765.69023013503, 4782.928256076161, 4797.0, 4800.951990480051, 4551.2464958700175, 4661.743604101739, 4797.136515427256, 4852.636052296092, 4863.416390033148, 4780.521947805261, 4922.483139270396, 4946.925796113062, 5064.240363945438, 5111.974440127776, 5474.972625136928, 5493.258410114663, 5503.724813759296, 5513.704279494315, 5520.309961254843, 1601.6786151425122, 1660.3441640551914, 1660.9086500242602, 1667.7741859733087, 1670.323518974817, 1266.8779793845272, 1276.8723127687158, 1298.0653929170983, 1298.5519995601503, 1306.9738605227842, 5389.703566303812, 5413.296271484682, 5427.945720542823, 5439.0, 5445.0, 5719.8570035749435, 5723.856903577361, 5752.28096487939, 5775.768969241268, 5779.826605201766, 5296.232046353257, 5332.786688532493, 5364.544013758874, 5421.322334708161, 5501.642393244426, 2907.25864904448, 2965.377270773162, 2968.881244750186, 2971.9554206686917, 2988.716071973159, 5626.634268772516, 5884.676342801187, 5905.379935106752, 5914.64512129265, 5916.319623243382, 5678.0, 5700.25896633435, 5724.255846739898, 5772.249607550992, 5791.247137872134, 5869.413058694182, 5884.176215329857, 5902.380250073767, 5949.643021418815, 5966.120671988309, 5361.839144825662, 5665.801696940587, 5685.914711279252, 5686.630369026, 5733.483986441073, 5598.580106491948, 5604.719764011702, 5634.74643641029, 5645.463680950304, 5663.292088488939, 5651.265335506358, 5713.685747283939, 5800.970995144998, 5931.495822855106, 5964.582479226586, 4744.667873248977, 4786.9521304787895, 4787.42550893895, 4802.423709154924, 4830.130576496264, 5517.393086760373, 5685.175649530712, 5704.344000439836, 5783.624064435967, 5786.218860453785, 5440.836774896759, 5442.673439593637, 5456.945430545644, 5529.529989950899, 5531.391546929754, 5447.918281225864, 5525.640833345819, 5550.250716153268, 5567.0, 5579.386267510652, 5417.972910135424, 5502.724863756716, 5562.721863906708, 5582.246396736388, 5600.93582219377, 5530.529904958124, 5543.1685247213245, 5576.609637325349, 5580.581456390706, 5585.301837270341, 5167.173252279617, 5383.300170977748, 5408.269883565668, 5447.455254474521, 5472.945270547403], "value": 4471.229689051156, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [854.239726643288, 898.31727886806, 917.2249449215415, 939.8439918899753, 963.971080867574, 17679.734803977935, 18339.266429342828, 18749.156287967042, 18759.249630014816, 19404.90297548514, 19068.33260835871, 19220.327288544904, 19350.225990960378, 19389.806101938975, 19412.708809367836, 888.1828717579842, 888.5335199020534, 909.1635695160435, 922.7646950027734, 923.7090316550265, 918.8392031394512, 920.728385126386, 922.0825278847523, 922.1746536849515, 923.187594916476, 972.6060945317158, 973.1728031173482, 974.3423189347197, 975.3708857786723, 975.6146322202726, 964.4309857184295, 968.4431451915177, 969.3844408800427, 970.898055704148, 971.1647982734878, 715.2918610575545, 715.5420530860254, 720.9819754506127, 721.239092757141, 722.3210182428501, 18688.906555467136, 18720.719189212035, 18810.717839232424, 19063.61872762537, 19290.4212873614, 16023.839761602352, 16297.755533667005, 16351.0, 16358.918205408896, 16659.16704164799, 13591.0, 13885.930570347084, 13907.652308692263, 14396.280185990763, 14445.92777036108, 4063.857764978241, 4099.118689481776, 4136.875893723163, 4147.3778933159965, 4275.230458517465, 53791.19313210305, 54760.0, 66961.0, 77422.22577774206, 77462.45075098523, 12920.455899289265, 13007.804882926765, 13087.541936032194, 13227.867721322664, 13299.601011969657, 24260.51478970446, 24306.756932430802, 24339.513209736062, 24475.26574202777, 24625.507489850104, 8760.51817150063, 8829.11708829112, 9053.094690530894, 9303.883533975966, 9532.237421006303, 5155.510226528474, 5205.557527610195, 5253.185756207794, 5295.205719142159, 5402.216678581583, 3722.3485889969147, 3799.6200379962333, 3835.0987517933263, 3855.248226595843, 3885.0870045539277, 656.540421704799, 656.8325077105308, 660.6135410784744, 662.3409707341226, 662.8011596521121, 784.3881772217679, 790.3992965346379, 812.4312980913267, 817.4604760857924, 833.7790485521342, 11169.888301116885, 11435.256708313933, 11676.76646467066, 11768.293902365886, 12077.75844483123, 819.0744458761561, 823.5388182617753, 828.1221904780951, 828.3083625172927, 835.0855812884881, 5037.5214354636255, 5539.279893613804, 5652.463016013472, 5659.349174844863, 5680.5455563554815, 81461.77807332895, 84666.57666711751, 85110.5744471286, 85846.57076714576, 86198.56900715457, 50264.24603630949, 58830.411695882496, 60882.08676869851, 61512.38487615067, 76084.0, 63729.0, 63790.04314935187, 64228.357716423176, 64617.67691161514, 65115.348846510926, 11844.170908036354, 12109.576164834189, 12199.207051541976, 12269.38653067361, 12343.69140771488, 40304.39543406793, 40362.798186010055, 42246.0, 42758.78620606877, 43775.12449751051, 45162.548374515834, 45720.77139614281, 46416.535834641225, 54881.72559137338, 55983.72008139933, 15890.205489725236, 16401.0, 16570.58573535671, 16971.575710607332, 17038.14809259557, 17183.57041073983, 17497.12514374302, 17500.82499174992, 18864.811351886307, 19194.328198512983, 15364.343783407325, 15747.055176689435, 16062.0, 16076.196190190678, 16228.594285142966, 16305.347786088898, 16333.918330408273, 16647.66704665924, 17004.489865304062, 17213.483595492155, 16165.75751363754, 16443.506694799176, 16563.254653540862, 16671.749618778398, 16725.080120593484, 11405.942970285096, 11464.0, 12037.759244814879, 12471.376431178587, 12713.93643031816, 14445.78331325052, 14565.708685826436, 14643.56069317922, 14710.705785884436, 14736.852631473548], "value": 8178.3157360396135, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1448.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 111.0, 112.0, 112.0, 113.0, 111.0, 113.0, 111.0, 111.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 114.0, 116.0, 148.0, 115.0, 116.0, 115.0, 115.0, 136.0, 114.0], "value": 122.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 159.0, 160.0, 159.0, 158.0, 161.0, 162.0, 159.0, 159.0], "value": 159.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 104.0, 77.0, 75.0, 75.0, 76.0, 95.0, 77.0], "value": 80.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 111.0, 82.0, 82.0, 83.0, 106.0, 82.0, 81.0, 107.0], "value": 89.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 112.0, 112.0, 113.0, 113.0, 113.0, 113.0, 112.0, 112.0], "value": 112.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 93.0, 93.0, 94.0, 94.0, 94.0, 93.0], "value": 93.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 53.0, 54.0, 59.0, 55.0, 52.0, 54.0, 54.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 52.0, 53.0, 53.0, 53.0, 53.0, 53.0, 53.0], "value": 52.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 81.0, 79.0, 81.0, 76.0, 83.0, 77.0, 84.0, 79.0, 79.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 119.0, 118.0, 119.0, 118.0, 119.0, 126.0, 120.0, 164.0, 126.0], "value": 125.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 161.0, 165.0, 160.0, 164.0, 159.0, 157.0, 158.0], "value": 160.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 59.0, 60.0, 61.0, 60.0, 61.0, 59.0, 62.0, 58.0], "value": 60.4, "unit": "score"}]}]} 05:52:09 INFO - Return code: 0 05:52:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:52:09 INFO - # TBPL SUCCESS # 05:52:09 INFO - Running post-action listener: _resource_record_post_action 05:52:09 INFO - [mozharness: 2017-06-01 12:52:09.907139Z] Finished run-tests step (success) 05:52:09 INFO - Running post-run listener: _resource_record_post_run 05:52:09 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 7593984; Write bytes: 335949824; Read time: 1468; Write time: 315000 05:52:09 INFO - TinderboxPrint: CPU usage
13.1% 05:52:09 INFO - TinderboxPrint: I/O read bytes / time
7,593,984 / 1,468 05:52:09 INFO - TinderboxPrint: I/O write bytes / time
335,949,824 / 315,000 05:52:09 INFO - TinderboxPrint: CPU idle
8,260.4 (86.9%) 05:52:09 INFO - TinderboxPrint: CPU user
1,198.3 (12.6%) 05:52:09 INFO - TinderboxPrint: Swap in / out
0 / 0 05:52:09 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 39923712; Read time: 0; Write time: 26300 05:52:10 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 5464064; Write bytes: 267657216; Read time: 1032; Write time: 277260 05:52:10 INFO - Running post-run listener: _upload_blobber_files 05:52:10 INFO - Blob upload gear active. 05:52:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:52:10 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 05:52:10 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'] 05:52:10 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 05:52:10 INFO - (blobuploader) - INFO - Open directory for files ... 05:52:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:52:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:52:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:52:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:52:12 INFO - (blobuploader) - INFO - Done attempting. 05:52:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:52:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:52:13 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:52:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:52:13 INFO - (blobuploader) - INFO - Done attempting. 05:52:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:52:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:52:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:52:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:52:16 INFO - (blobuploader) - INFO - Done attempting. 05:52:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:52:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:52:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:52:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:52:17 INFO - (blobuploader) - INFO - Done attempting. 05:52:17 INFO - (blobuploader) - INFO - Iteration through files over. 05:52:17 INFO - Return code: 0 05:52:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:52:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:52:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0f75b870346e21a7be488b98d318ba21a553e516331619720d1189c7274e0dc188323fc453be5bf2ecf5006fcde07087c0e379337a5c21683e63bcff0a062199", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/a26bd1311a0222eba2bb54528d87678161a6745ceab772236da7ab693a34e0777becc0dc96b9645b19a3f8c270298678526ca5ef17e6c8d40d233a26663b244e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/26adbcf9760bf10b760838023af49fdca8edb2aedfd11567b0b7378e11431cf1dabf38bbab893156ee013461d2509cec938e4aa5b312a1e5b2e0d7fdeecfe425", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d499c1b5106322d014955935892b3f203c3835c056f1d2b69b6ef8aad9cc79d13d3cfbb43d0760914c4a3e712bf3d4b32c45baef946744e2a3e265f2f041f520"} 05:52:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:52:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:52:17 INFO - Contents: 05:52:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0f75b870346e21a7be488b98d318ba21a553e516331619720d1189c7274e0dc188323fc453be5bf2ecf5006fcde07087c0e379337a5c21683e63bcff0a062199", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/a26bd1311a0222eba2bb54528d87678161a6745ceab772236da7ab693a34e0777becc0dc96b9645b19a3f8c270298678526ca5ef17e6c8d40d233a26663b244e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/26adbcf9760bf10b760838023af49fdca8edb2aedfd11567b0b7378e11431cf1dabf38bbab893156ee013461d2509cec938e4aa5b312a1e5b2e0d7fdeecfe425", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d499c1b5106322d014955935892b3f203c3835c056f1d2b69b6ef8aad9cc79d13d3cfbb43d0760914c4a3e712bf3d4b32c45baef946744e2a3e265f2f041f520"} 05:52:17 INFO - Running post-run listener: copy_logs_to_upload_dir 05:52:17 INFO - Copying logs to upload dir... 05:52:17 INFO - mkdir: /builds/slave/test/build/upload/logs 05:52:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.776510 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-06-01 05:52:16.900069) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-01 05:52:16.904723) ========= 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=1258088b6da462a47ba2cd90000001a2-1496307261.131646-1847580301 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/0f75b870346e21a7be488b98d318ba21a553e516331619720d1189c7274e0dc188323fc453be5bf2ecf5006fcde07087c0e379337a5c21683e63bcff0a062199", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/a26bd1311a0222eba2bb54528d87678161a6745ceab772236da7ab693a34e0777becc0dc96b9645b19a3f8c270298678526ca5ef17e6c8d40d233a26663b244e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/26adbcf9760bf10b760838023af49fdca8edb2aedfd11567b0b7378e11431cf1dabf38bbab893156ee013461d2509cec938e4aa5b312a1e5b2e0d7fdeecfe425", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d499c1b5106322d014955935892b3f203c3835c056f1d2b69b6ef8aad9cc79d13d3cfbb43d0760914c4a3e712bf3d4b32c45baef946744e2a3e265f2f041f520"} build_url:https://queue.taskcluster.net/v1/task/JMorGhSRTqevz7bidjkOhw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011218 build_url: 'https://queue.taskcluster.net/v1/task/JMorGhSRTqevz7bidjkOhw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0f75b870346e21a7be488b98d318ba21a553e516331619720d1189c7274e0dc188323fc453be5bf2ecf5006fcde07087c0e379337a5c21683e63bcff0a062199", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/a26bd1311a0222eba2bb54528d87678161a6745ceab772236da7ab693a34e0777becc0dc96b9645b19a3f8c270298678526ca5ef17e6c8d40d233a26663b244e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/26adbcf9760bf10b760838023af49fdca8edb2aedfd11567b0b7378e11431cf1dabf38bbab893156ee013461d2509cec938e4aa5b312a1e5b2e0d7fdeecfe425", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d499c1b5106322d014955935892b3f203c3835c056f1d2b69b6ef8aad9cc79d13d3cfbb43d0760914c4a3e712bf3d4b32c45baef946744e2a3e265f2f041f520"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-01 05:52:16.930266) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 05:52:16.930613) ========= 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=1258088b6da462a47ba2cd90000001a2-1496307261.131646-1847580301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 05:52:17.011136) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-01 05:52:17.014518) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-01 05:52:17.014830) ========= ========= Total master_lag: 0.20 =========