builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-005 starttime: 1494549732.26 results: success (0) revision: c1719e0d676b56ccd940c6f8a9b1bb819d441b20 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-11 17:42:12.264545) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-11 17:42:12.264947) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-11 17:42:12.265213) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-11 17:42:12.279478) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 17:42:12.279730) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1494549732.339517-1433854511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-11 17:42:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 19.5M=0.001s 2017-05-11 17:42:13 (19.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.090264 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 17:42:12.383410) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 17:42:12.383708) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1494549732.339517-1433854511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020571 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 17:42:12.435768) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-11 17:42:12.436074) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c1719e0d676b56ccd940c6f8a9b1bb819d441b20 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev c1719e0d676b56ccd940c6f8a9b1bb819d441b20 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1494549732.339517-1433854511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-11 17:42:13,321 truncating revision to first 12 chars 2017-05-11 17:42:13,321 Setting DEBUG logging. 2017-05-11 17:42:13,321 attempt 1/10 2017-05-11 17:42:13,321 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c1719e0d676b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-11 17:42:14,403 unpacking tar archive at: mozilla-central-c1719e0d676b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.443815 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-11 17:42:13.896065) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-11 17:42:13.899463) ========= script_repo_revision: c1719e0d676b56ccd940c6f8a9b1bb819d441b20 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-11 17:42:13.899928) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-11 17:42:13.900188) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-11 17:42:13.910463) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-05-11 17:42:13.910841) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1494549732.339517-1433854511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:42:14 INFO - MultiFileLogger online at 20170511 17:42:14 in /builds/slave/test 17:42:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 17:42:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:42:14 INFO - {'append_to_log': False, 17:42:14 INFO - 'base_work_dir': '/builds/slave/test', 17:42:14 INFO - 'blob_upload_branch': 'Firefox', 17:42:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:42:14 INFO - 'branch': 'Firefox', 17:42:14 INFO - 'buildbot_json_path': 'buildprops.json', 17:42:14 INFO - 'config_files': ('talos/linux_config.py',), 17:42:14 INFO - 'default_actions': ('clobber', 17:42:14 INFO - 'read-buildbot-config', 17:42:14 INFO - 'download-and-extract', 17:42:14 INFO - 'populate-webroot', 17:42:14 INFO - 'create-virtualenv', 17:42:14 INFO - 'install', 17:42:14 INFO - 'run-tests'), 17:42:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:42:14 INFO - 'download_minidump_stackwalk': True, 17:42:14 INFO - 'download_symbols': 'ondemand', 17:42:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:42:14 INFO - 'tooltool.py': '/tools/tooltool.py', 17:42:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:42:14 INFO - '/tools/misc-python/virtualenv.py')}, 17:42:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:42:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:42:14 INFO - 'gecko_profile': False, 17:42:14 INFO - 'gecko_profile_interval': 0, 17:42:14 INFO - 'installer_path': 'installer.exe', 17:42:14 INFO - 'log_level': 'info', 17:42:14 INFO - 'log_name': 'talos', 17:42:14 INFO - 'log_to_console': True, 17:42:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:42:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:42:14 INFO - 'opt_config_files': (), 17:42:14 INFO - 'pip_index': False, 17:42:14 INFO - 'suite': 'dromaeojs', 17:42:14 INFO - 'system_bits': '32', 17:42:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:42:14 INFO - 'title': 'talos-linux64-ix-005', 17:42:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:42:14 INFO - 'use_talos_json': True, 17:42:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:42:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:42:14 INFO - 'work_dir': 'build'} 17:42:14 INFO - [mozharness: 2017-05-12 00:42:14.893245Z] Running clobber step. 17:42:14 INFO - Running pre-action listener: _resource_record_pre_action 17:42:14 INFO - Running main action method: clobber 17:42:14 INFO - rmtree: /builds/slave/test/build 17:42:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:42:16 INFO - Running post-action listener: _resource_record_post_action 17:42:16 INFO - [mozharness: 2017-05-12 00:42:16.368617Z] Finished clobber step (success) 17:42:16 INFO - [mozharness: 2017-05-12 00:42:16.368717Z] Running read-buildbot-config step. 17:42:16 INFO - Running pre-action listener: _resource_record_pre_action 17:42:16 INFO - Running main action method: read_buildbot_config 17:42:16 INFO - Using buildbot properties: 17:42:16 INFO - { 17:42:16 INFO - "project": "", 17:42:16 INFO - "product": "firefox", 17:42:16 INFO - "who": "kwierso@gmail.com", 17:42:16 INFO - "installer_path": "public/build/target.tar.bz2", 17:42:16 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 17:42:16 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 17:42:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 17:42:16 INFO - "stage_platform": "linux64-pgo", 17:42:16 INFO - "basedir": "/builds/slave/test", 17:42:16 INFO - "buildnumber": 176, 17:42:16 INFO - "platform": "ubuntu64_hw", 17:42:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:42:16 INFO - "slavebuilddir": "test", 17:42:16 INFO - "taskId": "BEEoy9L4QVyjmsapp_WDmg", 17:42:16 INFO - "branch": "mozilla-central", 17:42:16 INFO - "script_repo_revision": "production", 17:42:16 INFO - "revision": "c1719e0d676b56ccd940c6f8a9b1bb819d441b20", 17:42:16 INFO - "slavename": "talos-linux64-ix-005", 17:42:16 INFO - "repo_path": "mozilla-central" 17:42:16 INFO - } 17:42:16 INFO - Finding installer, test and symbols from parent task. 17:42:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BEEoy9L4QVyjmsapp_WDmg'}, attempt #1 17:42:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BEEoy9L4QVyjmsapp_WDmg'}, attempt #1 17:42:17 INFO - Task dependencies: EgneG4LHTiSiS4iuGGWyDQ 17:42:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EgneG4LHTiSiS4iuGGWyDQ'}, attempt #1 17:42:17 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/EgneG4LHTiSiS4iuGGWyDQ/artifacts/public/build/target.tar.bz2 17:42:17 INFO - Set test_url: https://queue.taskcluster.net/v1/task/EgneG4LHTiSiS4iuGGWyDQ/artifacts/public/build/test_packages.json 17:42:17 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/EgneG4LHTiSiS4iuGGWyDQ/artifacts/public/build/target.crashreporter-symbols.zip 17:42:17 INFO - Running post-action listener: _resource_record_post_action 17:42:17 INFO - [mozharness: 2017-05-12 00:42:17.714352Z] Finished read-buildbot-config step (success) 17:42:17 INFO - [mozharness: 2017-05-12 00:42:17.714656Z] Running download-and-extract step. 17:42:17 INFO - Running pre-action listener: _resource_record_pre_action 17:42:17 INFO - Running main action method: download_and_extract 17:42:17 INFO - mkdir: /builds/slave/test/build/tests 17:42: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')]} 17:42:17 INFO - trying https://queue.taskcluster.net/v1/task/EgneG4LHTiSiS4iuGGWyDQ/artifacts/public/build/target.test_packages.json 17:42:17 INFO - Downloading https://queue.taskcluster.net/v1/task/EgneG4LHTiSiS4iuGGWyDQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:42:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EgneG4LHTiSiS4iuGGWyDQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:42:18 INFO - Downloaded 986 bytes. 17:42:18 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:42:18 INFO - Using the following test package requirements: 17:42:18 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:42:18 INFO - u'common': [u'target.common.tests.zip'], 17:42:18 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:42:18 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:42:18 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:42:18 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:42:18 INFO - u'mozbase': [u'target.common.tests.zip'], 17:42:18 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:42:18 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:42:18 INFO - u'web-platform': [u'target.common.tests.zip', 17:42:18 INFO - u'target.web-platform.tests.zip'], 17:42:18 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:42:18 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:42:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EgneG4LHTiSiS4iuGGWyDQ/artifacts/public/build/target.common.tests.zip 17:42:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EgneG4LHTiSiS4iuGGWyDQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:42:18 INFO - Fetch https://queue.taskcluster.net/v1/task/EgneG4LHTiSiS4iuGGWyDQ/artifacts/public/build/target.common.tests.zip into memory 17:42:19 INFO - Content-Length response header: 60737096 17:42:19 INFO - Bytes received: 60737096 17:42:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:42:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EgneG4LHTiSiS4iuGGWyDQ/artifacts/public/build/target.common.tests.zip 17:42:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EgneG4LHTiSiS4iuGGWyDQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:42:29 INFO - Fetch https://queue.taskcluster.net/v1/task/EgneG4LHTiSiS4iuGGWyDQ/artifacts/public/build/target.common.tests.zip into memory 17:42:30 INFO - Content-Length response header: 60737096 17:42:30 INFO - Bytes received: 60737096 17:42:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EgneG4LHTiSiS4iuGGWyDQ/artifacts/public/build/target.talos.tests.zip 17:42:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EgneG4LHTiSiS4iuGGWyDQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:42:41 INFO - Fetch https://queue.taskcluster.net/v1/task/EgneG4LHTiSiS4iuGGWyDQ/artifacts/public/build/target.talos.tests.zip into memory 17:42:42 INFO - Content-Length response header: 14409411 17:42:42 INFO - Bytes received: 14409411 17:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:42 INFO - trying https://queue.taskcluster.net/v1/task/EgneG4LHTiSiS4iuGGWyDQ/artifacts/public/build/target.tar.bz2 17:42:42 INFO - Downloading https://queue.taskcluster.net/v1/task/EgneG4LHTiSiS4iuGGWyDQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:42:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EgneG4LHTiSiS4iuGGWyDQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:42:43 INFO - Downloaded 68531167 bytes. 17:42:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EgneG4LHTiSiS4iuGGWyDQ/artifacts/public/build/target.tar.bz2 17:42:43 INFO - mkdir: /builds/slave/test/properties 17:42:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:42:43 INFO - Writing to file /builds/slave/test/properties/build_url 17:42:43 INFO - Contents: 17:42:43 INFO - build_url:https://queue.taskcluster.net/v1/task/EgneG4LHTiSiS4iuGGWyDQ/artifacts/public/build/target.tar.bz2 17:42:43 INFO - Running post-action listener: _resource_record_post_action 17:42:43 INFO - Running post-action listener: set_extra_try_arguments 17:42:43 INFO - [mozharness: 2017-05-12 00:42:43.638766Z] Finished download-and-extract step (success) 17:42:43 INFO - [mozharness: 2017-05-12 00:42:43.638862Z] Running populate-webroot step. 17:42:43 INFO - Running pre-action listener: _resource_record_pre_action 17:42:43 INFO - Running main action method: populate_webroot 17:42:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:42:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:42:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:42:43 INFO - '--tppagecycles', 17:42:43 INFO - '7'], 17:42:43 INFO - 'tests': ['tsvgm']}}, 17:42:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:42:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:42:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:42:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:42:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:42:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:42:43 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:42:43 INFO - 'talos_options': ['--disable-e10s'], 17:42:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:42:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:42:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:42:43 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:42:43 INFO - 'talos_options': ['--disable-e10s'], 17:42:43 INFO - 'tests': ['damp', 'tps']}, 17:42:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:42:43 INFO - 'tests': ['damp', 'tps']}, 17:42:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:42:43 INFO - 'tests': ['dromaeo_dom']}, 17:42:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:42:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:42:43 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:42:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:42:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:42:43 INFO - 'tests': ['a11yr', 17:42:43 INFO - 'ts_paint', 17:42:43 INFO - 'tpaint', 17:42:43 INFO - 'sessionrestore', 17:42:43 INFO - 'sessionrestore_no_auto_restore', 17:42:43 INFO - 'tabpaint']}, 17:42:43 INFO - 'other-e10s': {'tests': ['a11yr', 17:42:43 INFO - 'ts_paint', 17:42:43 INFO - 'tpaint', 17:42:43 INFO - 'sessionrestore', 17:42:43 INFO - 'sessionrestore_no_auto_restore', 17:42:43 INFO - 'tabpaint']}, 17:42:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:42:43 INFO - 'ts_paint', 17:42:43 INFO - 'tpaint', 17:42:43 INFO - 'sessionrestore', 17:42:43 INFO - 'sessionrestore_no_auto_restore', 17:42:43 INFO - 'tabpaint']}, 17:42:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:42:43 INFO - 'ts_paint', 17:42:43 INFO - 'tpaint', 17:42:43 INFO - 'sessionrestore', 17:42:43 INFO - 'sessionrestore_no_auto_restore', 17:42:43 INFO - 'tabpaint']}, 17:42:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:42:43 INFO - 'tests': ['a11yr', 17:42:43 INFO - 'ts_paint', 17:42:43 INFO - 'tpaint', 17:42:43 INFO - 'sessionrestore', 17:42:43 INFO - 'sessionrestore_no_auto_restore', 17:42:43 INFO - 'tabpaint']}, 17:42:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:42:43 INFO - 'tests': ['a11yr', 17:42:43 INFO - 'ts_paint', 17:42:43 INFO - 'tpaint', 17:42:43 INFO - 'sessionrestore', 17:42:43 INFO - 'sessionrestore_no_auto_restore', 17:42:43 INFO - 'tabpaint']}, 17:42:43 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 17:42:43 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 17:42:43 INFO - 'bloom_basic_ref']}, 17:42:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:42:43 INFO - 'tests': ['tsvgx', 17:42:43 INFO - 'tsvgr_opacity', 17:42:43 INFO - 'tart', 17:42:43 INFO - 'tscrollx', 17:42:43 INFO - 'cart', 17:42:43 INFO - 'tsvg_static']}, 17:42:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:42:43 INFO - 'tsvgr_opacity', 17:42:43 INFO - 'tart', 17:42:43 INFO - 'tscrollx', 17:42:43 INFO - 'cart', 17:42:43 INFO - 'tsvg_static']}, 17:42:43 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:42:43 INFO - 'talos_options': ['--disable-e10s'], 17:42:43 INFO - 'tests': ['tp5o']}, 17:42:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:42:43 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:42:43 INFO - 'talos_options': ['--disable-e10s', 17:42:43 INFO - '--xperf_path', 17:42:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:42:43 INFO - 'tests': ['tp5n']}, 17:42:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:42:43 INFO - 'talos_options': ['--xperf_path', 17:42:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:42:43 INFO - 'tests': ['tp5n']}}, 17:42:43 INFO - 'talos.zip': {'path': '', 17:42:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:42:43 INFO - Running post-action listener: _resource_record_post_action 17:42:43 INFO - [mozharness: 2017-05-12 00:42:43.652450Z] Finished populate-webroot step (success) 17:42:43 INFO - [mozharness: 2017-05-12 00:42:43.652538Z] Running create-virtualenv step. 17:42:43 INFO - Running pre-action listener: _resource_record_pre_action 17:42:43 INFO - Running main action method: create_virtualenv 17:42:43 INFO - Creating virtualenv /builds/slave/test/build/venv 17:42:43 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 17:42:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:42:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:42:43 INFO - Using real prefix '/usr' 17:42:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:42:44 INFO - Installing distribute.............................................................................................................................................................................................done. 17:42:46 INFO - Installing pip.................done. 17:42:46 INFO - Return code: 0 17:42:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:42:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:42:46 INFO - Reading from file tmpfile_stdout 17:42:46 INFO - Output received: 17:42:46 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) 17:42:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:42:46 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')]} 17:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:46 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')]} 17:42:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:46 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 0x1d531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c2a30>, '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 0x20c37f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c3ca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1494549732.339517-1433854511', '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 17:42:46 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 17:42:46 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 17:42:46 INFO - Using env: {'DISPLAY': ':0', 17:42:46 INFO - 'HOME': '/home/cltbld', 17:42:46 INFO - 'LANG': 'en_US.UTF-8', 17:42:46 INFO - 'LANGUAGE': 'en_US:en', 17:42:46 INFO - 'LOGNAME': 'cltbld', 17:42:46 INFO - 'MAIL': '/var/mail/cltbld', 17:42:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:46 INFO - 'MOZ_NO_REMOTE': '1', 17:42:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:46 INFO - 'NO_EM_RESTART': '1', 17:42:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:46 INFO - 'PWD': '/builds/slave/test', 17:42:46 INFO - 'SHELL': '/bin/bash', 17:42:46 INFO - 'SHLVL': '1', 17:42:46 INFO - 'TERM': 'linux', 17:42:46 INFO - 'TMOUT': '86400', 17:42:46 INFO - 'USER': 'cltbld', 17:42:46 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1494549732.339517-1433854511', 17:42:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:46 INFO - '_': '/tools/buildbot/bin/python'} 17:42:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:46 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 17:42:46 INFO - Cleaning up... 17:42:46 INFO - Return code: 0 17:42:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:42:46 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')]} 17:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:46 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')]} 17:42:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:46 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 0x1d531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c2a30>, '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 0x20c37f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c3ca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1494549732.339517-1433854511', '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 17:42:46 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 17:42:46 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 17:42:46 INFO - Using env: {'DISPLAY': ':0', 17:42:46 INFO - 'HOME': '/home/cltbld', 17:42:46 INFO - 'LANG': 'en_US.UTF-8', 17:42:46 INFO - 'LANGUAGE': 'en_US:en', 17:42:46 INFO - 'LOGNAME': 'cltbld', 17:42:46 INFO - 'MAIL': '/var/mail/cltbld', 17:42:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:46 INFO - 'MOZ_NO_REMOTE': '1', 17:42:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:46 INFO - 'NO_EM_RESTART': '1', 17:42:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:46 INFO - 'PWD': '/builds/slave/test', 17:42:46 INFO - 'SHELL': '/bin/bash', 17:42:46 INFO - 'SHLVL': '1', 17:42:46 INFO - 'TERM': 'linux', 17:42:46 INFO - 'TMOUT': '86400', 17:42:46 INFO - 'USER': 'cltbld', 17:42:46 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1494549732.339517-1433854511', 17:42:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:46 INFO - '_': '/tools/buildbot/bin/python'} 17:42:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:46 INFO - Downloading/unpacking psutil>=3.1.1 17:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:42:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:42:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:42:48 INFO - Installing collected packages: psutil 17:42:48 INFO - Running setup.py install for psutil 17:42:48 INFO - building 'psutil._psutil_linux' extension 17:42:48 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 17:42:48 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 17:42:48 INFO - building 'psutil._psutil_posix' extension 17:42:48 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 17:42:48 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 17:42:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:42:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:42:48 INFO - Successfully installed psutil 17:42:48 INFO - Cleaning up... 17:42:48 INFO - Return code: 0 17:42:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:42:48 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')]} 17:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:48 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')]} 17:42:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:48 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 0x1d531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c2a30>, '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 0x20c37f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c3ca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1494549732.339517-1433854511', '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 17:42:48 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 17:42:48 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 17:42:48 INFO - Using env: {'DISPLAY': ':0', 17:42:48 INFO - 'HOME': '/home/cltbld', 17:42:48 INFO - 'LANG': 'en_US.UTF-8', 17:42:48 INFO - 'LANGUAGE': 'en_US:en', 17:42:48 INFO - 'LOGNAME': 'cltbld', 17:42:48 INFO - 'MAIL': '/var/mail/cltbld', 17:42:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:48 INFO - 'MOZ_NO_REMOTE': '1', 17:42:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:48 INFO - 'NO_EM_RESTART': '1', 17:42:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:48 INFO - 'PWD': '/builds/slave/test', 17:42:48 INFO - 'SHELL': '/bin/bash', 17:42:48 INFO - 'SHLVL': '1', 17:42:48 INFO - 'TERM': 'linux', 17:42:48 INFO - 'TMOUT': '86400', 17:42:48 INFO - 'USER': 'cltbld', 17:42:48 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1494549732.339517-1433854511', 17:42:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:48 INFO - '_': '/tools/buildbot/bin/python'} 17:42:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:42:49 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 17:42:49 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 17:42:49 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 17:42:49 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 17:42:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:42:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:42:50 INFO - Installing collected packages: mozsystemmonitor 17:42:50 INFO - Running setup.py install for mozsystemmonitor 17:42:50 INFO - Successfully installed mozsystemmonitor 17:42:50 INFO - Cleaning up... 17:42:50 INFO - Return code: 0 17:42:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:50 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 0x1d531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c2a30>, '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 0x20c37f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c3ca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1494549732.339517-1433854511', '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 17:42:50 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 17:42:50 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 17:42:50 INFO - Using env: {'DISPLAY': ':0', 17:42:50 INFO - 'HOME': '/home/cltbld', 17:42:50 INFO - 'LANG': 'en_US.UTF-8', 17:42:50 INFO - 'LANGUAGE': 'en_US:en', 17:42:50 INFO - 'LOGNAME': 'cltbld', 17:42:50 INFO - 'MAIL': '/var/mail/cltbld', 17:42:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:50 INFO - 'MOZ_NO_REMOTE': '1', 17:42:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:50 INFO - 'NO_EM_RESTART': '1', 17:42:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:50 INFO - 'PWD': '/builds/slave/test', 17:42:50 INFO - 'SHELL': '/bin/bash', 17:42:50 INFO - 'SHLVL': '1', 17:42:50 INFO - 'TERM': 'linux', 17:42:50 INFO - 'TMOUT': '86400', 17:42:50 INFO - 'USER': 'cltbld', 17:42:50 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1494549732.339517-1433854511', 17:42:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:50 INFO - '_': '/tools/buildbot/bin/python'} 17:42:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:50 INFO - Downloading/unpacking jsonschema==2.5.1 17:42:50 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 17:42:50 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 17:42:50 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 17:42:50 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 17:42:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:42:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:42:51 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 17:42:51 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 17:42:51 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 17:42:51 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 17:42:51 INFO - Downloading functools32-3.2.3-2.tar.gz 17:42:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:42:51 INFO - warning: no files found matching '*.txt' 17:42:51 INFO - no previously-included directories found matching 'build' 17:42:51 INFO - no previously-included directories found matching 'dist' 17:42:51 INFO - no previously-included directories found matching '.git*' 17:42:51 INFO - Installing collected packages: jsonschema, functools32 17:42:51 INFO - Running setup.py install for functools32 17:42:51 INFO - warning: no files found matching '*.txt' 17:42:51 INFO - no previously-included directories found matching 'build' 17:42:51 INFO - no previously-included directories found matching 'dist' 17:42:51 INFO - no previously-included directories found matching '.git*' 17:42:51 INFO - Successfully installed jsonschema functools32 17:42:51 INFO - Cleaning up... 17:42:51 INFO - Return code: 0 17:42:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:42:51 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')]} 17:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:51 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')]} 17:42:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:51 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 0x1d531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c2a30>, '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 0x20c37f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c3ca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1494549732.339517-1433854511', '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 17:42:51 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 17:42:51 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 17:42:51 INFO - Using env: {'DISPLAY': ':0', 17:42:51 INFO - 'HOME': '/home/cltbld', 17:42:51 INFO - 'LANG': 'en_US.UTF-8', 17:42:51 INFO - 'LANGUAGE': 'en_US:en', 17:42:51 INFO - 'LOGNAME': 'cltbld', 17:42:51 INFO - 'MAIL': '/var/mail/cltbld', 17:42:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:51 INFO - 'MOZ_NO_REMOTE': '1', 17:42:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:51 INFO - 'NO_EM_RESTART': '1', 17:42:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:51 INFO - 'PWD': '/builds/slave/test', 17:42:51 INFO - 'SHELL': '/bin/bash', 17:42:51 INFO - 'SHLVL': '1', 17:42:51 INFO - 'TERM': 'linux', 17:42:51 INFO - 'TMOUT': '86400', 17:42:51 INFO - 'USER': 'cltbld', 17:42:51 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1494549732.339517-1433854511', 17:42:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:51 INFO - '_': '/tools/buildbot/bin/python'} 17:42:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:42:52 INFO - Cleaning up... 17:42:52 INFO - Return code: 0 17:42:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:52 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 0x1d531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c2a30>, '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 0x20c37f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c3ca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1494549732.339517-1433854511', '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 17:42:52 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 17:42:52 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 17:42:52 INFO - Using env: {'DISPLAY': ':0', 17:42:52 INFO - 'HOME': '/home/cltbld', 17:42:52 INFO - 'LANG': 'en_US.UTF-8', 17:42:52 INFO - 'LANGUAGE': 'en_US:en', 17:42:52 INFO - 'LOGNAME': 'cltbld', 17:42:52 INFO - 'MAIL': '/var/mail/cltbld', 17:42:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:52 INFO - 'MOZ_NO_REMOTE': '1', 17:42:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:52 INFO - 'NO_EM_RESTART': '1', 17:42:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:52 INFO - 'PWD': '/builds/slave/test', 17:42:52 INFO - 'SHELL': '/bin/bash', 17:42:52 INFO - 'SHLVL': '1', 17:42:52 INFO - 'TERM': 'linux', 17:42:52 INFO - 'TMOUT': '86400', 17:42:52 INFO - 'USER': 'cltbld', 17:42:52 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1494549732.339517-1433854511', 17:42:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:52 INFO - '_': '/tools/buildbot/bin/python'} 17:42:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:52 INFO - Downloading/unpacking blobuploader==1.2.4 17:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:53 INFO - Downloading blobuploader-1.2.4.tar.gz 17:42:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:42:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:42:53 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 17:42:53 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 17:42:53 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 17:42:53 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 17:42:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:42:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:42:53 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 17:42:53 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 17:42:53 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 17:42:53 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 17:42:53 INFO - Downloading docopt-0.6.1.tar.gz 17:42:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:42:54 INFO - Installing collected packages: blobuploader, requests, docopt 17:42:54 INFO - Running setup.py install for blobuploader 17:42:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:42:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:42:54 INFO - Running setup.py install for requests 17:42:54 INFO - Running setup.py install for docopt 17:42:54 INFO - Successfully installed blobuploader requests docopt 17:42:54 INFO - Cleaning up... 17:42:54 INFO - Return code: 0 17:42:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:42:54 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')]} 17:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:54 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')]} 17:42:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:54 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 0x1d531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c2a30>, '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 0x20c37f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c3ca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1494549732.339517-1433854511', '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 17:42:54 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 17:42:54 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 17:42:54 INFO - Using env: {'DISPLAY': ':0', 17:42:54 INFO - 'HOME': '/home/cltbld', 17:42:54 INFO - 'LANG': 'en_US.UTF-8', 17:42:54 INFO - 'LANGUAGE': 'en_US:en', 17:42:54 INFO - 'LOGNAME': 'cltbld', 17:42:54 INFO - 'MAIL': '/var/mail/cltbld', 17:42:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:54 INFO - 'MOZ_NO_REMOTE': '1', 17:42:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:54 INFO - 'NO_EM_RESTART': '1', 17:42:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:54 INFO - 'PWD': '/builds/slave/test', 17:42:54 INFO - 'SHELL': '/bin/bash', 17:42:54 INFO - 'SHLVL': '1', 17:42:54 INFO - 'TERM': 'linux', 17:42:54 INFO - 'TMOUT': '86400', 17:42:54 INFO - 'USER': 'cltbld', 17:42:54 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1494549732.339517-1433854511', 17:42:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:54 INFO - '_': '/tools/buildbot/bin/python'} 17:42:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:42:54 INFO - Running setup.py (path:/tmp/pip-G8fR8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:42:54 INFO - Running setup.py (path:/tmp/pip-OkQYHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:42:55 INFO - Running setup.py (path:/tmp/pip-xNhjwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:42:55 INFO - Running setup.py (path:/tmp/pip-WqDK7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:42:55 INFO - Running setup.py (path:/tmp/pip-JuAuvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:42:55 INFO - Running setup.py (path:/tmp/pip-EPPSdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:42:55 INFO - Running setup.py (path:/tmp/pip-1iNyHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:42:55 INFO - Running setup.py (path:/tmp/pip-iHQj49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:42:55 INFO - Running setup.py (path:/tmp/pip-vjKhLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:42:55 INFO - Running setup.py (path:/tmp/pip-wyWBKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:42:55 INFO - Running setup.py (path:/tmp/pip-1WdCpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:42:55 INFO - Running setup.py (path:/tmp/pip-JnMW8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:42:55 INFO - Running setup.py (path:/tmp/pip-996BW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:42:55 INFO - Running setup.py (path:/tmp/pip-wvUahK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:42:55 INFO - Running setup.py (path:/tmp/pip-EfRGag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:42:55 INFO - Running setup.py (path:/tmp/pip-HAXXqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:42:56 INFO - Running setup.py (path:/tmp/pip-BCei_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:42:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:42:56 INFO - Running setup.py install for manifestparser 17:42:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:42:56 INFO - Running setup.py install for mozcrash 17:42:56 INFO - Running setup.py install for mozdebug 17:42:56 INFO - Running setup.py install for mozdevice 17:42:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:42:56 INFO - Running setup.py install for mozfile 17:42:56 INFO - Running setup.py install for mozhttpd 17:42:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:42:56 INFO - Running setup.py install for mozinfo 17:42:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:42:56 INFO - Running setup.py install for mozInstall 17:42:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:42:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:42:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:42:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:42:56 INFO - Running setup.py install for mozleak 17:42:56 INFO - Running setup.py install for mozlog 17:42:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:42:57 INFO - Running setup.py install for moznetwork 17:42:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:42:57 INFO - Running setup.py install for mozprocess 17:42:57 INFO - Running setup.py install for mozprofile 17:42:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:42:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:42:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:42:57 INFO - Running setup.py install for mozrunner 17:42:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:42:57 INFO - Running setup.py install for mozscreenshot 17:42:57 INFO - Running setup.py install for moztest 17:42:57 INFO - Running setup.py install for mozversion 17:42:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:42:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:42:57 INFO - Cleaning up... 17:42:57 INFO - Return code: 0 17:42:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:42: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')]} 17:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42: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')]} 17:42:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:57 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 0x1d531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c2a30>, '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 0x20c37f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c3ca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1494549732.339517-1433854511', '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 17:42:57 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 17:42:57 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 17:42:57 INFO - Using env: {'DISPLAY': ':0', 17:42:57 INFO - 'HOME': '/home/cltbld', 17:42:57 INFO - 'LANG': 'en_US.UTF-8', 17:42:57 INFO - 'LANGUAGE': 'en_US:en', 17:42:57 INFO - 'LOGNAME': 'cltbld', 17:42:57 INFO - 'MAIL': '/var/mail/cltbld', 17:42:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:57 INFO - 'MOZ_NO_REMOTE': '1', 17:42:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:57 INFO - 'NO_EM_RESTART': '1', 17:42:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:57 INFO - 'PWD': '/builds/slave/test', 17:42:57 INFO - 'SHELL': '/bin/bash', 17:42:57 INFO - 'SHLVL': '1', 17:42:57 INFO - 'TERM': 'linux', 17:42:57 INFO - 'TMOUT': '86400', 17:42:57 INFO - 'USER': 'cltbld', 17:42:57 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1494549732.339517-1433854511', 17:42:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:57 INFO - '_': '/tools/buildbot/bin/python'} 17:42:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:42:58 INFO - Running setup.py (path:/tmp/pip-IwY3sB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:42:58 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)) 17:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:42:58 INFO - Running setup.py (path:/tmp/pip-HsKfUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:42:58 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)) 17:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:42:58 INFO - Running setup.py (path:/tmp/pip-MNNb1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:42:58 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)) 17:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:42:58 INFO - Running setup.py (path:/tmp/pip-Z24lzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:42:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 17:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:42:58 INFO - Running setup.py (path:/tmp/pip-CoNeKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:42:58 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)) 17:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:42:58 INFO - Running setup.py (path:/tmp/pip-acnbAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:42:58 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)) 17:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:42:58 INFO - Running setup.py (path:/tmp/pip-26gBud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:42:58 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)) 17:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:42:58 INFO - Running setup.py (path:/tmp/pip-9LJhgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:42:58 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)) 17:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:42:58 INFO - Running setup.py (path:/tmp/pip-MgIEDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:42:58 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)) 17:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:42:58 INFO - Running setup.py (path:/tmp/pip-PyoNka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:42:58 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)) 17:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:42:58 INFO - Running setup.py (path:/tmp/pip-7BR1gu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:42:58 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)) 17:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:42:58 INFO - Running setup.py (path:/tmp/pip-nWf7bN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:42:58 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)) 17:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:42:58 INFO - Running setup.py (path:/tmp/pip-JBjXhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:42:59 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)) 17:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:42:59 INFO - Running setup.py (path:/tmp/pip-ZNtAw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:42:59 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)) 17:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:42:59 INFO - Running setup.py (path:/tmp/pip-qZqsDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:42:59 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)) 17:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:42:59 INFO - Running setup.py (path:/tmp/pip-f7sOfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:42:59 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)) 17:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:42:59 INFO - Running setup.py (path:/tmp/pip-hQ3H58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:42:59 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)) 17:42:59 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)) 17:42:59 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)) 17:42:59 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)) 17:42:59 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:42:59 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:42:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:00 INFO - Downloading blessings-1.6.tar.gz 17:43:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:43:00 INFO - Installing collected packages: blessings 17:43:00 INFO - Running setup.py install for blessings 17:43:00 INFO - Successfully installed blessings 17:43:00 INFO - Cleaning up... 17:43:00 INFO - Return code: 0 17:43:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:43:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:43:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:43:00 INFO - Reading from file tmpfile_stdout 17:43:00 INFO - Current package versions: 17:43:00 INFO - argparse == 1.2.1 17:43:00 INFO - blessings == 1.6 17:43:00 INFO - blobuploader == 1.2.4 17:43:00 INFO - docopt == 0.6.1 17:43:00 INFO - functools32 == 3.2.3-2 17:43:00 INFO - jsonschema == 2.5.1 17:43:00 INFO - manifestparser == 1.1 17:43:00 INFO - mozInstall == 1.12 17:43:00 INFO - mozcrash == 1.0 17:43:00 INFO - mozdebug == 0.1 17:43:00 INFO - mozdevice == 0.50 17:43:00 INFO - mozfile == 1.2 17:43:00 INFO - mozhttpd == 0.7 17:43:00 INFO - mozinfo == 0.9 17:43:00 INFO - mozleak == 0.1 17:43:00 INFO - mozlog == 3.4 17:43:00 INFO - moznetwork == 0.27 17:43:00 INFO - mozprocess == 0.25 17:43:00 INFO - mozprofile == 0.28 17:43:00 INFO - mozrunner == 6.13 17:43:00 INFO - mozscreenshot == 0.1 17:43:00 INFO - mozsystemmonitor == 0.3 17:43:00 INFO - moztest == 0.8 17:43:00 INFO - mozversion == 1.4 17:43:00 INFO - psutil == 3.1.1 17:43:00 INFO - requests == 1.2.3 17:43:00 INFO - wsgiref == 0.1.2 17:43:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:43:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:00 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 0x1d531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c2a30>, '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 0x20c37f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c3ca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1494549732.339517-1433854511', '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 17:43:00 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 17:43:00 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 17:43:00 INFO - Using env: {'DISPLAY': ':0', 17:43:00 INFO - 'HOME': '/home/cltbld', 17:43:00 INFO - 'LANG': 'en_US.UTF-8', 17:43:00 INFO - 'LANGUAGE': 'en_US:en', 17:43:00 INFO - 'LOGNAME': 'cltbld', 17:43:00 INFO - 'MAIL': '/var/mail/cltbld', 17:43:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:00 INFO - 'MOZ_NO_REMOTE': '1', 17:43:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:00 INFO - 'NO_EM_RESTART': '1', 17:43:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:00 INFO - 'PWD': '/builds/slave/test', 17:43:00 INFO - 'SHELL': '/bin/bash', 17:43:00 INFO - 'SHLVL': '1', 17:43:00 INFO - 'TERM': 'linux', 17:43:00 INFO - 'TMOUT': '86400', 17:43:00 INFO - 'USER': 'cltbld', 17:43:00 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1494549732.339517-1433854511', 17:43:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:00 INFO - '_': '/tools/buildbot/bin/python'} 17:43:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:01 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)) 17:43:01 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)) 17:43:01 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)) 17:43:01 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)) 17:43:01 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)) 17:43:01 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)) 17:43:01 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)) 17:43:01 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)) 17:43:01 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)) 17:43:01 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)) 17:43:01 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)) 17:43:01 INFO - Cleaning up... 17:43:01 INFO - Return code: 0 17:43:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c2a30>, '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 0x20c37f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c3ca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1494549732.339517-1433854511', '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 17:43:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:43:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:43:01 INFO - Using env: {'DISPLAY': ':0', 17:43:01 INFO - 'HOME': '/home/cltbld', 17:43:01 INFO - 'LANG': 'en_US.UTF-8', 17:43:01 INFO - 'LANGUAGE': 'en_US:en', 17:43:01 INFO - 'LOGNAME': 'cltbld', 17:43:01 INFO - 'MAIL': '/var/mail/cltbld', 17:43:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:01 INFO - 'MOZ_NO_REMOTE': '1', 17:43:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:01 INFO - 'NO_EM_RESTART': '1', 17:43:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:01 INFO - 'PWD': '/builds/slave/test', 17:43:01 INFO - 'SHELL': '/bin/bash', 17:43:01 INFO - 'SHLVL': '1', 17:43:01 INFO - 'TERM': 'linux', 17:43:01 INFO - 'TMOUT': '86400', 17:43:01 INFO - 'USER': 'cltbld', 17:43:01 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1494549732.339517-1433854511', 17:43:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:01 INFO - '_': '/tools/buildbot/bin/python'} 17:43:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:43:01 INFO - Cleaning up... 17:43:01 INFO - Return code: 0 17:43:01 INFO - Running post-action listener: _resource_record_post_action 17:43:01 INFO - Running post-action listener: _start_resource_monitoring 17:43:01 INFO - Starting resource monitoring. 17:43:01 INFO - [mozharness: 2017-05-12 00:43:01.366264Z] Finished create-virtualenv step (success) 17:43:01 INFO - [mozharness: 2017-05-12 00:43:01.366777Z] Running install step. 17:43:01 INFO - Running pre-action listener: _resource_record_pre_action 17:43:01 INFO - Running main action method: install 17:43:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:43:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:43:01 INFO - Reading from file tmpfile_stdout 17:43:01 INFO - Detecting whether we're running mozinstall >=1.0... 17:43:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:43:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:43:01 INFO - Reading from file tmpfile_stdout 17:43:01 INFO - Output received: 17:43:01 INFO - Usage: mozinstall [options] installer 17:43:01 INFO - Options: 17:43:01 INFO - -h, --help show this help message and exit 17:43:01 INFO - -d DEST, --destination=DEST 17:43:01 INFO - Directory to install application into. [default: 17:43:01 INFO - "/builds/slave/test"] 17:43:01 INFO - --app=APP Application being installed. [default: firefox] 17:43:01 INFO - mkdir: /builds/slave/test/build/application 17:43:01 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'] 17:43:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:43:18 INFO - Reading from file tmpfile_stdout 17:43:18 INFO - Output received: 17:43:18 INFO - /builds/slave/test/build/application/firefox/firefox 17:43:18 INFO - Running post-action listener: _resource_record_post_action 17:43:18 INFO - [mozharness: 2017-05-12 00:43:18.738048Z] Finished install step (success) 17:43:18 INFO - [mozharness: 2017-05-12 00:43:18.738295Z] Running run-tests step. 17:43:18 INFO - Running pre-action listener: _resource_record_pre_action 17:43:18 INFO - Running main action method: run_tests 17:43:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:43:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:43:18 INFO - Python 2.7.3 17:43:18 INFO - Return code: 0 17:43:18 INFO - grabbing minidump binary from tooltool 17:43: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')]} 17:43:18 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 0x20c2a30>, '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 0x20c37f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c3ca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:43:18 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 17:43:18 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 17:43:18 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 17:43:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:43:18 INFO - Return code: 0 17:43:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:43:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:43:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:43:18 INFO - ENV: RUST_BACKTRACE is now 1 17:43:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:43:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:43:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EgneG4LHTiSiS4iuGGWyDQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:43:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EgneG4LHTiSiS4iuGGWyDQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-005 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:43:18 INFO - Using env: {'DISPLAY': ':0', 17:43:18 INFO - 'HOME': '/home/cltbld', 17:43:18 INFO - 'LANG': 'en_US.UTF-8', 17:43:18 INFO - 'LANGUAGE': 'en_US:en', 17:43:18 INFO - 'LOGNAME': 'cltbld', 17:43:18 INFO - 'MAIL': '/var/mail/cltbld', 17:43:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:43:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:43:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:18 INFO - 'MOZ_NO_REMOTE': '1', 17:43:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:43:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:18 INFO - 'NO_EM_RESTART': '1', 17:43:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:18 INFO - 'PWD': '/builds/slave/test', 17:43:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:43:18 INFO - 'RUST_BACKTRACE': '1', 17:43:18 INFO - 'SHELL': '/bin/bash', 17:43:18 INFO - 'SHLVL': '1', 17:43:18 INFO - 'TERM': 'linux', 17:43:18 INFO - 'TMOUT': '86400', 17:43:18 INFO - 'USER': 'cltbld', 17:43:18 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1494549732.339517-1433854511', 17:43:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:18 INFO - '_': '/tools/buildbot/bin/python'} 17:43:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EgneG4LHTiSiS4iuGGWyDQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:43:19 INFO - mozversion application_buildid: 20170511234406 17:43:19 INFO - mozversion application_changeset: c1719e0d676b56ccd940c6f8a9b1bb819d441b20 17:43:19 INFO - mozversion application_display_name: Nightly 17:43:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:43:19 INFO - mozversion application_name: Firefox 17:43:19 INFO - mozversion application_remotingname: firefox 17:43:19 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:43:19 INFO - mozversion application_vendor: Mozilla 17:43:19 INFO - mozversion application_version: 55.0a1 17:43:19 INFO - mozversion platform_buildid: 20170511234406 17:43:19 INFO - mozversion platform_changeset: c1719e0d676b56ccd940c6f8a9b1bb819d441b20 17:43:19 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:43:19 INFO - mozversion platform_version: 55.0a1 17:43:19 INFO - using testdate: 1494549799 17:43:19 INFO - actual date: 1494549799 17:43:19 INFO - starting webserver on 'localhost:47311' 17:43:19 INFO - SUITE-START | Running 2 tests 17:43:19 INFO - TEST-START | dromaeo_css 17:43:19 INFO - operating with platform_type : linux_ 17:43:19 INFO - Initialising browser for dromaeo_css test... 17:43:19 INFO - TEST-INFO | started process 14568 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3cwl0y/profile http://localhost:47311/getInfo.html) 17:43:22 INFO - PID 14568 | __metrics Screen width/height:1600/1200 17:43:22 INFO - PID 14568 | colorDepth:24 17:43:22 INFO - PID 14568 | Browser inner width/height: 1024/695 17:43:22 INFO - PID 14568 | __metrics 17:43:23 INFO - PID 14568 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:43:23 INFO - PID 14568 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:43:24 INFO - TEST-INFO | 14568: exit 0 17:43:24 INFO - Browser initialized. 17:43:24 INFO - Running cycle 1/1 for dromaeo_css test... 17:43:24 INFO - TEST-INFO | started process 14665 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3cwl0y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:43:35 INFO - PID 14665 | RSS: Main: 144261120 17:43:35 INFO - PID 14665 | 17:46:38 INFO - PID 14665 | Cycle 1(1): loaded http://localhost:47311/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47311/tests/dromaeo/cssquery-ext.html) 17:46:39 INFO - PID 14665 | RSS: Main: 248778752 17:46:39 INFO - PID 14665 | 17:49:41 INFO - PID 14665 | Cycle 1(1): loaded http://localhost:47311/tests/dromaeo/cssquery-ext.html (next: http://localhost:47311/tests/dromaeo/cssquery-jquery.html) 17:49:42 INFO - PID 14665 | RSS: Main: 225837056 17:49:42 INFO - PID 14665 | 17:52:44 INFO - PID 14665 | Cycle 1(1): loaded http://localhost:47311/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47311/tests/dromaeo/cssquery-mootools.html) 17:52:44 INFO - PID 14665 | RSS: Main: 177848320 17:52:44 INFO - PID 14665 | 17:55:46 INFO - PID 14665 | Cycle 1(1): loaded http://localhost:47311/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47311/tests/dromaeo/cssquery-prototype.html) 17:55:47 INFO - PID 14665 | RSS: Main: 177074176 17:55:47 INFO - PID 14665 | 17:58:49 INFO - PID 14665 | Cycle 1(1): loaded http://localhost:47311/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47311/tests/dromaeo/cssquery-yui.html) 17:58:50 INFO - PID 14665 | RSS: Main: 179060736 17:58:50 INFO - PID 14665 | 18:01:52 INFO - PID 14665 | Cycle 1(1): loaded http://localhost:47311/tests/dromaeo/cssquery-yui.html (next: http://localhost:47311/tests/dromaeo/cssquery-dojo.html) 18:01:52 INFO - PID 14665 | RSS: Main: 274046976 18:01:52 INFO - PID 14665 | 18:01:52 INFO - PID 14665 | __start_tp_report 18:01:52 INFO - PID 14665 | _x_x_mozilla_page_load 18:01:52 INFO - PID 14665 | _x_x_mozilla_page_load_details 18:01:52 INFO - PID 14665 | |i|pagename|runs| 18:01:52 INFO - PID 14665 | |0;dojo.html;3210.390025895081;3226.1128189747815;3237.465818140007;3246.8701251949915;3286.5563148974898;5461;5560.304961879765;5652.660840349582;5670.518005969492;5683.346415162252;5534.833954981357;5565.220869078322;5611.635243709166;5641.971790141054;5760.683162426076;4678.672492925497;4963.7021778693215;5018.397792264925;5099;5114.923276150842;5043.016611760708;5080.568151707109;5095.3885533736;5136.383633963911;5136.974315128419;4954.380702412199;5004.524570165829;5029.522195391413;5075.086484432801;5101.82143624975;5069.366329208849;5070.8225212117395;5071.39143302806;5078.009788091324;5120.129577971754;5011.373578302712;5030.220315851049;5057.468965758616;5063.518965698289;5066.0374528839775;5498.725063746797;5529.087700529408;5566.721663916828;5602.299712535933;5640.971795141039;6020.518358531307;6032.487238584726;6039.758409663608;6081.239845019372;6084.878302433926;6020.909686354708;6031.306399764039;6056.545759068087;6077.361877002895;6086.786962456337;5461.098918678414;5524.613277070566;5551.805686800943;5619.353774315965;5624.156376543551;6249.96875015622;6270.122182894398;6271.686415679198;6274.372562743781;6276.686165691788;5857.121431785266;5869.178315035899;5928.318243401977;5932.555058370639;5935.792247271324;6132.8756461173125;6138.1738283688655;6142.003848749175;6144.740328232701;6144.8771024580155;5969.134475501115;6024.759009639565;6039.818805435844;6047.848803779941;6137.877242455126;6107.328193898667;6108.7974236896625;6116.223169985297;6121.696863452088;6138.294096178996;4677.158111539888;4677.22825733757;4679.227927391942;4704.858854234379;4714.080754252887;4084.4690190275073;4158.209940111369;4173.874783756492;4176;4199.748015119103;5597.188407680864;5608.046632072557;5612.915806262909;5613.46672066153;5617.606767526316;5937.821865344046;5970.671613061237;6003.3996600339615;6018.458338749446;6067.180930574405;5678.346990096109;5722.055860783007;5727.742251598688;5735.1970724098655;5780.335261444988;5318;5320.547753441001;5325.547328477045;5328.040952628564;5346.1713434417725;6186.19579454668;6247.187865577446;6265.27949285838;6412.39082287182;6419.486441084702;6103.277060575968;6111.470193407285;6124.197855633957;6125.11336343068;6125.754381768298;6335.1447554579545;6383.96808015957;6392.648404337806;6393.552451328363;6395.264544577433;5881.088431293157;5953.1367951647635;6016.09758536223;6023.939760602513;6044.24446944132;5997.880042399041;6091.299500557493;6097.7865774697675;6102.481289090477;6107.175531303217;5873.618214816023;5880.353161152184;5881.147233651182;5900.881982360414;5926.555508336805;5881.676507791942;5928.8814223716145;5934.050551911673;5939.524838013035;5946.108083787466;5875.676837773793;5934;5935.643861368331;5947.405259474018;5962.493188079062;5952.464278214981;5955;5978.402159784161;5996.400359963969;6012.068129439944;5791.420857914343;5807.564432667651;5808.041673123887;5812.244408226903;5813.273340832396 18:01:52 INFO - PID 14665 | |1;ext.html;812.3054788156127;1118.815395459749;1135.6876858863811;1141.7145713571608;1178.8172833210856;37638.43542346863;38382.23235535288;38594.42108368377;38616.61383386165;38636.420453693216;35448.82275588618;35492.11269718252;35820.46269305963;35822.64177358232;35851.282974340495;5474.644148130379;5622.437756224385;6571.605703657772;6679.231888332855;6687.331266873322;6907.309269073077;7092.680829362691;7103.218645948941;7105.182903966059;7107.3603375696175;7118.85762284754;7144.106986626672;7193.784186474388;7194.460415468835;7195.064641596611;5469.316335458067;5618.606697531174;7115.39519140871;7163.391111755481;7168.211496735355;5540.778368865241;6895;7086;7090.07828982229;7096.929030709678;35758.28483430343;36046.45930311021;36055.4591681125;36065.09837254063;36136.63863361359;3504.54440922681;3522.119470132467;3543.326767914114;3543.3799085160254;3545.131442796506;28494.287642809097;28507.714922850715;28545;28555.428891422056;28572.142835714752;3670.72469564781;3703.962960370389;3714.1271801126713;3724.944125838115;3736.953652977171;192078;192402;192517;192695;192705;40406.19187616231;41097.79451102785;46443.76778116155;48677.26984095242;48923;48454.51545484571;48657.756711216214;48663.51336486661;48719.75640121777;48729.51270487321;13790.65523361924;13897.513587024609;13898.58304250874;13905;13911.165330080228;11142.220044596801;11142.721431964104;11146.386948717898;11158.1631377647;11159.49782259784;13161.736765264832;13261.801072983913;13271.867281327062;13296.800547991788;13390;5310.946890531122;5495.285612870382;5498.505134537911;5521.4478552145265;5540.750666220029;1044.38903241603;1084.35480888871;1088.7604726960055;1117.0393461622998;1124.9381284029457;23978.88010559936;25334.239972800846;25374.238772836845;25388.111416100717;25464.618030729554;1172.9120315976336;1173.677238759331;1183.183603313728;1183.8875306845837;1205.7046023724245;12554.748905022032;13240.801387979189;13300.933495332654;13328.600141995756;13375.866241337657;217782;218692;220087;220995;221378;50425;50458.24312635313;50495;50522.926790249396;50525.49474505281;1404.108391171593;1456.788765628978;1505.9774103388459;1508.3137172586446;1514.386673397276;23688.88155559211;24722.876385617958;24725.13462028892;24830.627540586545;25034.62448063244;37360.81319593385;38246.23507529889;38305.80847095747;38339.424908625835;38378.61621383862;197923;197977;198091;198585;199644;28973.420531589672;29504.409911801213;31685.841570792;33438;33573.32853342968;39187.608123919534;40328.59671403249;40896.38655420112;41062.79468602638;41231.7938410306;30211.395772084874;30486.044874131847;30704.232394190323;31401.37197256088;31494.370112598077;30071;30323.393532129674;30772.230694232825;30975.69024309728;31367;33621.3275734479;34636;35066.47400288947;35283.294334113685;35479.46780798342;28659.856700716362;29125.708742913146;29313.85343073271;30083.3983320328;30301.848490757406;23262.76737232606;24530.386740331636;24661.87669061643;24734.25797226086;25158.74841251564 18:01:52 INFO - PID 14665 | |2;jquery.html;415.8502938941978;436.4805881001608;438.7499125498467;442.4381036084173;456.94059772229605;19643.017849107542;20135.39593812188;20240.493987650298;20450.284240051602;20482.38552843417;21153;21978;22402.32793016208;22585;22812.429689257777;5318.335208098997;5447.945520544803;5463.125899856024;5470.17947307903;5471.37079235887;5215.582753379739;5478.287822583058;5513.09034009388;5518.310211223597;5530.087535556629;5476.863078423032;5488.4785945335325;5488.670679759207;5491.395946445888;5495.258140151069;5339.8398048058425;5454.7272636368025;5482.23248745176;5488.1493368527945;5488.4237155098535;4958.504149585049;4971.801127954877;4981.427135879348;4981.576565991895;4981.750912454363;25346.746532534624;26059;26118.694065296848;26209;26352.868235658698;2096.402525280303;2097.4127244371603;2139.5720855828895;2139.818115460172;2141.2612648636195;16300.510984670478;16524.339026438927;16813.91593042027;16850.915745421316;16980.83019169805;2167.26313053561;2225.9888700556394;2248.4940888300166;2260.5139894922672;2264.7055882735303;108708.60364457867;112952.87047129506;113127.43436282848;113161.43419282851;114420.4278978608;12018.819717704242;12254.326012069421;12532.436040378205;12738.808917866054;12793.168444051107;17541;17635.206415711324;17675.646487070444;17707.73438398425;17710.380136695152;8376.371772117116;8728.825423491495;8820.162084601952;8821.073787252375;8885.200331970025;7956.5226086435;8016.959915200387;8030.63862126194;8219.465734727224;8254.42219044673;7827.9608601956625;7868.875403640985;7984.840303193903;8050.235227653364;8139.877901831477;2272.307500311993;2307.1924826310656;2321.97678023221;2326.3718795925006;2429.149797570836;1034.384541197986;1068.2468859454066;1069.3476979042778;1072.4905669806778;1073.683263437288;22666.66000010001;23433.88283058574;25183.622245665963;25525.74474255271;25638.230853074063;1070.2561719604955;1073.4632683658172;1076.6016573867719;1079.384750692098;1081.0972837680467;11279.605213817476;11554.826677599844;11630.418479076012;11721.531138754524;11825.467853946593;514012;517945;519188;536671;546841;98967.50516247372;99385;101436.49281753691;101533;101565;1191.4817054581285;1247.4012474012343;1281.7885048966816;1291.5092264939262;1296.1251155470209;19978.800211997695;20056.398308050782;20824.271150510267;20832.791672083084;20850.47873803167;45620.29746281715;46008.769956151344;46416;46530.767346163055;47603.76198118987;59084;60269.397306028135;60326.396736032075;60581.69709151426;61597.38402615916;9607.471589062668;9798.216142708423;9931.106200441995;9975.60097596088;10106.848397274194;14838.18389988561;15511.146886921328;15512.146831924352;15559.988600740915;15617.219139042774;12988.220706757626;13315;13387.330633468093;13435.596932092052;13671.79492307636;12137.817932731192;12355.69110772238;12408;12560.37198140071;13024.934875325564;13259;13292.800607991081;13364.599062028155;13383.19700817954;13575.456981721016;9616.567254473426;9762.75593110178;9824.214062875095;9902.207823374258;10018.499075046073;12432;13049.804252936403;13264.602061938158;13414.597562073153;13527.526536571173 18:01:52 INFO - PID 14665 | |3;mootools.html;1198.3648666206914;1316.2168509736707;1384.5015794314045;1392.338639146405;1406.0368647476475;9612.951935240322;10621.46892655367;11220.551177952882;11238.831417528723;11244.156688248373;10800.433937079119;10933.398663073527;10944.781104377927;10949.890501094987;10953.068989135932;2001.3695685858982;2399.976000239997;2440;2441.7680320369627;2444.8899799509063;2033.3594917600908;2052.733144691188;2054.60962417141;2342.754010828864;2413.2036427978724;2376.536575367804;2389.0563227525117;2389.1279682915697;2389.163792672568;2391.868447235401;2267.841251112423;2302.654601809725;2303.8387312888103;2309.168699268262;2314.837961342707;2246.584381889356;2271.761465046163;2278.874661893595;2280.293109136173;2290.633498640226;10445.164386849034;10508.2644214905;10513.52689128991;10521.210909181842;10572.312799667998;6019.337872833985;6157.107219453154;6171.814845554641;6204.224471941007;6213.5339849511465;3627.6009638939695;3689.797061161635;3782;3951.7036222283446;3956.56477787446;1184.538030168235;1194.5341316886422;1258.6538701857062;1263.9368031598383;1277.3613193403298;16148.596285092966;16223.432179873647;16225.675486490321;16250.349986000545;16253.18734063304;5192.558632516203;5327.573794096463;5476.289236827795;5545.251391062236;5549.556035517149;13369.064165508516;13398.464061437628;13463.932680336731;13503.324833758274;13512;6255.40573645503;6265.122882796412;6273.529485288622;6276.121343011982;6281.246250449975;5563.054280772279;5668.319801623749;5692.6015178937905;5747.827565172968;5774.48029677331;4036.2129384769687;4228.344606585984;4443.755593442327;4585.082983403266;4603.332516785047;1351.1690310458996;1413.6253892718232;1418.269591160553;1420.08404579048;1424.3234463629901;826.3389288569241;833.4457585705438;849.6219182463868;853.5220276645099;883.0771843423638;6005.159277701126;6050.9394906050375;6138.6623735694075;6140.95603747364;6219.253689557282;874.5539774714814;909.7043460875242;955.159459675495;963.9277054220961;990.3265779270165;4088.468499095158;4113.8971525712095;4297.8495752648505;4377.9781101094295;4467.865964021084;13501;14049.367778449994;14065.71868562623;14085.295735213404;14094.365753541115;13784.724305514033;14037.649058773612;14154.36305366261;14159.85840141606;14217.36021879018;9081.728558001885;9119.133682300171;9198;9280.489573073412;9294.86057709135;6244.313125556276;6273.309935906956;6330.493560515056;6377.043443483329;6508.479321654351;12490.313032783284;12661.493540258654;12672.239665620093;12844;12954.80567791465;12737.808932866199;13043.478260869839;13222.603321900358;13231.933840330737;13265.403056862657;9073.364864459425;9185.632574697205;9211.677591284273;9253.306002050007;9262.212711919292;9132.954335228282;9879;10354.1198998083;10354.585816567253;10448.373097614167;8834.204921557091;8862.20240178387;8917.242034427147;9022.909770902206;9065.048169942062;8441.788955276168;8616.913830861611;8660.740177794676;8797.648094076421;8974.967878693773;7306.634668266672;7429.07136607924;7433.145188303414;7436.628168591441;7440.404767618469;5434.402215756185;5438.891222175614;5542.7782888685615;5589.301337332833;5656.43435656431;5716.54267658578;5738.626989245686;5751.597388182787;5841.065429531254;5850.444207800252 18:01:52 INFO - PID 14665 | |4;prototype.html;387.0748910104848;391.86872397746754;392.32128417837123;392.3584938625348;397.7692938095904;5766.596338256319;5810.651360918338;5835.153902684114;5838.883222335551;5842.853928651786;5251.763670634821;5688.108226924841;5714.742836572354;5756.136579513075;5757.280339957505;4571.47428045774;4571.839985600504;4579.885502862438;4580.1984652685815;4600.309953506984;4593.127305811885;4601.260701477484;4609.838655647053;4617.46899106602;4620.099080679269;4512.0975804839;4562.315652652095;4578.992621623238;4593.885152871188;4619.8152073917;4544.636429085665;4550.908981820362;4555.954440455586;4558.977205113986;4563.748993805356;4140.6729967184365;4155.688323375729;4156.91686166278;4162.91674166515;4168.416421700964;5547.140193270009;5625.71871406428;5660.688662123582;5684.9147262790675;5696.8006119785605;5359.866003349947;5377.354717433933;5382.111951527993;5382.973085134549;5399.865003374908;6021.63870167787;6147.815565533041;6156.692165391757;6158.7228574714245;6175.783847565313;4628.861134165981;4632.212523870916;4634.420697412824;4641.141388843075;4660.883477913046;6151.323354431009;6338.144350512668;6345.365463453664;6349.904751428732;6354.205724284465;4545.863624091283;4566.680332376702;4566.725996440225;4755.310479980383;4787.904241915142;4885.218365061573;4905.705657660552;4918.336024636628;4923.113839508851;4946.4064312282035;5254.789808407697;5410.161424979135;5423.430539793344;5428.018773147773;5466.535344495683;6212.782552610637;6230.688465576703;6243.219597550306;6243.531735119885;6247.781327653601;1684.991575042117;1702.540314115182;1721.0878234535467;1721.4061148903609;1723.8534724548304;1185.4369174641977;1192.1893112683458;1194.7192409783695;1211.7213041000618;1217.4704003758393;5896.410358964069;5906.8818623627285;5922.615030023035;5923.407659234128;5934.109883517421;6145.784897528565;6242.531810114259;6343.619382837044;6348.841278968062;6362.554621176473;5884.617499862496;5897.174395584621;5904.132793020578;5904.261967254093;5909.793157239476;3239.49787782894;3304.438245498223;3335.466325387975;3341.5655964724915;3348.547946027304;6565.818152732554;6578.703958321791;6652.467802575782;6657.434118100015;6678.3655552723385;6477.546571739933;6507.837304067341;6510.934890651033;6520.869582608321;6534;6418.1656384669695;6532.902006470002;6539.738410463623;6583;6613.338666133348;6247.718852651732;6273.215848018997;6302.779402720883;6313.1477250572425;6315.368463153832;5971.641701497924;6184.226971628546;6195.482106883662;6239.377761782061;6264.684416272452;6303.338149494237;6401.487880969418;6414.230292364759;6419.716056788568;6435.517336199898;4742.834000809955;4785.210440277455;4804.495527969652;4808.2787581863;4828.37231159947;6131.570790044654;6231.937680623136;6261.123442718114;6267.780627678009;6270.372962703693;5950.523958083257;5975.103734439869;5980.760769569342;5983.132445795248;6023;5954.255718035246;6023;6034.728437220423;6066.272047354169;6080.939190608215;6065.787697430569;6067.211262535842;6081.6924361262545;6092.268927728701;6101.664408457577;5882.088276317178;6053.969730151321;6077.696115194134;6090.665013424127;6091.5126789857595;5892.970535147297;5906.734196961061;5970.940290597212;5971.820845374646;5972.820815375546 18:01:52 INFO - PID 14665 | |5;yui.html;870.2776695342866;877.548062747685;887.8313120507103;889.2796834564006;890.4167770110572;16885.24016419261;17007.82992170078;17335.653286934255;17359.82640173598;17375.218115184816;16481.67036659266;16602.83397166028;16813.495595132135;16838.494845154633;16888.07115608641;1005.5977608956421;1017.5166795771986;1021.9897801022006;1027.8201314769922;1031.649239258652;1032.0917592518574;1034.1726618705043;1034.255336157965;1035.0270745499206;1035.0684384054337;1075.779465209634;1077.3966578715906;1077.6874706335154;1079.034264333421;1086.239632257419;1070.4380200394817;1071.3518321415547;1076.1928553584812;1076.8976947190004;1082.2045796339685;794.4994653368399;797.5972134072315;797.7048492057976;798.8002999250187;799.2686691677109;15390.3074361654;15796.842031579652;15937.20313984296;16219.51341459758;16306.673866522722;14813.18527480988;14889;15032.549023529311;15138.697226055527;15228.771568426482;13569.660758481019;13730.588082357544;13732;13864.376103075387;13949.232792196424;3435.12404336895;3436.896893093211;3463.1515278756615;3470.3059388122224;3474.4788281757687;64989.99999999953;82673.17326826775;84275;84577.57711211467;85493.57253213756;14455.927720361542;14702.852971470362;14977.326020329112;15005.099694018394;15023.924880375747;25328.746712533008;25389.11138110157;25396;25507.36231594225;25726.48547029049;8355.874661880076;8380.036295825936;8390;8406.873896891551;8450.19723126302;3874.5544262410185;3956.5054368203973;3960.7623542587535;3968.761874287552;3968.7817170055346;4221.409002739619;4259.595338442843;4270.0605866709275;4299.742015479082;4300.634446072119;807.4347956430522;838.4591938199827;839.5969934431507;846.1834329871581;847.631280393031;725.3689290317458;731.7438896386328;743.4498471131324;754.4379437319122;773.0221270093336;10866.61966831157;11314.208005439705;11782.234154779911;11801.822972655416;11912.106592005634;735.8344372516248;748.3975399803211;748.7267147491235;750.6809605917463;765.3456294867808;5359.812406565751;5414.7004718867975;5556.583256255716;5587.8603034923635;5712.942870571241;84620;84833.15166848376;86147.5692621533;86148;87457.56271218731;71428.2857171432;73230.2676973234;73385.63307183537;75595.24404755991;75702.24297756952;62626.37373626297;64236.67881660655;64256.67871660705;64324.356756432775;66919.66540167366;10809.513571889127;11277.32336059839;11343.319400835977;11384.14618903602;11390.145739069769;34499.137521561155;34534.48198277078;34827.47758783671;35421.103678594816;35436;41932.16135677331;42478;42721.57278427176;42918.141637167704;43783.78108109439;14235.217063061631;14308.141511509342;14411.495597654031;14599;14650.926745366205;16780.32878684839;16926.830731692524;17157.82842171562;17183.484495465156;17520.211590478713;15567.84432155664;15831.762523562385;15859.52421427359;15860.127692976997;15916.68166636684;15044.247787610357;15315.234238288263;15532.534023979299;15573;15714.449994250146;15768.526944191693;15768.842311577197;16019.359225630844;16131.919340403223;16318.1025043619;10940.726481838017;11028.613998510014;11115.555377784798;11262.943685281522;11473.713157170803;11865.703357416134;12340.691482713004;12349.135560510678;12371.381430928597;12480.750384992069 18:01:52 INFO - PID 14665 | __end_tp_report 18:01:52 INFO - PID 14665 | __start_cc_report 18:01:52 INFO - PID 14665 | _x_x_mozilla_cycle_collect,1595 18:01:52 INFO - PID 14665 | __end_cc_report 18:01:52 INFO - PID 14665 | __startTimestamp1494550912315__endTimestamp 18:01:52 INFO - PID 14665 | 18:01:52 INFO - PID 14665 | ------- Summary: start ------- 18:01:52 INFO - PID 14665 | Number of tests: 6 18:01:52 INFO - PID 14665 | 18:01:52 INFO - PID 14665 | [#0] dojo.html Cycles:165 Average:5615.97 Median:5873.62 stddev:659.79 (11.2%) stddev-sans-first:634.25 18:01:52 INFO - PID 14665 | Values: 3210.4 3226.1 3237.5 3246.9 3286.6 5461.0 5560.3 5652.7 5670.5 5683.3 5534.8 5565.2 5611.6 5642.0 5760.7 4678.7 4963.7 5018.4 5099.0 5114.9 5043.0 5080.6 5095.4 5136.4 5137.0 4954.4 5004.5 5029.5 5075.1 5101.8 5069.4 5070.8 5071.4 5078.0 5120.1 5011.4 5030.2 5057.5 5063.5 5066.0 5498.7 5529.1 5566.7 5602.3 5641.0 6020.5 6032.5 6039.8 6081.2 6084.9 6020.9 6031.3 6056.5 6077.4 6086.8 5461.1 5524.6 5551.8 5619.4 5624.2 6250.0 6270.1 6271.7 6274.4 6276.7 5857.1 5869.2 5928.3 5932.6 5935.8 6132.9 6138.2 6142.0 6144.7 6144.9 5969.1 6024.8 6039.8 6047.8 6137.9 6107.3 6108.8 6116.2 6121.7 6138.3 4677.2 4677.2 4679.2 4704.9 4714.1 4084.5 4158.2 4173.9 4176.0 4199.7 5597.2 5608.0 5612.9 5613.5 5617.6 5937.8 5970.7 6003.4 6018.5 6067.2 5678.3 5722.1 5727.7 5735.2 5780.3 5318.0 5320.5 5325.5 5328.0 5346.2 6186.2 6247.2 6265.3 6412.4 6419.5 6103.3 6111.5 6124.2 6125.1 6125.8 6335.1 6384.0 6392.6 6393.6 6395.3 5881.1 5953.1 6016.1 6023.9 6044.2 5997.9 6091.3 6097.8 6102.5 6107.2 5873.6 5880.4 5881.1 5900.9 5926.6 5881.7 5928.9 5934.1 5939.5 5946.1 5875.7 5934.0 5935.6 5947.4 5962.5 5952.5 5955.0 5978.4 5996.4 6012.1 5791.4 5807.6 5808.0 5812.2 5813.3 18:01:52 INFO - PID 14665 | 18:01:52 INFO - PID 14665 | [#1] ext.html Cycles:180 Average:36289.33 Median:31590.11 stddev:52854.28 (167.3%) stddev-sans-first:52935.42 18:01:52 INFO - PID 14665 | Values: 812.3 1118.8 1135.7 1141.7 1178.8 37638.4 38382.2 38594.4 38616.6 38636.4 35448.8 35492.1 35820.5 35822.6 35851.3 5474.6 5622.4 6571.6 6679.2 6687.3 6907.3 7092.7 7103.2 7105.2 7107.4 7118.9 7144.1 7193.8 7194.5 7195.1 5469.3 5618.6 7115.4 7163.4 7168.2 5540.8 6895.0 7086.0 7090.1 7096.9 35758.3 36046.5 36055.5 36065.1 36136.6 3504.5 3522.1 3543.3 3543.4 3545.1 28494.3 28507.7 28545.0 28555.4 28572.1 3670.7 3704.0 3714.1 3724.9 3737.0 192078.0 192402.0 192517.0 192695.0 192705.0 40406.2 41097.8 46443.8 48677.3 48923.0 48454.5 48657.8 48663.5 48719.8 48729.5 13790.7 13897.5 13898.6 13905.0 13911.2 11142.2 11142.7 11146.4 11158.2 11159.5 13161.7 13261.8 13271.9 13296.8 13390.0 5310.9 5495.3 5498.5 5521.4 5540.8 1044.4 1084.4 1088.8 1117.0 1124.9 23978.9 25334.2 25374.2 25388.1 25464.6 1172.9 1173.7 1183.2 1183.9 1205.7 12554.7 13240.8 13300.9 13328.6 13375.9 217782.0 218692.0 220087.0 220995.0 221378.0 50425.0 50458.2 50495.0 50522.9 50525.5 1404.1 1456.8 1506.0 1508.3 1514.4 23688.9 24722.9 24725.1 24830.6 25034.6 37360.8 38246.2 38305.8 38339.4 38378.6 197923.0 197977.0 198091.0 198585.0 199644.0 28973.4 29504.4 31685.8 33438.0 33573.3 39187.6 40328.6 40896.4 41062.8 41231.8 30211.4 30486.0 30704.2 31401.4 31494.4 30071.0 30323.4 30772.2 30975.7 31367.0 33621.3 34636.0 35066.5 35283.3 35479.5 28659.9 29125.7 29313.9 30083.4 30301.8 23262.8 24530.4 24661.9 24734.3 25158.7 18:01:52 INFO - PID 14665 | 18:01:52 INFO - PID 14665 | [#2] jquery.html Cycles:180 Average:32450.26 Median:12416.75 stddev:87396.80 (703.9%) stddev-sans-first:87608.87 18:01:52 INFO - PID 14665 | Values: 415.9 436.5 438.7 442.4 456.9 19643.0 20135.4 20240.5 20450.3 20482.4 21153.0 21978.0 22402.3 22585.0 22812.4 5318.3 5447.9 5463.1 5470.2 5471.4 5215.6 5478.3 5513.1 5518.3 5530.1 5476.9 5488.5 5488.7 5491.4 5495.3 5339.8 5454.7 5482.2 5488.1 5488.4 4958.5 4971.8 4981.4 4981.6 4981.8 25346.7 26059.0 26118.7 26209.0 26352.9 2096.4 2097.4 2139.6 2139.8 2141.3 16300.5 16524.3 16813.9 16850.9 16980.8 2167.3 2226.0 2248.5 2260.5 2264.7 108708.6 112952.9 113127.4 113161.4 114420.4 12018.8 12254.3 12532.4 12738.8 12793.2 17541.0 17635.2 17675.6 17707.7 17710.4 8376.4 8728.8 8820.2 8821.1 8885.2 7956.5 8017.0 8030.6 8219.5 8254.4 7828.0 7868.9 7984.8 8050.2 8139.9 2272.3 2307.2 2322.0 2326.4 2429.1 1034.4 1068.2 1069.3 1072.5 1073.7 22666.7 23433.9 25183.6 25525.7 25638.2 1070.3 1073.5 1076.6 1079.4 1081.1 11279.6 11554.8 11630.4 11721.5 11825.5 514012.0 517945.0 519188.0 536671.0 546841.0 98967.5 99385.0 101436.5 101533.0 101565.0 1191.5 1247.4 1281.8 1291.5 1296.1 19978.8 20056.4 20824.3 20832.8 20850.5 45620.3 46008.8 46416.0 46530.8 47603.8 59084.0 60269.4 60326.4 60581.7 61597.4 9607.5 9798.2 9931.1 9975.6 10106.8 14838.2 15511.1 15512.1 15560.0 15617.2 12988.2 13315.0 13387.3 13435.6 13671.8 12137.8 12355.7 12408.0 12560.4 13024.9 13259.0 13292.8 13364.6 13383.2 13575.5 9616.6 9762.8 9824.2 9902.2 10018.5 12432.0 13049.8 13264.6 13414.6 13527.5 18:01:52 INFO - PID 14665 | 18:01:52 INFO - PID 14665 | [#3] mootools.html Cycles:180 Average:6839.42 Median:3954.13 stddev:4356.54 (110.2%) stddev-sans-first:4348.14 18:01:52 INFO - PID 14665 | Values: 1198.4 1316.2 1384.5 1392.3 1406.0 9613.0 10621.5 11220.6 11238.8 11244.2 10800.4 10933.4 10944.8 10949.9 10953.1 2001.4 2400.0 2440.0 2441.8 2444.9 2033.4 2052.7 2054.6 2342.8 2413.2 2376.5 2389.1 2389.1 2389.2 2391.9 2267.8 2302.7 2303.8 2309.2 2314.8 2246.6 2271.8 2278.9 2280.3 2290.6 10445.2 10508.3 10513.5 10521.2 10572.3 6019.3 6157.1 6171.8 6204.2 6213.5 3627.6 3689.8 3782.0 3951.7 3956.6 1184.5 1194.5 1258.7 1263.9 1277.4 16148.6 16223.4 16225.7 16250.3 16253.2 5192.6 5327.6 5476.3 5545.3 5549.6 13369.1 13398.5 13463.9 13503.3 13512.0 6255.4 6265.1 6273.5 6276.1 6281.2 5563.1 5668.3 5692.6 5747.8 5774.5 4036.2 4228.3 4443.8 4585.1 4603.3 1351.2 1413.6 1418.3 1420.1 1424.3 826.3 833.4 849.6 853.5 883.1 6005.2 6050.9 6138.7 6141.0 6219.3 874.6 909.7 955.2 963.9 990.3 4088.5 4113.9 4297.8 4378.0 4467.9 13501.0 14049.4 14065.7 14085.3 14094.4 13784.7 14037.6 14154.4 14159.9 14217.4 9081.7 9119.1 9198.0 9280.5 9294.9 6244.3 6273.3 6330.5 6377.0 6508.5 12490.3 12661.5 12672.2 12844.0 12954.8 12737.8 13043.5 13222.6 13231.9 13265.4 9073.4 9185.6 9211.7 9253.3 9262.2 9133.0 9879.0 10354.1 10354.6 10448.4 8834.2 8862.2 8917.2 9022.9 9065.0 8441.8 8616.9 8660.7 8797.6 8975.0 7306.6 7429.1 7433.1 7436.6 7440.4 5434.4 5438.9 5542.8 5589.3 5656.4 5716.5 5738.6 5751.6 5841.1 5850.4 18:01:52 INFO - PID 14665 | 18:01:52 INFO - PID 14665 | [#4] prototype.html Cycles:180 Average:5210.56 Median:5883.35 stddev:1477.50 (25.1%) stddev-sans-first:1436.60 18:01:52 INFO - PID 14665 | Values: 387.1 391.9 392.3 392.4 397.8 5766.6 5810.7 5835.2 5838.9 5842.9 5251.8 5688.1 5714.7 5756.1 5757.3 4571.5 4571.8 4579.9 4580.2 4600.3 4593.1 4601.3 4609.8 4617.5 4620.1 4512.1 4562.3 4579.0 4593.9 4619.8 4544.6 4550.9 4556.0 4559.0 4563.7 4140.7 4155.7 4156.9 4162.9 4168.4 5547.1 5625.7 5660.7 5684.9 5696.8 5359.9 5377.4 5382.1 5383.0 5399.9 6021.6 6147.8 6156.7 6158.7 6175.8 4628.9 4632.2 4634.4 4641.1 4660.9 6151.3 6338.1 6345.4 6349.9 6354.2 4545.9 4566.7 4566.7 4755.3 4787.9 4885.2 4905.7 4918.3 4923.1 4946.4 5254.8 5410.2 5423.4 5428.0 5466.5 6212.8 6230.7 6243.2 6243.5 6247.8 1685.0 1702.5 1721.1 1721.4 1723.9 1185.4 1192.2 1194.7 1211.7 1217.5 5896.4 5906.9 5922.6 5923.4 5934.1 6145.8 6242.5 6343.6 6348.8 6362.6 5884.6 5897.2 5904.1 5904.3 5909.8 3239.5 3304.4 3335.5 3341.6 3348.5 6565.8 6578.7 6652.5 6657.4 6678.4 6477.5 6507.8 6510.9 6520.9 6534.0 6418.2 6532.9 6539.7 6583.0 6613.3 6247.7 6273.2 6302.8 6313.1 6315.4 5971.6 6184.2 6195.5 6239.4 6264.7 6303.3 6401.5 6414.2 6419.7 6435.5 4742.8 4785.2 4804.5 4808.3 4828.4 6131.6 6231.9 6261.1 6267.8 6270.4 5950.5 5975.1 5980.8 5983.1 6023.0 5954.3 6023.0 6034.7 6066.3 6080.9 6065.8 6067.2 6081.7 6092.3 6101.7 5882.1 6054.0 6077.7 6090.7 6091.5 5893.0 5906.7 5970.9 5971.8 5972.8 18:01:52 INFO - PID 14665 | 18:01:52 INFO - PID 14665 | [#5] yui.html Cycles:180 Average:18335.35 Median:17259.57 stddev:22737.81 (131.7%) stddev-sans-first:22763.78 18:01:52 INFO - PID 14665 | Values: 870.3 877.5 887.8 889.3 890.4 16885.2 17007.8 17335.7 17359.8 17375.2 16481.7 16602.8 16813.5 16838.5 16888.1 1005.6 1017.5 1022.0 1027.8 1031.6 1032.1 1034.2 1034.3 1035.0 1035.1 1075.8 1077.4 1077.7 1079.0 1086.2 1070.4 1071.4 1076.2 1076.9 1082.2 794.5 797.6 797.7 798.8 799.3 15390.3 15796.8 15937.2 16219.5 16306.7 14813.2 14889.0 15032.5 15138.7 15228.8 13569.7 13730.6 13732.0 13864.4 13949.2 3435.1 3436.9 3463.2 3470.3 3474.5 64990.0 82673.2 84275.0 84577.6 85493.6 14455.9 14702.9 14977.3 15005.1 15023.9 25328.7 25389.1 25396.0 25507.4 25726.5 8355.9 8380.0 8390.0 8406.9 8450.2 3874.6 3956.5 3960.8 3968.8 3968.8 4221.4 4259.6 4270.1 4299.7 4300.6 807.4 838.5 839.6 846.2 847.6 725.4 731.7 743.4 754.4 773.0 10866.6 11314.2 11782.2 11801.8 11912.1 735.8 748.4 748.7 750.7 765.3 5359.8 5414.7 5556.6 5587.9 5712.9 84620.0 84833.2 86147.6 86148.0 87457.6 71428.3 73230.3 73385.6 75595.2 75702.2 62626.4 64236.7 64256.7 64324.4 66919.7 10809.5 11277.3 11343.3 11384.1 11390.1 34499.1 34534.5 34827.5 35421.1 35436.0 41932.2 42478.0 42721.6 42918.1 43783.8 14235.2 14308.1 14411.5 14599.0 14650.9 16780.3 16926.8 17157.8 17183.5 17520.2 15567.8 15831.8 15859.5 15860.1 15916.7 15044.2 15315.2 15532.5 15573.0 15714.4 15768.5 15768.8 16019.4 16131.9 16318.1 10940.7 11028.6 11115.6 11262.9 11473.7 11865.7 12340.7 12349.1 12371.4 12480.8 18:01:52 INFO - PID 14665 | -------- Summary: end -------- 18:01:52 INFO - PID 14665 | 18:01:53 INFO - TEST-INFO | 14665: exit 0 18:01:53 INFO - TEST-OK | dromaeo_css | took 1114134ms 18:01:53 INFO - TEST-START | kraken 18:01:53 INFO - operating with platform_type : linux_ 18:01:53 INFO - Initialising browser for kraken test... 18:01:53 INFO - TEST-INFO | started process 14992 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsDv3_2/profile http://localhost:47311/getInfo.html) 18:01:56 INFO - PID 14992 | __metrics Screen width/height:1600/1200 18:01:56 INFO - PID 14992 | colorDepth:24 18:01:56 INFO - PID 14992 | Browser inner width/height: 1024/695 18:01:56 INFO - PID 14992 | __metrics 18:01:57 INFO - PID 14992 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:01:57 INFO - PID 14992 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:01:58 INFO - TEST-INFO | 14992: exit 0 18:01:58 INFO - Browser initialized. 18:01:58 INFO - Running cycle 1/1 for kraken test... 18:01:58 INFO - TEST-INFO | started process 15091 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsDv3_2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:02:10 INFO - PID 15091 | RSS: Main: 143630336 18:02:10 INFO - PID 15091 | 18:02:12 INFO - PID 15091 | Cycle 1(1): loaded http://localhost:47311/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47311/tests/kraken/driver.html?testName=audio-beat-detection) 18:02:13 INFO - PID 15091 | RSS: Main: 216489984 18:02:13 INFO - PID 15091 | 18:02:15 INFO - PID 15091 | Cycle 1(1): loaded http://localhost:47311/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47311/tests/kraken/driver.html?testName=audio-dft) 18:02:16 INFO - PID 15091 | RSS: Main: 178688000 18:02:16 INFO - PID 15091 | 18:02:19 INFO - PID 15091 | Cycle 1(1): loaded http://localhost:47311/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47311/tests/kraken/driver.html?testName=audio-fft) 18:02:19 INFO - PID 15091 | RSS: Main: 258785280 18:02:19 INFO - PID 15091 | 18:02:22 INFO - PID 15091 | Cycle 1(1): loaded http://localhost:47311/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47311/tests/kraken/driver.html?testName=audio-oscillator) 18:02:22 INFO - PID 15091 | RSS: Main: 170434560 18:02:22 INFO - PID 15091 | 18:02:24 INFO - PID 15091 | Cycle 1(1): loaded http://localhost:47311/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47311/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:02:25 INFO - PID 15091 | RSS: Main: 174120960 18:02:25 INFO - PID 15091 | 18:02:28 INFO - PID 15091 | Cycle 1(1): loaded http://localhost:47311/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47311/tests/kraken/driver.html?testName=imaging-darkroom) 18:02:28 INFO - PID 15091 | RSS: Main: 230739968 18:02:28 INFO - PID 15091 | 18:02:32 INFO - PID 15091 | Cycle 1(1): loaded http://localhost:47311/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47311/tests/kraken/driver.html?testName=imaging-desaturate) 18:02:32 INFO - PID 15091 | RSS: Main: 253403136 18:02:32 INFO - PID 15091 | 18:02:35 INFO - PID 15091 | Cycle 1(1): loaded http://localhost:47311/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47311/tests/kraken/driver.html?testName=json-parse-financial) 18:02:36 INFO - PID 15091 | RSS: Main: 271093760 18:02:36 INFO - PID 15091 | 18:02:37 INFO - PID 15091 | Cycle 1(1): loaded http://localhost:47311/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47311/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:02:38 INFO - PID 15091 | RSS: Main: 198180864 18:02:38 INFO - PID 15091 | 18:02:39 INFO - PID 15091 | Cycle 1(1): loaded http://localhost:47311/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47311/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:02:40 INFO - PID 15091 | RSS: Main: 202833920 18:02:40 INFO - PID 15091 | 18:02:42 INFO - PID 15091 | Cycle 1(1): loaded http://localhost:47311/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47311/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:02:42 INFO - PID 15091 | RSS: Main: 212369408 18:02:42 INFO - PID 15091 | 18:02:45 INFO - PID 15091 | Cycle 1(1): loaded http://localhost:47311/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47311/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:02:46 INFO - PID 15091 | RSS: Main: 222130176 18:02:46 INFO - PID 15091 | 18:02:49 INFO - PID 15091 | Cycle 1(1): loaded http://localhost:47311/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47311/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:02:49 INFO - PID 15091 | RSS: Main: 199094272 18:02:49 INFO - PID 15091 | 18:02:51 INFO - PID 15091 | Cycle 1(1): loaded http://localhost:47311/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47311/tests/kraken/driver.html?testName=ai-astar) 18:02:51 INFO - PID 15091 | RSS: Main: 267239424 18:02:51 INFO - PID 15091 | 18:02:51 INFO - PID 15091 | __start_tp_report 18:02:51 INFO - PID 15091 | _x_x_mozilla_page_load 18:02:51 INFO - PID 15091 | _x_x_mozilla_page_load_details 18:02:51 INFO - PID 15091 | |i|pagename|runs| 18:02:51 INFO - PID 15091 | |0;ai-astar;108;108;109;109;107;110;108;109;109;109 18:02:51 INFO - PID 15091 | |1;audio-beat-detection;145;117;124;162;118;119;119;117;140;117 18:02:51 INFO - PID 15091 | |2;audio-dft;161;161;163;161;164;161;161;163;161;162 18:02:51 INFO - PID 15091 | |3;audio-fft;74;74;75;112;75;73;74;75;97;74 18:02:51 INFO - PID 15091 | |4;audio-oscillator;85;82;110;83;84;82;94;82;82;109 18:02:51 INFO - PID 15091 | |5;imaging-gaussian-blur;113;113;113;113;113;113;113;114;114;114 18:02:51 INFO - PID 15091 | |6;imaging-darkroom;147;147;147;146;147;147;147;147;147;148 18:02:51 INFO - PID 15091 | |7;imaging-desaturate;94;94;94;94;93;93;94;94;94;94 18:02:51 INFO - PID 15091 | |8;json-parse-financial;47;47;48;46;47;47;48;47;48;46 18:02:51 INFO - PID 15091 | |9;json-stringify-tinderbox;56;54;53;54;53;53;54;55;55;55 18:02:51 INFO - PID 15091 | |10;stanford-crypto-aes;78;80;78;85;78;77;79;80;80;77 18:02:51 INFO - PID 15091 | |11;stanford-crypto-ccm;133;124;123;123;122;123;121;122;168;122 18:02:51 INFO - PID 15091 | |12;stanford-crypto-pbkdf2;183;182;181;184;178;183;169;177;183;183 18:02:51 INFO - PID 15091 | |13;stanford-crypto-sha256-iterative;66;64;68;63;64;65;68;66;64;65 18:02:51 INFO - PID 15091 | __end_tp_report 18:02:51 INFO - PID 15091 | __start_cc_report 18:02:51 INFO - PID 15091 | _x_x_mozilla_cycle_collect,1681 18:02:51 INFO - PID 15091 | __end_cc_report 18:02:51 INFO - PID 15091 | __startTimestamp1494550971607__endTimestamp 18:02:51 INFO - PID 15091 | 18:02:51 INFO - PID 15091 | ------- Summary: start ------- 18:02:51 INFO - PID 15091 | Number of tests: 14 18:02:51 INFO - PID 15091 | 18:02:51 INFO - PID 15091 | [#0] ai-astar Cycles:10 Average:108.60 Median:109.00 stddev:0.84 (0.8%) stddev-sans-first:0.87 18:02:51 INFO - PID 15091 | Values: 108.0 108.0 109.0 109.0 107.0 110.0 108.0 109.0 109.0 109.0 18:02:51 INFO - PID 15091 | 18:02:51 INFO - PID 15091 | [#1] audio-beat-detection Cycles:10 Average:127.80 Median:121.50 stddev:15.74 (13.0%) stddev-sans-first:15.41 18:02:51 INFO - PID 15091 | Values: 145.0 117.0 124.0 162.0 118.0 119.0 119.0 117.0 140.0 117.0 18:02:51 INFO - PID 15091 | 18:02:51 INFO - PID 15091 | [#2] audio-dft Cycles:10 Average:161.80 Median:161.50 stddev:1.14 (0.7%) stddev-sans-first:1.17 18:02:51 INFO - PID 15091 | Values: 161.0 161.0 163.0 161.0 164.0 161.0 161.0 163.0 161.0 162.0 18:02:51 INFO - PID 15091 | 18:02:51 INFO - PID 15091 | [#3] audio-fft Cycles:10 Average:80.30 Median:74.50 stddev:13.25 (17.8%) stddev-sans-first:13.86 18:02:51 INFO - PID 15091 | Values: 74.0 74.0 75.0 112.0 75.0 73.0 74.0 75.0 97.0 74.0 18:02:51 INFO - PID 15091 | 18:02:51 INFO - PID 15091 | [#4] audio-oscillator Cycles:10 Average:89.30 Median:82.50 stddev:11.25 (13.6%) stddev-sans-first:11.82 18:02:51 INFO - PID 15091 | Values: 85.0 82.0 110.0 83.0 84.0 82.0 94.0 82.0 82.0 109.0 18:02:51 INFO - PID 15091 | 18:02:51 INFO - PID 15091 | [#5] imaging-gaussian-blur Cycles:10 Average:113.30 Median:113.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 18:02:51 INFO - PID 15091 | Values: 113.0 113.0 113.0 113.0 113.0 113.0 113.0 114.0 114.0 114.0 18:02:51 INFO - PID 15091 | 18:02:51 INFO - PID 15091 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 18:02:51 INFO - PID 15091 | Values: 147.0 147.0 147.0 146.0 147.0 147.0 147.0 147.0 147.0 148.0 18:02:51 INFO - PID 15091 | 18:02:51 INFO - PID 15091 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 18:02:51 INFO - PID 15091 | Values: 94.0 94.0 94.0 94.0 93.0 93.0 94.0 94.0 94.0 94.0 18:02:51 INFO - PID 15091 | 18:02:51 INFO - PID 15091 | [#8] json-parse-financial Cycles:10 Average:47.10 Median:47.00 stddev:0.74 (1.6%) stddev-sans-first:0.78 18:02:51 INFO - PID 15091 | Values: 47.0 47.0 48.0 46.0 47.0 47.0 48.0 47.0 48.0 46.0 18:02:51 INFO - PID 15091 | 18:02:51 INFO - PID 15091 | [#9] json-stringify-tinderbox Cycles:10 Average:54.20 Median:54.50 stddev:1.03 (1.9%) stddev-sans-first:0.87 18:02:51 INFO - PID 15091 | Values: 56.0 54.0 53.0 54.0 53.0 53.0 54.0 55.0 55.0 55.0 18:02:51 INFO - PID 15091 | 18:02:51 INFO - PID 15091 | [#10] stanford-crypto-aes Cycles:10 Average:79.20 Median:79.50 stddev:2.35 (3.0%) stddev-sans-first:2.45 18:02:51 INFO - PID 15091 | Values: 78.0 80.0 78.0 85.0 78.0 77.0 79.0 80.0 80.0 77.0 18:02:51 INFO - PID 15091 | 18:02:51 INFO - PID 15091 | [#11] stanford-crypto-ccm Cycles:10 Average:128.10 Median:123.00 stddev:14.43 (11.7%) stddev-sans-first:15.19 18:02:51 INFO - PID 15091 | Values: 133.0 124.0 123.0 123.0 122.0 123.0 121.0 122.0 168.0 122.0 18:02:51 INFO - PID 15091 | 18:02:51 INFO - PID 15091 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.30 Median:183.00 stddev:4.60 (2.5%) stddev-sans-first:4.77 18:02:51 INFO - PID 15091 | Values: 183.0 182.0 181.0 184.0 178.0 183.0 169.0 177.0 183.0 183.0 18:02:51 INFO - PID 15091 | 18:02:51 INFO - PID 15091 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.50 stddev:1.70 (2.6%) stddev-sans-first:1.79 18:02:51 INFO - PID 15091 | Values: 66.0 64.0 68.0 63.0 64.0 65.0 68.0 66.0 64.0 65.0 18:02:51 INFO - PID 15091 | -------- Summary: end -------- 18:02:51 INFO - PID 15091 | 18:02:52 INFO - TEST-INFO | 15091: exit 0 18:02:52 INFO - TEST-OK | kraken | took 59532ms 18:02:52 INFO - SUITE-END | took 1173s 18:02:52 INFO - Completed test suite (00:19:33) 18:02:52 INFO - javascript benchmark 18:02:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7555.631990780648, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3210.390025895081, 3226.1128189747815, 3237.465818140007, 3246.8701251949915, 3286.5563148974898, 5461.0, 5560.304961879765, 5652.660840349582, 5670.518005969492, 5683.346415162252, 5534.833954981357, 5565.220869078322, 5611.635243709166, 5641.971790141054, 5760.683162426076, 4678.672492925497, 4963.7021778693215, 5018.397792264925, 5099.0, 5114.923276150842, 5043.016611760708, 5080.568151707109, 5095.3885533736, 5136.383633963911, 5136.974315128419, 4954.380702412199, 5004.524570165829, 5029.522195391413, 5075.086484432801, 5101.82143624975, 5069.366329208849, 5070.8225212117395, 5071.39143302806, 5078.009788091324, 5120.129577971754, 5011.373578302712, 5030.220315851049, 5057.468965758616, 5063.518965698289, 5066.0374528839775, 5498.725063746797, 5529.087700529408, 5566.721663916828, 5602.299712535933, 5640.971795141039, 6020.518358531307, 6032.487238584726, 6039.758409663608, 6081.239845019372, 6084.878302433926, 6020.909686354708, 6031.306399764039, 6056.545759068087, 6077.361877002895, 6086.786962456337, 5461.098918678414, 5524.613277070566, 5551.805686800943, 5619.353774315965, 5624.156376543551, 6249.96875015622, 6270.122182894398, 6271.686415679198, 6274.372562743781, 6276.686165691788, 5857.121431785266, 5869.178315035899, 5928.318243401977, 5932.555058370639, 5935.792247271324, 6132.8756461173125, 6138.1738283688655, 6142.003848749175, 6144.740328232701, 6144.8771024580155, 5969.134475501115, 6024.759009639565, 6039.818805435844, 6047.848803779941, 6137.877242455126, 6107.328193898667, 6108.7974236896625, 6116.223169985297, 6121.696863452088, 6138.294096178996, 4677.158111539888, 4677.22825733757, 4679.227927391942, 4704.858854234379, 4714.080754252887, 4084.4690190275073, 4158.209940111369, 4173.874783756492, 4176.0, 4199.748015119103, 5597.188407680864, 5608.046632072557, 5612.915806262909, 5613.46672066153, 5617.606767526316, 5937.821865344046, 5970.671613061237, 6003.3996600339615, 6018.458338749446, 6067.180930574405, 5678.346990096109, 5722.055860783007, 5727.742251598688, 5735.1970724098655, 5780.335261444988, 5318.0, 5320.547753441001, 5325.547328477045, 5328.040952628564, 5346.1713434417725, 6186.19579454668, 6247.187865577446, 6265.27949285838, 6412.39082287182, 6419.486441084702, 6103.277060575968, 6111.470193407285, 6124.197855633957, 6125.11336343068, 6125.754381768298, 6335.1447554579545, 6383.96808015957, 6392.648404337806, 6393.552451328363, 6395.264544577433, 5881.088431293157, 5953.1367951647635, 6016.09758536223, 6023.939760602513, 6044.24446944132, 5997.880042399041, 6091.299500557493, 6097.7865774697675, 6102.481289090477, 6107.175531303217, 5873.618214816023, 5880.353161152184, 5881.147233651182, 5900.881982360414, 5926.555508336805, 5881.676507791942, 5928.8814223716145, 5934.050551911673, 5939.524838013035, 5946.108083787466, 5875.676837773793, 5934.0, 5935.643861368331, 5947.405259474018, 5962.493188079062, 5952.464278214981, 5955.0, 5978.402159784161, 5996.400359963969, 6012.068129439944, 5791.420857914343, 5807.564432667651, 5808.041673123887, 5812.244408226903, 5813.273340832396], "value": 5570.248563867895, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [812.3054788156127, 1118.815395459749, 1135.6876858863811, 1141.7145713571608, 1178.8172833210856, 37638.43542346863, 38382.23235535288, 38594.42108368377, 38616.61383386165, 38636.420453693216, 35448.82275588618, 35492.11269718252, 35820.46269305963, 35822.64177358232, 35851.282974340495, 5474.644148130379, 5622.437756224385, 6571.605703657772, 6679.231888332855, 6687.331266873322, 6907.309269073077, 7092.680829362691, 7103.218645948941, 7105.182903966059, 7107.3603375696175, 7118.85762284754, 7144.106986626672, 7193.784186474388, 7194.460415468835, 7195.064641596611, 5469.316335458067, 5618.606697531174, 7115.39519140871, 7163.391111755481, 7168.211496735355, 5540.778368865241, 6895.0, 7086.0, 7090.07828982229, 7096.929030709678, 35758.28483430343, 36046.45930311021, 36055.4591681125, 36065.09837254063, 36136.63863361359, 3504.54440922681, 3522.119470132467, 3543.326767914114, 3543.3799085160254, 3545.131442796506, 28494.287642809097, 28507.714922850715, 28545.0, 28555.428891422056, 28572.142835714752, 3670.72469564781, 3703.962960370389, 3714.1271801126713, 3724.944125838115, 3736.953652977171, 192078.0, 192402.0, 192517.0, 192695.0, 192705.0, 40406.19187616231, 41097.79451102785, 46443.76778116155, 48677.26984095242, 48923.0, 48454.51545484571, 48657.756711216214, 48663.51336486661, 48719.75640121777, 48729.51270487321, 13790.65523361924, 13897.513587024609, 13898.58304250874, 13905.0, 13911.165330080228, 11142.220044596801, 11142.721431964104, 11146.386948717898, 11158.1631377647, 11159.49782259784, 13161.736765264832, 13261.801072983913, 13271.867281327062, 13296.800547991788, 13390.0, 5310.946890531122, 5495.285612870382, 5498.505134537911, 5521.4478552145265, 5540.750666220029, 1044.38903241603, 1084.35480888871, 1088.7604726960055, 1117.0393461622998, 1124.9381284029457, 23978.88010559936, 25334.239972800846, 25374.238772836845, 25388.111416100717, 25464.618030729554, 1172.9120315976336, 1173.677238759331, 1183.183603313728, 1183.8875306845837, 1205.7046023724245, 12554.748905022032, 13240.801387979189, 13300.933495332654, 13328.600141995756, 13375.866241337657, 217782.0, 218692.0, 220087.0, 220995.0, 221378.0, 50425.0, 50458.24312635313, 50495.0, 50522.926790249396, 50525.49474505281, 1404.108391171593, 1456.788765628978, 1505.9774103388459, 1508.3137172586446, 1514.386673397276, 23688.88155559211, 24722.876385617958, 24725.13462028892, 24830.627540586545, 25034.62448063244, 37360.81319593385, 38246.23507529889, 38305.80847095747, 38339.424908625835, 38378.61621383862, 197923.0, 197977.0, 198091.0, 198585.0, 199644.0, 28973.420531589672, 29504.409911801213, 31685.841570792, 33438.0, 33573.32853342968, 39187.608123919534, 40328.59671403249, 40896.38655420112, 41062.79468602638, 41231.7938410306, 30211.395772084874, 30486.044874131847, 30704.232394190323, 31401.37197256088, 31494.370112598077, 30071.0, 30323.393532129674, 30772.230694232825, 30975.69024309728, 31367.0, 33621.3275734479, 34636.0, 35066.47400288947, 35283.294334113685, 35479.46780798342, 28659.856700716362, 29125.708742913146, 29313.85343073271, 30083.3983320328, 30301.848490757406, 23262.76737232606, 24530.386740331636, 24661.87669061643, 24734.25797226086, 25158.74841251564], "value": 16377.72143482135, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.8502938941978, 436.4805881001608, 438.7499125498467, 442.4381036084173, 456.94059772229605, 19643.017849107542, 20135.39593812188, 20240.493987650298, 20450.284240051602, 20482.38552843417, 21153.0, 21978.0, 22402.32793016208, 22585.0, 22812.429689257777, 5318.335208098997, 5447.945520544803, 5463.125899856024, 5470.17947307903, 5471.37079235887, 5215.582753379739, 5478.287822583058, 5513.09034009388, 5518.310211223597, 5530.087535556629, 5476.863078423032, 5488.4785945335325, 5488.670679759207, 5491.395946445888, 5495.258140151069, 5339.8398048058425, 5454.7272636368025, 5482.23248745176, 5488.1493368527945, 5488.4237155098535, 4958.504149585049, 4971.801127954877, 4981.427135879348, 4981.576565991895, 4981.750912454363, 25346.746532534624, 26059.0, 26118.694065296848, 26209.0, 26352.868235658698, 2096.402525280303, 2097.4127244371603, 2139.5720855828895, 2139.818115460172, 2141.2612648636195, 16300.510984670478, 16524.339026438927, 16813.91593042027, 16850.915745421316, 16980.83019169805, 2167.26313053561, 2225.9888700556394, 2248.4940888300166, 2260.5139894922672, 2264.7055882735303, 108708.60364457867, 112952.87047129506, 113127.43436282848, 113161.43419282851, 114420.4278978608, 12018.819717704242, 12254.326012069421, 12532.436040378205, 12738.808917866054, 12793.168444051107, 17541.0, 17635.206415711324, 17675.646487070444, 17707.73438398425, 17710.380136695152, 8376.371772117116, 8728.825423491495, 8820.162084601952, 8821.073787252375, 8885.200331970025, 7956.5226086435, 8016.959915200387, 8030.63862126194, 8219.465734727224, 8254.42219044673, 7827.9608601956625, 7868.875403640985, 7984.840303193903, 8050.235227653364, 8139.877901831477, 2272.307500311993, 2307.1924826310656, 2321.97678023221, 2326.3718795925006, 2429.149797570836, 1034.384541197986, 1068.2468859454066, 1069.3476979042778, 1072.4905669806778, 1073.683263437288, 22666.66000010001, 23433.88283058574, 25183.622245665963, 25525.74474255271, 25638.230853074063, 1070.2561719604955, 1073.4632683658172, 1076.6016573867719, 1079.384750692098, 1081.0972837680467, 11279.605213817476, 11554.826677599844, 11630.418479076012, 11721.531138754524, 11825.467853946593, 514012.0, 517945.0, 519188.0, 536671.0, 546841.0, 98967.50516247372, 99385.0, 101436.49281753691, 101533.0, 101565.0, 1191.4817054581285, 1247.4012474012343, 1281.7885048966816, 1291.5092264939262, 1296.1251155470209, 19978.800211997695, 20056.398308050782, 20824.271150510267, 20832.791672083084, 20850.47873803167, 45620.29746281715, 46008.769956151344, 46416.0, 46530.767346163055, 47603.76198118987, 59084.0, 60269.397306028135, 60326.396736032075, 60581.69709151426, 61597.38402615916, 9607.471589062668, 9798.216142708423, 9931.106200441995, 9975.60097596088, 10106.848397274194, 14838.18389988561, 15511.146886921328, 15512.146831924352, 15559.988600740915, 15617.219139042774, 12988.220706757626, 13315.0, 13387.330633468093, 13435.596932092052, 13671.79492307636, 12137.817932731192, 12355.69110772238, 12408.0, 12560.37198140071, 13024.934875325564, 13259.0, 13292.800607991081, 13364.599062028155, 13383.19700817954, 13575.456981721016, 9616.567254473426, 9762.75593110178, 9824.214062875095, 9902.207823374258, 10018.499075046073, 12432.0, 13049.804252936403, 13264.602061938158, 13414.597562073153, 13527.526536571173], "value": 10327.990988078187, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1198.3648666206914, 1316.2168509736707, 1384.5015794314045, 1392.338639146405, 1406.0368647476475, 9612.951935240322, 10621.46892655367, 11220.551177952882, 11238.831417528723, 11244.156688248373, 10800.433937079119, 10933.398663073527, 10944.781104377927, 10949.890501094987, 10953.068989135932, 2001.3695685858982, 2399.976000239997, 2440.0, 2441.7680320369627, 2444.8899799509063, 2033.3594917600908, 2052.733144691188, 2054.60962417141, 2342.754010828864, 2413.2036427978724, 2376.536575367804, 2389.0563227525117, 2389.1279682915697, 2389.163792672568, 2391.868447235401, 2267.841251112423, 2302.654601809725, 2303.8387312888103, 2309.168699268262, 2314.837961342707, 2246.584381889356, 2271.761465046163, 2278.874661893595, 2280.293109136173, 2290.633498640226, 10445.164386849034, 10508.2644214905, 10513.52689128991, 10521.210909181842, 10572.312799667998, 6019.337872833985, 6157.107219453154, 6171.814845554641, 6204.224471941007, 6213.5339849511465, 3627.6009638939695, 3689.797061161635, 3782.0, 3951.7036222283446, 3956.56477787446, 1184.538030168235, 1194.5341316886422, 1258.6538701857062, 1263.9368031598383, 1277.3613193403298, 16148.596285092966, 16223.432179873647, 16225.675486490321, 16250.349986000545, 16253.18734063304, 5192.558632516203, 5327.573794096463, 5476.289236827795, 5545.251391062236, 5549.556035517149, 13369.064165508516, 13398.464061437628, 13463.932680336731, 13503.324833758274, 13512.0, 6255.40573645503, 6265.122882796412, 6273.529485288622, 6276.121343011982, 6281.246250449975, 5563.054280772279, 5668.319801623749, 5692.6015178937905, 5747.827565172968, 5774.48029677331, 4036.2129384769687, 4228.344606585984, 4443.755593442327, 4585.082983403266, 4603.332516785047, 1351.1690310458996, 1413.6253892718232, 1418.269591160553, 1420.08404579048, 1424.3234463629901, 826.3389288569241, 833.4457585705438, 849.6219182463868, 853.5220276645099, 883.0771843423638, 6005.159277701126, 6050.9394906050375, 6138.6623735694075, 6140.95603747364, 6219.253689557282, 874.5539774714814, 909.7043460875242, 955.159459675495, 963.9277054220961, 990.3265779270165, 4088.468499095158, 4113.8971525712095, 4297.8495752648505, 4377.9781101094295, 4467.865964021084, 13501.0, 14049.367778449994, 14065.71868562623, 14085.295735213404, 14094.365753541115, 13784.724305514033, 14037.649058773612, 14154.36305366261, 14159.85840141606, 14217.36021879018, 9081.728558001885, 9119.133682300171, 9198.0, 9280.489573073412, 9294.86057709135, 6244.313125556276, 6273.309935906956, 6330.493560515056, 6377.043443483329, 6508.479321654351, 12490.313032783284, 12661.493540258654, 12672.239665620093, 12844.0, 12954.80567791465, 12737.808932866199, 13043.478260869839, 13222.603321900358, 13231.933840330737, 13265.403056862657, 9073.364864459425, 9185.632574697205, 9211.677591284273, 9253.306002050007, 9262.212711919292, 9132.954335228282, 9879.0, 10354.1198998083, 10354.585816567253, 10448.373097614167, 8834.204921557091, 8862.20240178387, 8917.242034427147, 9022.909770902206, 9065.048169942062, 8441.788955276168, 8616.913830861611, 8660.740177794676, 8797.648094076421, 8974.967878693773, 7306.634668266672, 7429.07136607924, 7433.145188303414, 7436.628168591441, 7440.404767618469, 5434.402215756185, 5438.891222175614, 5542.7782888685615, 5589.301337332833, 5656.43435656431, 5716.54267658578, 5738.626989245686, 5751.597388182787, 5841.065429531254, 5850.444207800252], "value": 5184.943331183246, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.0748910104848, 391.86872397746754, 392.32128417837123, 392.3584938625348, 397.7692938095904, 5766.596338256319, 5810.651360918338, 5835.153902684114, 5838.883222335551, 5842.853928651786, 5251.763670634821, 5688.108226924841, 5714.742836572354, 5756.136579513075, 5757.280339957505, 4571.47428045774, 4571.839985600504, 4579.885502862438, 4580.1984652685815, 4600.309953506984, 4593.127305811885, 4601.260701477484, 4609.838655647053, 4617.46899106602, 4620.099080679269, 4512.0975804839, 4562.315652652095, 4578.992621623238, 4593.885152871188, 4619.8152073917, 4544.636429085665, 4550.908981820362, 4555.954440455586, 4558.977205113986, 4563.748993805356, 4140.6729967184365, 4155.688323375729, 4156.91686166278, 4162.91674166515, 4168.416421700964, 5547.140193270009, 5625.71871406428, 5660.688662123582, 5684.9147262790675, 5696.8006119785605, 5359.866003349947, 5377.354717433933, 5382.111951527993, 5382.973085134549, 5399.865003374908, 6021.63870167787, 6147.815565533041, 6156.692165391757, 6158.7228574714245, 6175.783847565313, 4628.861134165981, 4632.212523870916, 4634.420697412824, 4641.141388843075, 4660.883477913046, 6151.323354431009, 6338.144350512668, 6345.365463453664, 6349.904751428732, 6354.205724284465, 4545.863624091283, 4566.680332376702, 4566.725996440225, 4755.310479980383, 4787.904241915142, 4885.218365061573, 4905.705657660552, 4918.336024636628, 4923.113839508851, 4946.4064312282035, 5254.789808407697, 5410.161424979135, 5423.430539793344, 5428.018773147773, 5466.535344495683, 6212.782552610637, 6230.688465576703, 6243.219597550306, 6243.531735119885, 6247.781327653601, 1684.991575042117, 1702.540314115182, 1721.0878234535467, 1721.4061148903609, 1723.8534724548304, 1185.4369174641977, 1192.1893112683458, 1194.7192409783695, 1211.7213041000618, 1217.4704003758393, 5896.410358964069, 5906.8818623627285, 5922.615030023035, 5923.407659234128, 5934.109883517421, 6145.784897528565, 6242.531810114259, 6343.619382837044, 6348.841278968062, 6362.554621176473, 5884.617499862496, 5897.174395584621, 5904.132793020578, 5904.261967254093, 5909.793157239476, 3239.49787782894, 3304.438245498223, 3335.466325387975, 3341.5655964724915, 3348.547946027304, 6565.818152732554, 6578.703958321791, 6652.467802575782, 6657.434118100015, 6678.3655552723385, 6477.546571739933, 6507.837304067341, 6510.934890651033, 6520.869582608321, 6534.0, 6418.1656384669695, 6532.902006470002, 6539.738410463623, 6583.0, 6613.338666133348, 6247.718852651732, 6273.215848018997, 6302.779402720883, 6313.1477250572425, 6315.368463153832, 5971.641701497924, 6184.226971628546, 6195.482106883662, 6239.377761782061, 6264.684416272452, 6303.338149494237, 6401.487880969418, 6414.230292364759, 6419.716056788568, 6435.517336199898, 4742.834000809955, 4785.210440277455, 4804.495527969652, 4808.2787581863, 4828.37231159947, 6131.570790044654, 6231.937680623136, 6261.123442718114, 6267.780627678009, 6270.372962703693, 5950.523958083257, 5975.103734439869, 5980.760769569342, 5983.132445795248, 6023.0, 5954.255718035246, 6023.0, 6034.728437220423, 6066.272047354169, 6080.939190608215, 6065.787697430569, 6067.211262535842, 6081.6924361262545, 6092.268927728701, 6101.664408457577, 5882.088276317178, 6053.969730151321, 6077.696115194134, 6090.665013424127, 6091.5126789857595, 5892.970535147297, 5906.734196961061, 5970.940290597212, 5971.820845374646, 5972.820815375546], "value": 4757.381821953663, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [870.2776695342866, 877.548062747685, 887.8313120507103, 889.2796834564006, 890.4167770110572, 16885.24016419261, 17007.82992170078, 17335.653286934255, 17359.82640173598, 17375.218115184816, 16481.67036659266, 16602.83397166028, 16813.495595132135, 16838.494845154633, 16888.07115608641, 1005.5977608956421, 1017.5166795771986, 1021.9897801022006, 1027.8201314769922, 1031.649239258652, 1032.0917592518574, 1034.1726618705043, 1034.255336157965, 1035.0270745499206, 1035.0684384054337, 1075.779465209634, 1077.3966578715906, 1077.6874706335154, 1079.034264333421, 1086.239632257419, 1070.4380200394817, 1071.3518321415547, 1076.1928553584812, 1076.8976947190004, 1082.2045796339685, 794.4994653368399, 797.5972134072315, 797.7048492057976, 798.8002999250187, 799.2686691677109, 15390.3074361654, 15796.842031579652, 15937.20313984296, 16219.51341459758, 16306.673866522722, 14813.18527480988, 14889.0, 15032.549023529311, 15138.697226055527, 15228.771568426482, 13569.660758481019, 13730.588082357544, 13732.0, 13864.376103075387, 13949.232792196424, 3435.12404336895, 3436.896893093211, 3463.1515278756615, 3470.3059388122224, 3474.4788281757687, 64989.99999999953, 82673.17326826775, 84275.0, 84577.57711211467, 85493.57253213756, 14455.927720361542, 14702.852971470362, 14977.326020329112, 15005.099694018394, 15023.924880375747, 25328.746712533008, 25389.11138110157, 25396.0, 25507.36231594225, 25726.48547029049, 8355.874661880076, 8380.036295825936, 8390.0, 8406.873896891551, 8450.19723126302, 3874.5544262410185, 3956.5054368203973, 3960.7623542587535, 3968.761874287552, 3968.7817170055346, 4221.409002739619, 4259.595338442843, 4270.0605866709275, 4299.742015479082, 4300.634446072119, 807.4347956430522, 838.4591938199827, 839.5969934431507, 846.1834329871581, 847.631280393031, 725.3689290317458, 731.7438896386328, 743.4498471131324, 754.4379437319122, 773.0221270093336, 10866.61966831157, 11314.208005439705, 11782.234154779911, 11801.822972655416, 11912.106592005634, 735.8344372516248, 748.3975399803211, 748.7267147491235, 750.6809605917463, 765.3456294867808, 5359.812406565751, 5414.7004718867975, 5556.583256255716, 5587.8603034923635, 5712.942870571241, 84620.0, 84833.15166848376, 86147.5692621533, 86148.0, 87457.56271218731, 71428.2857171432, 73230.2676973234, 73385.63307183537, 75595.24404755991, 75702.24297756952, 62626.37373626297, 64236.67881660655, 64256.67871660705, 64324.356756432775, 66919.66540167366, 10809.513571889127, 11277.32336059839, 11343.319400835977, 11384.14618903602, 11390.145739069769, 34499.137521561155, 34534.48198277078, 34827.47758783671, 35421.103678594816, 35436.0, 41932.16135677331, 42478.0, 42721.57278427176, 42918.141637167704, 43783.78108109439, 14235.217063061631, 14308.141511509342, 14411.495597654031, 14599.0, 14650.926745366205, 16780.32878684839, 16926.830731692524, 17157.82842171562, 17183.484495465156, 17520.211590478713, 15567.84432155664, 15831.762523562385, 15859.52421427359, 15860.127692976997, 15916.68166636684, 15044.247787610357, 15315.234238288263, 15532.534023979299, 15573.0, 15714.449994250146, 15768.526944191693, 15768.842311577197, 16019.359225630844, 16131.919340403223, 16318.1025043619, 10940.726481838017, 11028.613998510014, 11115.555377784798, 11262.943685281522, 11473.713157170803, 11865.703357416134, 12340.691482713004, 12349.135560510678, 12371.381430928597, 12480.750384992069], "value": 8004.567991816505, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1476.0999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 108.0, 109.0, 109.0, 107.0, 110.0, 108.0, 109.0, 109.0, 109.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 117.0, 124.0, 162.0, 118.0, 119.0, 119.0, 117.0, 140.0, 117.0], "value": 127.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 163.0, 161.0, 164.0, 161.0, 161.0, 163.0, 161.0, 162.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 112.0, 75.0, 73.0, 74.0, 75.0, 97.0, 74.0], "value": 80.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 110.0, 83.0, 84.0, 82.0, 94.0, 82.0, 82.0, 109.0], "value": 89.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 114.0, 114.0, 114.0], "value": 113.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 93.0, 93.0, 94.0, 94.0, 94.0, 94.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 47.0, 48.0, 46.0, 47.0, 47.0, 48.0, 47.0, 48.0, 46.0], "value": 47.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 53.0, 54.0, 53.0, 53.0, 54.0, 55.0, 55.0, 55.0], "value": 54.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 80.0, 78.0, 85.0, 78.0, 77.0, 79.0, 80.0, 80.0, 77.0], "value": 79.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 124.0, 123.0, 123.0, 122.0, 123.0, 121.0, 122.0, 168.0, 122.0], "value": 128.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 182.0, 181.0, 184.0, 178.0, 183.0, 169.0, 177.0, 183.0, 183.0], "value": 180.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 68.0, 63.0, 64.0, 65.0, 68.0, 66.0, 64.0, 65.0], "value": 65.3, "unit": "score"}]}]} 18:02:52 INFO - Return code: 0 18:02:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:02:52 INFO - # TBPL SUCCESS # 18:02:52 INFO - Running post-action listener: _resource_record_post_action 18:02:52 INFO - [mozharness: 2017-05-12 01:02:52.929345Z] Finished run-tests step (success) 18:02:52 INFO - Running post-run listener: _resource_record_post_run 18:02:52 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 380424192; Read time: 12; Write time: 233168 18:02:52 INFO - TinderboxPrint: CPU usage
12.9% 18:02:52 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 18:02:52 INFO - TinderboxPrint: I/O write bytes / time
380,424,192 / 233,168 18:02:52 INFO - TinderboxPrint: CPU idle
8,276.4 (87.1%) 18:02:52 INFO - TinderboxPrint: CPU user
1,187.2 (12.5%) 18:02:52 INFO - TinderboxPrint: Swap in / out
0 / 0 18:02:52 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 111878144; Read time: 0; Write time: 82560 18:02:53 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 268546048; Read time: 0; Write time: 150608 18:02:53 INFO - Running post-run listener: _upload_blobber_files 18:02:53 INFO - Blob upload gear active. 18:02:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:02:53 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:02:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:02:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:02:53 INFO - (blobuploader) - INFO - Open directory for files ... 18:02:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:02:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:02:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:02:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:02:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:02:54 INFO - (blobuploader) - INFO - Done attempting. 18:02:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:02:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:02:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:02:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:02:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:02:55 INFO - (blobuploader) - INFO - Done attempting. 18:02:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:02:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:02:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:02:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:02:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:02:59 INFO - (blobuploader) - INFO - Done attempting. 18:02:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:02:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:02:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:03:00 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:03:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:03:00 INFO - (blobuploader) - INFO - Done attempting. 18:03:00 INFO - (blobuploader) - INFO - Iteration through files over. 18:03:00 INFO - Return code: 0 18:03:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:03:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:03:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a273508a9ed4e20df26b913eeeeff3cbe7d35203157bb29d7fb3408a890541379aba7515b1f00386903e7973ebf709ac72aa4e545e425d23049463e311fea0d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba2b2a8d82e4589bf328a3a44fab46d3e52a51984ca4ef842fa8cb257c29725d25c63ed6e568ddcf4cf5a3403134afecebe8ab94717aaa950617ed4e01c1c6f4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7dc5f08c0fe27ee2e8a4be4f260e946fd207883ca811373b19db3a9abff3ca2b8888acb5e56ca575e6762efacafb15b4ba9bfe096607b0c5dddaca18e9045220", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d297f53cf421517b6825c8c8458594567461c19b6645cee6f2e4c6e232499c16789adbc81e9a84c66f6a332ac5deb90a6a76e13e55d13399ec217a2b678006ca"} 18:03:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:03:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:03:00 INFO - Contents: 18:03:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a273508a9ed4e20df26b913eeeeff3cbe7d35203157bb29d7fb3408a890541379aba7515b1f00386903e7973ebf709ac72aa4e545e425d23049463e311fea0d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba2b2a8d82e4589bf328a3a44fab46d3e52a51984ca4ef842fa8cb257c29725d25c63ed6e568ddcf4cf5a3403134afecebe8ab94717aaa950617ed4e01c1c6f4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7dc5f08c0fe27ee2e8a4be4f260e946fd207883ca811373b19db3a9abff3ca2b8888acb5e56ca575e6762efacafb15b4ba9bfe096607b0c5dddaca18e9045220", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d297f53cf421517b6825c8c8458594567461c19b6645cee6f2e4c6e232499c16789adbc81e9a84c66f6a332ac5deb90a6a76e13e55d13399ec217a2b678006ca"} 18:03:00 INFO - Running post-run listener: copy_logs_to_upload_dir 18:03:00 INFO - Copying logs to upload dir... 18:03:00 INFO - mkdir: /builds/slave/test/build/upload/logs 18:03:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.622537 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-05-11 18:02:59.584946) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-11 18:02:59.589688) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1494549732.339517-1433854511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a273508a9ed4e20df26b913eeeeff3cbe7d35203157bb29d7fb3408a890541379aba7515b1f00386903e7973ebf709ac72aa4e545e425d23049463e311fea0d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba2b2a8d82e4589bf328a3a44fab46d3e52a51984ca4ef842fa8cb257c29725d25c63ed6e568ddcf4cf5a3403134afecebe8ab94717aaa950617ed4e01c1c6f4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7dc5f08c0fe27ee2e8a4be4f260e946fd207883ca811373b19db3a9abff3ca2b8888acb5e56ca575e6762efacafb15b4ba9bfe096607b0c5dddaca18e9045220", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d297f53cf421517b6825c8c8458594567461c19b6645cee6f2e4c6e232499c16789adbc81e9a84c66f6a332ac5deb90a6a76e13e55d13399ec217a2b678006ca"} build_url:https://queue.taskcluster.net/v1/task/EgneG4LHTiSiS4iuGGWyDQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011170 build_url: 'https://queue.taskcluster.net/v1/task/EgneG4LHTiSiS4iuGGWyDQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a273508a9ed4e20df26b913eeeeff3cbe7d35203157bb29d7fb3408a890541379aba7515b1f00386903e7973ebf709ac72aa4e545e425d23049463e311fea0d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba2b2a8d82e4589bf328a3a44fab46d3e52a51984ca4ef842fa8cb257c29725d25c63ed6e568ddcf4cf5a3403134afecebe8ab94717aaa950617ed4e01c1c6f4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7dc5f08c0fe27ee2e8a4be4f260e946fd207883ca811373b19db3a9abff3ca2b8888acb5e56ca575e6762efacafb15b4ba9bfe096607b0c5dddaca18e9045220", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d297f53cf421517b6825c8c8458594567461c19b6645cee6f2e4c6e232499c16789adbc81e9a84c66f6a332ac5deb90a6a76e13e55d13399ec217a2b678006ca"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-11 18:02:59.617365) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 18:02:59.617659) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1494549732.339517-1433854511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004456 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 18:02:59.700013) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-11 18:02:59.703349) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-11 18:02:59.703657) ========= ========= Total master_lag: 0.21 =========