builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-021 starttime: 1494600820.44 results: success (0) revision: 1ec1d88637208098802e57d13db9033902e5a229 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-12 07:53:40.439384) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-12 07:53:40.439944) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-12 07:53:40.440317) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-12 07:53:40.453402) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 07:53:40.453723) ========= 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=df17445c3590ff7897617a0e00000225-1494600819.515925-727620629 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-12 07:53:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.5M=0s 2017-05-12 07:53:40 (42.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.174762 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 07:53:40.639998) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 07:53:40.640330) ========= 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=df17445c3590ff7897617a0e00000225-1494600819.515925-727620629 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014297 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 07:53:40.692356) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 07:53:40.692708) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1ec1d88637208098802e57d13db9033902e5a229 --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 1ec1d88637208098802e57d13db9033902e5a229 --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=df17445c3590ff7897617a0e00000225-1494600819.515925-727620629 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-12 07:53:41,051 truncating revision to first 12 chars 2017-05-12 07:53:41,051 Setting DEBUG logging. 2017-05-12 07:53:41,051 attempt 1/10 2017-05-12 07:53:41,051 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1ec1d8863720?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-12 07:53:41,352 unpacking tar archive at: mozilla-central-1ec1d8863720/testing/mozharness/ program finished with exit code 0 elapsedTime=0.658038 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 07:53:41.366905) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-12 07:53:41.367249) ========= script_repo_revision: 1ec1d88637208098802e57d13db9033902e5a229 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-12 07:53:41.367647) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-12 07:53:41.367915) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-12 07:53:41.377919) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-05-12 07:53:41.378311) ========= /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=df17445c3590ff7897617a0e00000225-1494600819.515925-727620629 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:53:41 INFO - MultiFileLogger online at 20170512 07:53:41 in /builds/slave/test 07:53:41 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 07:53:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:53:41 INFO - {'append_to_log': False, 07:53:41 INFO - 'base_work_dir': '/builds/slave/test', 07:53:41 INFO - 'blob_upload_branch': 'Firefox', 07:53:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:53:41 INFO - 'branch': 'Firefox', 07:53:41 INFO - 'buildbot_json_path': 'buildprops.json', 07:53:41 INFO - 'config_files': ('talos/linux_config.py',), 07:53:41 INFO - 'default_actions': ('clobber', 07:53:41 INFO - 'read-buildbot-config', 07:53:41 INFO - 'download-and-extract', 07:53:41 INFO - 'populate-webroot', 07:53:41 INFO - 'create-virtualenv', 07:53:41 INFO - 'install', 07:53:41 INFO - 'run-tests'), 07:53:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:53:41 INFO - 'download_minidump_stackwalk': True, 07:53:41 INFO - 'download_symbols': 'ondemand', 07:53:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:53:41 INFO - 'tooltool.py': '/tools/tooltool.py', 07:53:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:53:41 INFO - '/tools/misc-python/virtualenv.py')}, 07:53:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:53:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:53:41 INFO - 'gecko_profile': False, 07:53:41 INFO - 'gecko_profile_interval': 0, 07:53:41 INFO - 'installer_path': 'installer.exe', 07:53:41 INFO - 'log_level': 'info', 07:53:41 INFO - 'log_name': 'talos', 07:53:41 INFO - 'log_to_console': True, 07:53:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:53:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:53:41 INFO - 'opt_config_files': (), 07:53:41 INFO - 'pip_index': False, 07:53:41 INFO - 'suite': 'dromaeojs', 07:53:41 INFO - 'system_bits': '32', 07:53:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:53:41 INFO - 'title': 'talos-linux64-ix-021', 07:53:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:53:41 INFO - 'use_talos_json': True, 07:53:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:53:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:53:41 INFO - 'work_dir': 'build'} 07:53:41 INFO - [mozharness: 2017-05-12 14:53:41.839274Z] Running clobber step. 07:53:41 INFO - Running pre-action listener: _resource_record_pre_action 07:53:41 INFO - Running main action method: clobber 07:53:41 INFO - rmtree: /builds/slave/test/build 07:53:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:53:42 INFO - Running post-action listener: _resource_record_post_action 07:53:42 INFO - [mozharness: 2017-05-12 14:53:42.860748Z] Finished clobber step (success) 07:53:42 INFO - [mozharness: 2017-05-12 14:53:42.860849Z] Running read-buildbot-config step. 07:53:42 INFO - Running pre-action listener: _resource_record_pre_action 07:53:42 INFO - Running main action method: read_buildbot_config 07:53:42 INFO - Using buildbot properties: 07:53:42 INFO - { 07:53:42 INFO - "project": "", 07:53:42 INFO - "product": "firefox", 07:53:42 INFO - "who": "cbook@mozilla.com", 07:53:42 INFO - "installer_path": "public/build/target.tar.bz2", 07:53:42 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:53:42 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 07:53:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 07:53:42 INFO - "stage_platform": "linux64-pgo", 07:53:42 INFO - "basedir": "/builds/slave/test", 07:53:42 INFO - "buildnumber": 178, 07:53:42 INFO - "platform": "ubuntu64_hw", 07:53:42 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:53:42 INFO - "slavebuilddir": "test", 07:53:42 INFO - "taskId": "UvZ_Ea-9SwGWggNwweiZQw", 07:53:42 INFO - "branch": "mozilla-central", 07:53:42 INFO - "script_repo_revision": "production", 07:53:42 INFO - "revision": "1ec1d88637208098802e57d13db9033902e5a229", 07:53:42 INFO - "slavename": "talos-linux64-ix-021", 07:53:42 INFO - "repo_path": "mozilla-central" 07:53:42 INFO - } 07:53:42 INFO - Finding installer, test and symbols from parent task. 07:53:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UvZ_Ea-9SwGWggNwweiZQw'}, attempt #1 07:53:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UvZ_Ea-9SwGWggNwweiZQw'}, attempt #1 07:53:43 INFO - Task dependencies: KI_iaByYSeeSOnxUNs4HQA 07:53:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KI_iaByYSeeSOnxUNs4HQA'}, attempt #1 07:53:44 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/KI_iaByYSeeSOnxUNs4HQA/artifacts/public/build/target.tar.bz2 07:53:44 INFO - Set test_url: https://queue.taskcluster.net/v1/task/KI_iaByYSeeSOnxUNs4HQA/artifacts/public/build/test_packages.json 07:53:44 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/KI_iaByYSeeSOnxUNs4HQA/artifacts/public/build/target.crashreporter-symbols.zip 07:53:44 INFO - Running post-action listener: _resource_record_post_action 07:53:44 INFO - [mozharness: 2017-05-12 14:53:44.251855Z] Finished read-buildbot-config step (success) 07:53:44 INFO - [mozharness: 2017-05-12 14:53:44.252074Z] Running download-and-extract step. 07:53:44 INFO - Running pre-action listener: _resource_record_pre_action 07:53:44 INFO - Running main action method: download_and_extract 07:53:44 INFO - mkdir: /builds/slave/test/build/tests 07:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:53:44 INFO - trying https://queue.taskcluster.net/v1/task/KI_iaByYSeeSOnxUNs4HQA/artifacts/public/build/target.test_packages.json 07:53:44 INFO - Downloading https://queue.taskcluster.net/v1/task/KI_iaByYSeeSOnxUNs4HQA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:53:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KI_iaByYSeeSOnxUNs4HQA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:53:44 INFO - Downloaded 986 bytes. 07:53:44 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:53:44 INFO - Using the following test package requirements: 07:53:44 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:53:44 INFO - u'common': [u'target.common.tests.zip'], 07:53:44 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:53:44 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:53:44 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:53:44 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:53:44 INFO - u'mozbase': [u'target.common.tests.zip'], 07:53:44 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:53:44 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:53:44 INFO - u'web-platform': [u'target.common.tests.zip', 07:53:44 INFO - u'target.web-platform.tests.zip'], 07:53:44 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:53:44 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 07:53:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KI_iaByYSeeSOnxUNs4HQA/artifacts/public/build/target.common.tests.zip 07:53:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KI_iaByYSeeSOnxUNs4HQA/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:53:44 INFO - Fetch https://queue.taskcluster.net/v1/task/KI_iaByYSeeSOnxUNs4HQA/artifacts/public/build/target.common.tests.zip into memory 07:53:45 INFO - Content-Length response header: 64596443 07:53:45 INFO - Bytes received: 64596443 07:53:57 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 07:53:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KI_iaByYSeeSOnxUNs4HQA/artifacts/public/build/target.common.tests.zip 07:53:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KI_iaByYSeeSOnxUNs4HQA/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:53:57 INFO - Fetch https://queue.taskcluster.net/v1/task/KI_iaByYSeeSOnxUNs4HQA/artifacts/public/build/target.common.tests.zip into memory 07:53:58 INFO - Content-Length response header: 64596443 07:53:58 INFO - Bytes received: 64596443 07:54:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KI_iaByYSeeSOnxUNs4HQA/artifacts/public/build/target.talos.tests.zip 07:54:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KI_iaByYSeeSOnxUNs4HQA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:54:10 INFO - Fetch https://queue.taskcluster.net/v1/task/KI_iaByYSeeSOnxUNs4HQA/artifacts/public/build/target.talos.tests.zip into memory 07:54:11 INFO - Content-Length response header: 14409411 07:54:11 INFO - Bytes received: 14409411 07:54:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:12 INFO - trying https://queue.taskcluster.net/v1/task/KI_iaByYSeeSOnxUNs4HQA/artifacts/public/build/target.tar.bz2 07:54:12 INFO - Downloading https://queue.taskcluster.net/v1/task/KI_iaByYSeeSOnxUNs4HQA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:54:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KI_iaByYSeeSOnxUNs4HQA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:54:13 INFO - Downloaded 68625662 bytes. 07:54:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KI_iaByYSeeSOnxUNs4HQA/artifacts/public/build/target.tar.bz2 07:54:13 INFO - mkdir: /builds/slave/test/properties 07:54:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:54:13 INFO - Writing to file /builds/slave/test/properties/build_url 07:54:13 INFO - Contents: 07:54:13 INFO - build_url:https://queue.taskcluster.net/v1/task/KI_iaByYSeeSOnxUNs4HQA/artifacts/public/build/target.tar.bz2 07:54:13 INFO - Running post-action listener: _resource_record_post_action 07:54:13 INFO - Running post-action listener: set_extra_try_arguments 07:54:13 INFO - [mozharness: 2017-05-12 14:54:13.311077Z] Finished download-and-extract step (success) 07:54:13 INFO - [mozharness: 2017-05-12 14:54:13.311176Z] Running populate-webroot step. 07:54:13 INFO - Running pre-action listener: _resource_record_pre_action 07:54:13 INFO - Running main action method: populate_webroot 07:54:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:54:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:54:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:54:13 INFO - '--tppagecycles', 07:54:13 INFO - '7'], 07:54:13 INFO - 'tests': ['tsvgm']}}, 07:54:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:54:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:54:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:54:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:54:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:54:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:54:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:54:13 INFO - 'talos_options': ['--disable-e10s'], 07:54:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:54:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:54:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:54:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:54:13 INFO - 'talos_options': ['--disable-e10s'], 07:54:13 INFO - 'tests': ['damp', 'tps']}, 07:54:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:54:13 INFO - 'tests': ['damp', 'tps']}, 07:54:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:54:13 INFO - 'tests': ['dromaeo_dom']}, 07:54:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:54:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:54:13 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 07:54:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 07:54:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:54:13 INFO - 'tests': ['a11yr', 07:54:13 INFO - 'ts_paint', 07:54:13 INFO - 'tpaint', 07:54:13 INFO - 'sessionrestore', 07:54:13 INFO - 'sessionrestore_no_auto_restore', 07:54:13 INFO - 'tabpaint']}, 07:54:13 INFO - 'other-e10s': {'tests': ['a11yr', 07:54:13 INFO - 'ts_paint', 07:54:13 INFO - 'tpaint', 07:54:13 INFO - 'sessionrestore', 07:54:13 INFO - 'sessionrestore_no_auto_restore', 07:54:13 INFO - 'tabpaint']}, 07:54:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:54:13 INFO - 'ts_paint', 07:54:13 INFO - 'tpaint', 07:54:13 INFO - 'sessionrestore', 07:54:13 INFO - 'sessionrestore_no_auto_restore', 07:54:13 INFO - 'tabpaint']}, 07:54:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:54:13 INFO - 'ts_paint', 07:54:13 INFO - 'tpaint', 07:54:13 INFO - 'sessionrestore', 07:54:13 INFO - 'sessionrestore_no_auto_restore', 07:54:13 INFO - 'tabpaint']}, 07:54:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:54:13 INFO - 'tests': ['a11yr', 07:54:13 INFO - 'ts_paint', 07:54:13 INFO - 'tpaint', 07:54:13 INFO - 'sessionrestore', 07:54:13 INFO - 'sessionrestore_no_auto_restore', 07:54:13 INFO - 'tabpaint']}, 07:54:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:54:13 INFO - 'tests': ['a11yr', 07:54:13 INFO - 'ts_paint', 07:54:13 INFO - 'tpaint', 07:54:13 INFO - 'sessionrestore', 07:54:13 INFO - 'sessionrestore_no_auto_restore', 07:54:13 INFO - 'tabpaint']}, 07:54:13 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 07:54:13 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 07:54:13 INFO - 'bloom_basic_ref']}, 07:54:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:54:13 INFO - 'tests': ['tsvgx', 07:54:13 INFO - 'tsvgr_opacity', 07:54:13 INFO - 'tart', 07:54:13 INFO - 'tscrollx', 07:54:13 INFO - 'cart', 07:54:13 INFO - 'tsvg_static']}, 07:54:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:54:13 INFO - 'tsvgr_opacity', 07:54:13 INFO - 'tart', 07:54:13 INFO - 'tscrollx', 07:54:13 INFO - 'cart', 07:54:13 INFO - 'tsvg_static']}, 07:54:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:54:13 INFO - 'talos_options': ['--disable-e10s'], 07:54:13 INFO - 'tests': ['tp5o']}, 07:54:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:54:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:54:13 INFO - 'talos_options': ['--disable-e10s', 07:54:13 INFO - '--xperf_path', 07:54:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:54:13 INFO - 'tests': ['tp5n']}, 07:54:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:54:13 INFO - 'talos_options': ['--xperf_path', 07:54:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:54:13 INFO - 'tests': ['tp5n']}}, 07:54:13 INFO - 'talos.zip': {'path': '', 07:54:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:54:13 INFO - Running post-action listener: _resource_record_post_action 07:54:13 INFO - [mozharness: 2017-05-12 14:54:13.324922Z] Finished populate-webroot step (success) 07:54:13 INFO - [mozharness: 2017-05-12 14:54:13.325012Z] Running create-virtualenv step. 07:54:13 INFO - Running pre-action listener: _resource_record_pre_action 07:54:13 INFO - Running main action method: create_virtualenv 07:54:13 INFO - Creating virtualenv /builds/slave/test/build/venv 07:54:13 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 07:54:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:54:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:54:13 INFO - Using real prefix '/usr' 07:54:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:54:13 INFO - Installing distribute.............................................................................................................................................................................................done. 07:54:15 INFO - Installing pip.................done. 07:54:15 INFO - Return code: 0 07:54:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:54:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:54:16 INFO - Reading from file tmpfile_stdout 07:54:16 INFO - Output received: 07:54:16 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) 07:54:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:54:16 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')]} 07:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:16 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')]} 07:54:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:16 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 0xa461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc12a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb5a30>, '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 0xdb67f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb6ca0>, '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': 'df17445c3590ff7897617a0e00000225-1494600819.515925-727620629', '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 07:54:16 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 07:54:16 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 07:54:16 INFO - Using env: {'DISPLAY': ':0', 07:54:16 INFO - 'HOME': '/home/cltbld', 07:54:16 INFO - 'LANG': 'en_US.UTF-8', 07:54:16 INFO - 'LANGUAGE': 'en_US:en', 07:54:16 INFO - 'LOGNAME': 'cltbld', 07:54:16 INFO - 'MAIL': '/var/mail/cltbld', 07:54:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:16 INFO - 'MOZ_NO_REMOTE': '1', 07:54:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:16 INFO - 'NO_EM_RESTART': '1', 07:54:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:16 INFO - 'PWD': '/builds/slave/test', 07:54:16 INFO - 'SHELL': '/bin/bash', 07:54:16 INFO - 'SHLVL': '1', 07:54:16 INFO - 'TERM': 'linux', 07:54:16 INFO - 'TMOUT': '86400', 07:54:16 INFO - 'USER': 'cltbld', 07:54:16 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1494600819.515925-727620629', 07:54:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:16 INFO - '_': '/tools/buildbot/bin/python'} 07:54:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:16 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 07:54:16 INFO - Cleaning up... 07:54:16 INFO - Return code: 0 07:54:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:54:16 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')]} 07:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:16 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')]} 07:54:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:16 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 0xa461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc12a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb5a30>, '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 0xdb67f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb6ca0>, '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': 'df17445c3590ff7897617a0e00000225-1494600819.515925-727620629', '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 07:54:16 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 07:54:16 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 07:54:16 INFO - Using env: {'DISPLAY': ':0', 07:54:16 INFO - 'HOME': '/home/cltbld', 07:54:16 INFO - 'LANG': 'en_US.UTF-8', 07:54:16 INFO - 'LANGUAGE': 'en_US:en', 07:54:16 INFO - 'LOGNAME': 'cltbld', 07:54:16 INFO - 'MAIL': '/var/mail/cltbld', 07:54:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:16 INFO - 'MOZ_NO_REMOTE': '1', 07:54:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:16 INFO - 'NO_EM_RESTART': '1', 07:54:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:16 INFO - 'PWD': '/builds/slave/test', 07:54:16 INFO - 'SHELL': '/bin/bash', 07:54:16 INFO - 'SHLVL': '1', 07:54:16 INFO - 'TERM': 'linux', 07:54:16 INFO - 'TMOUT': '86400', 07:54:16 INFO - 'USER': 'cltbld', 07:54:16 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1494600819.515925-727620629', 07:54:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:16 INFO - '_': '/tools/buildbot/bin/python'} 07:54:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:16 INFO - Downloading/unpacking psutil>=3.1.1 07:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:54:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:54:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:54:17 INFO - Installing collected packages: psutil 07:54:17 INFO - Running setup.py install for psutil 07:54:17 INFO - building 'psutil._psutil_linux' extension 07:54:17 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 07:54:17 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 07:54:17 INFO - building 'psutil._psutil_posix' extension 07:54:17 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 07:54:18 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 07:54:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:54:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:54:18 INFO - Successfully installed psutil 07:54:18 INFO - Cleaning up... 07:54:18 INFO - Return code: 0 07:54:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:54: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')]} 07:54:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54: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')]} 07:54:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xa461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc12a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb5a30>, '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 0xdb67f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb6ca0>, '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': 'df17445c3590ff7897617a0e00000225-1494600819.515925-727620629', '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 07:54:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:54:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:54:18 INFO - Using env: {'DISPLAY': ':0', 07:54:18 INFO - 'HOME': '/home/cltbld', 07:54:18 INFO - 'LANG': 'en_US.UTF-8', 07:54:18 INFO - 'LANGUAGE': 'en_US:en', 07:54:18 INFO - 'LOGNAME': 'cltbld', 07:54:18 INFO - 'MAIL': '/var/mail/cltbld', 07:54:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:18 INFO - 'MOZ_NO_REMOTE': '1', 07:54:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:18 INFO - 'NO_EM_RESTART': '1', 07:54:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:18 INFO - 'PWD': '/builds/slave/test', 07:54:18 INFO - 'SHELL': '/bin/bash', 07:54:18 INFO - 'SHLVL': '1', 07:54:18 INFO - 'TERM': 'linux', 07:54:18 INFO - 'TMOUT': '86400', 07:54:18 INFO - 'USER': 'cltbld', 07:54:18 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1494600819.515925-727620629', 07:54:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:18 INFO - '_': '/tools/buildbot/bin/python'} 07:54:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:54:18 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 07:54:18 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 07:54:18 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 07:54:18 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 07:54:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:54:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:54:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:54:19 INFO - Installing collected packages: mozsystemmonitor 07:54:19 INFO - Running setup.py install for mozsystemmonitor 07:54:19 INFO - Successfully installed mozsystemmonitor 07:54:19 INFO - Cleaning up... 07:54:19 INFO - Return code: 0 07:54:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:54:19 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')]} 07:54:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:19 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')]} 07:54:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:19 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 0xa461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc12a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb5a30>, '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 0xdb67f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb6ca0>, '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': 'df17445c3590ff7897617a0e00000225-1494600819.515925-727620629', '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 07:54:19 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 07:54:19 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 07:54:19 INFO - Using env: {'DISPLAY': ':0', 07:54:19 INFO - 'HOME': '/home/cltbld', 07:54:19 INFO - 'LANG': 'en_US.UTF-8', 07:54:19 INFO - 'LANGUAGE': 'en_US:en', 07:54:19 INFO - 'LOGNAME': 'cltbld', 07:54:19 INFO - 'MAIL': '/var/mail/cltbld', 07:54:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:19 INFO - 'MOZ_NO_REMOTE': '1', 07:54:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:19 INFO - 'NO_EM_RESTART': '1', 07:54:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:19 INFO - 'PWD': '/builds/slave/test', 07:54:19 INFO - 'SHELL': '/bin/bash', 07:54:19 INFO - 'SHLVL': '1', 07:54:19 INFO - 'TERM': 'linux', 07:54:19 INFO - 'TMOUT': '86400', 07:54:19 INFO - 'USER': 'cltbld', 07:54:19 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1494600819.515925-727620629', 07:54:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:19 INFO - '_': '/tools/buildbot/bin/python'} 07:54:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:19 INFO - Downloading/unpacking jsonschema==2.5.1 07:54:19 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 07:54:19 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 07:54:19 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 07:54:19 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 07:54:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:54:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:54:21 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 07:54:21 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 07:54:21 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 07:54:21 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 07:54:21 INFO - Downloading functools32-3.2.3-2.tar.gz 07:54:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:54:21 INFO - warning: no files found matching '*.txt' 07:54:21 INFO - no previously-included directories found matching 'build' 07:54:21 INFO - no previously-included directories found matching 'dist' 07:54:21 INFO - no previously-included directories found matching '.git*' 07:54:21 INFO - Installing collected packages: jsonschema, functools32 07:54:21 INFO - Running setup.py install for functools32 07:54:21 INFO - warning: no files found matching '*.txt' 07:54:21 INFO - no previously-included directories found matching 'build' 07:54:21 INFO - no previously-included directories found matching 'dist' 07:54:21 INFO - no previously-included directories found matching '.git*' 07:54:21 INFO - Successfully installed jsonschema functools32 07:54:21 INFO - Cleaning up... 07:54:21 INFO - Return code: 0 07:54:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:54:21 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')]} 07:54:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:21 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')]} 07:54:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:21 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 0xa461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc12a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb5a30>, '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 0xdb67f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb6ca0>, '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': 'df17445c3590ff7897617a0e00000225-1494600819.515925-727620629', '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 07:54:21 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 07:54:21 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 07:54:21 INFO - Using env: {'DISPLAY': ':0', 07:54:21 INFO - 'HOME': '/home/cltbld', 07:54:21 INFO - 'LANG': 'en_US.UTF-8', 07:54:21 INFO - 'LANGUAGE': 'en_US:en', 07:54:21 INFO - 'LOGNAME': 'cltbld', 07:54:21 INFO - 'MAIL': '/var/mail/cltbld', 07:54:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:21 INFO - 'MOZ_NO_REMOTE': '1', 07:54:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:21 INFO - 'NO_EM_RESTART': '1', 07:54:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:21 INFO - 'PWD': '/builds/slave/test', 07:54:21 INFO - 'SHELL': '/bin/bash', 07:54:21 INFO - 'SHLVL': '1', 07:54:21 INFO - 'TERM': 'linux', 07:54:21 INFO - 'TMOUT': '86400', 07:54:21 INFO - 'USER': 'cltbld', 07:54:21 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1494600819.515925-727620629', 07:54:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:21 INFO - '_': '/tools/buildbot/bin/python'} 07:54:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:54:21 INFO - Cleaning up... 07:54:21 INFO - Return code: 0 07:54:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:54:21 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')]} 07:54:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:21 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')]} 07:54:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:21 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 0xa461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc12a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb5a30>, '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 0xdb67f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb6ca0>, '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': 'df17445c3590ff7897617a0e00000225-1494600819.515925-727620629', '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 07:54:21 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 07:54:21 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 07:54:21 INFO - Using env: {'DISPLAY': ':0', 07:54:21 INFO - 'HOME': '/home/cltbld', 07:54:21 INFO - 'LANG': 'en_US.UTF-8', 07:54:21 INFO - 'LANGUAGE': 'en_US:en', 07:54:21 INFO - 'LOGNAME': 'cltbld', 07:54:21 INFO - 'MAIL': '/var/mail/cltbld', 07:54:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:21 INFO - 'MOZ_NO_REMOTE': '1', 07:54:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:21 INFO - 'NO_EM_RESTART': '1', 07:54:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:21 INFO - 'PWD': '/builds/slave/test', 07:54:21 INFO - 'SHELL': '/bin/bash', 07:54:21 INFO - 'SHLVL': '1', 07:54:21 INFO - 'TERM': 'linux', 07:54:21 INFO - 'TMOUT': '86400', 07:54:21 INFO - 'USER': 'cltbld', 07:54:21 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1494600819.515925-727620629', 07:54:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:21 INFO - '_': '/tools/buildbot/bin/python'} 07:54:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:21 INFO - Downloading/unpacking blobuploader==1.2.4 07:54:21 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 07:54:21 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 07:54:21 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 07:54:21 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 07:54:22 INFO - Downloading blobuploader-1.2.4.tar.gz 07:54:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:54:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:54:22 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 07:54:22 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 07:54:22 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 07:54:22 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 07:54:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:54:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:54:23 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 07:54:23 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 07:54:23 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 07:54:23 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 07:54:23 INFO - Downloading docopt-0.6.1.tar.gz 07:54:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:54:23 INFO - Installing collected packages: blobuploader, requests, docopt 07:54:23 INFO - Running setup.py install for blobuploader 07:54:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:54:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:54:23 INFO - Running setup.py install for requests 07:54:23 INFO - Running setup.py install for docopt 07:54:24 INFO - Successfully installed blobuploader requests docopt 07:54:24 INFO - Cleaning up... 07:54:24 INFO - Return code: 0 07:54:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:54:24 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')]} 07:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:24 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')]} 07:54:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:24 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 0xa461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc12a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb5a30>, '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 0xdb67f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb6ca0>, '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': 'df17445c3590ff7897617a0e00000225-1494600819.515925-727620629', '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 07:54:24 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 07:54:24 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 07:54:24 INFO - Using env: {'DISPLAY': ':0', 07:54:24 INFO - 'HOME': '/home/cltbld', 07:54:24 INFO - 'LANG': 'en_US.UTF-8', 07:54:24 INFO - 'LANGUAGE': 'en_US:en', 07:54:24 INFO - 'LOGNAME': 'cltbld', 07:54:24 INFO - 'MAIL': '/var/mail/cltbld', 07:54:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:24 INFO - 'MOZ_NO_REMOTE': '1', 07:54:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:24 INFO - 'NO_EM_RESTART': '1', 07:54:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:24 INFO - 'PWD': '/builds/slave/test', 07:54:24 INFO - 'SHELL': '/bin/bash', 07:54:24 INFO - 'SHLVL': '1', 07:54:24 INFO - 'TERM': 'linux', 07:54:24 INFO - 'TMOUT': '86400', 07:54:24 INFO - 'USER': 'cltbld', 07:54:24 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1494600819.515925-727620629', 07:54:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:24 INFO - '_': '/tools/buildbot/bin/python'} 07:54:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:54:24 INFO - Running setup.py (path:/tmp/pip-V4boiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:54:24 INFO - Running setup.py (path:/tmp/pip-NOi4bC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:54:24 INFO - Running setup.py (path:/tmp/pip-tZ0TlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:54:24 INFO - Running setup.py (path:/tmp/pip-cUK40w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:54:24 INFO - Running setup.py (path:/tmp/pip-idZcj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:54:24 INFO - Running setup.py (path:/tmp/pip-E4oUJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:54:24 INFO - Running setup.py (path:/tmp/pip-QQ6G9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:54:24 INFO - Running setup.py (path:/tmp/pip-pdv9IK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:54:24 INFO - Running setup.py (path:/tmp/pip-THFSCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:54:24 INFO - Running setup.py (path:/tmp/pip-Lk3l0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:54:25 INFO - Running setup.py (path:/tmp/pip-zdmEb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:54:25 INFO - Running setup.py (path:/tmp/pip-rjK9F9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:54:25 INFO - Running setup.py (path:/tmp/pip-4mGxaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:54:25 INFO - Running setup.py (path:/tmp/pip-8AItxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:54:25 INFO - Running setup.py (path:/tmp/pip-L4oitK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:54:25 INFO - Running setup.py (path:/tmp/pip-7stQAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:54:25 INFO - Running setup.py (path:/tmp/pip-eL7EBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:54:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:54:25 INFO - Running setup.py install for manifestparser 07:54:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:54:25 INFO - Running setup.py install for mozcrash 07:54:25 INFO - Running setup.py install for mozdebug 07:54:25 INFO - Running setup.py install for mozdevice 07:54:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:54:25 INFO - Running setup.py install for mozfile 07:54:26 INFO - Running setup.py install for mozhttpd 07:54:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:54:26 INFO - Running setup.py install for mozinfo 07:54:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:54:26 INFO - Running setup.py install for mozInstall 07:54:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:54:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:54:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:54:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:54:26 INFO - Running setup.py install for mozleak 07:54:26 INFO - Running setup.py install for mozlog 07:54:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:54:26 INFO - Running setup.py install for moznetwork 07:54:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:54:26 INFO - Running setup.py install for mozprocess 07:54:26 INFO - Running setup.py install for mozprofile 07:54:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:54:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:54:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:54:26 INFO - Running setup.py install for mozrunner 07:54:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:54:27 INFO - Running setup.py install for mozscreenshot 07:54:27 INFO - Running setup.py install for moztest 07:54:27 INFO - Running setup.py install for mozversion 07:54:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:54:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:54:27 INFO - Cleaning up... 07:54:27 INFO - Return code: 0 07:54:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:54:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:27 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 0xa461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc12a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb5a30>, '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 0xdb67f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb6ca0>, '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': 'df17445c3590ff7897617a0e00000225-1494600819.515925-727620629', '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 07:54:27 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 07:54:27 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 07:54:27 INFO - Using env: {'DISPLAY': ':0', 07:54:27 INFO - 'HOME': '/home/cltbld', 07:54:27 INFO - 'LANG': 'en_US.UTF-8', 07:54:27 INFO - 'LANGUAGE': 'en_US:en', 07:54:27 INFO - 'LOGNAME': 'cltbld', 07:54:27 INFO - 'MAIL': '/var/mail/cltbld', 07:54:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:27 INFO - 'MOZ_NO_REMOTE': '1', 07:54:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:27 INFO - 'NO_EM_RESTART': '1', 07:54:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:27 INFO - 'PWD': '/builds/slave/test', 07:54:27 INFO - 'SHELL': '/bin/bash', 07:54:27 INFO - 'SHLVL': '1', 07:54:27 INFO - 'TERM': 'linux', 07:54:27 INFO - 'TMOUT': '86400', 07:54:27 INFO - 'USER': 'cltbld', 07:54:27 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1494600819.515925-727620629', 07:54:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:27 INFO - '_': '/tools/buildbot/bin/python'} 07:54:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:54:27 INFO - Running setup.py (path:/tmp/pip-Ob8srh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:54:27 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)) 07:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:54:27 INFO - Running setup.py (path:/tmp/pip-YJombo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:54:27 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)) 07:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:54:27 INFO - Running setup.py (path:/tmp/pip-vweQRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:54:27 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)) 07:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:54:27 INFO - Running setup.py (path:/tmp/pip-95sFQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:54:27 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)) 07:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:54:27 INFO - Running setup.py (path:/tmp/pip-iW7sH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:54:27 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)) 07:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:54:27 INFO - Running setup.py (path:/tmp/pip-Ukd_Ou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:54:27 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)) 07:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:54:27 INFO - Running setup.py (path:/tmp/pip-EzE4wm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:54:28 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)) 07:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:54:28 INFO - Running setup.py (path:/tmp/pip-elgIjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:54:28 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)) 07:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:54:28 INFO - Running setup.py (path:/tmp/pip-i7XVFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:54:28 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)) 07:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:54:28 INFO - Running setup.py (path:/tmp/pip-xP0zka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:54:28 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)) 07:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:54:28 INFO - Running setup.py (path:/tmp/pip-901ASU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:54:28 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)) 07:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:54:28 INFO - Running setup.py (path:/tmp/pip-pXYAEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:54:28 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)) 07:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:54:28 INFO - Running setup.py (path:/tmp/pip-UAhJFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:54:28 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)) 07:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:54:28 INFO - Running setup.py (path:/tmp/pip-04mgWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:54:28 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)) 07:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:54:28 INFO - Running setup.py (path:/tmp/pip-BVJSES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:54:28 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)) 07:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:54:28 INFO - Running setup.py (path:/tmp/pip-rq0A9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:54:28 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)) 07:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:54:28 INFO - Running setup.py (path:/tmp/pip-zNaq2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:54:28 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)) 07:54:28 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)) 07:54:28 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)) 07:54:28 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)) 07:54:28 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)) 07:54:28 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)) 07:54:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:54:28 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 07:54:28 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 07:54:28 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 07:54:28 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 07:54:29 INFO - Downloading blessings-1.6.tar.gz 07:54:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:54:29 INFO - Installing collected packages: blessings 07:54:29 INFO - Running setup.py install for blessings 07:54:30 INFO - Successfully installed blessings 07:54:30 INFO - Cleaning up... 07:54:30 INFO - Return code: 0 07:54:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:54:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:54:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:54:30 INFO - Reading from file tmpfile_stdout 07:54:30 INFO - Current package versions: 07:54:30 INFO - argparse == 1.2.1 07:54:30 INFO - blessings == 1.6 07:54:30 INFO - blobuploader == 1.2.4 07:54:30 INFO - docopt == 0.6.1 07:54:30 INFO - functools32 == 3.2.3-2 07:54:30 INFO - jsonschema == 2.5.1 07:54:30 INFO - manifestparser == 1.1 07:54:30 INFO - mozInstall == 1.12 07:54:30 INFO - mozcrash == 1.0 07:54:30 INFO - mozdebug == 0.1 07:54:30 INFO - mozdevice == 0.50 07:54:30 INFO - mozfile == 1.2 07:54:30 INFO - mozhttpd == 0.7 07:54:30 INFO - mozinfo == 0.9 07:54:30 INFO - mozleak == 0.1 07:54:30 INFO - mozlog == 3.4 07:54:30 INFO - moznetwork == 0.27 07:54:30 INFO - mozprocess == 0.25 07:54:30 INFO - mozprofile == 0.28 07:54:30 INFO - mozrunner == 6.13 07:54:30 INFO - mozscreenshot == 0.1 07:54:30 INFO - mozsystemmonitor == 0.3 07:54:30 INFO - moztest == 0.8 07:54:30 INFO - mozversion == 1.4 07:54:30 INFO - psutil == 3.1.1 07:54:30 INFO - requests == 1.2.3 07:54:30 INFO - wsgiref == 0.1.2 07:54:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:54:30 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')]} 07:54:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:30 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')]} 07:54:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:30 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 0xa461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc12a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb5a30>, '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 0xdb67f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb6ca0>, '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': 'df17445c3590ff7897617a0e00000225-1494600819.515925-727620629', '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 07:54:30 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 07:54:30 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 07:54:30 INFO - Using env: {'DISPLAY': ':0', 07:54:30 INFO - 'HOME': '/home/cltbld', 07:54:30 INFO - 'LANG': 'en_US.UTF-8', 07:54:30 INFO - 'LANGUAGE': 'en_US:en', 07:54:30 INFO - 'LOGNAME': 'cltbld', 07:54:30 INFO - 'MAIL': '/var/mail/cltbld', 07:54:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:30 INFO - 'MOZ_NO_REMOTE': '1', 07:54:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:30 INFO - 'NO_EM_RESTART': '1', 07:54:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:30 INFO - 'PWD': '/builds/slave/test', 07:54:30 INFO - 'SHELL': '/bin/bash', 07:54:30 INFO - 'SHLVL': '1', 07:54:30 INFO - 'TERM': 'linux', 07:54:30 INFO - 'TMOUT': '86400', 07:54:30 INFO - 'USER': 'cltbld', 07:54:30 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1494600819.515925-727620629', 07:54:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:30 INFO - '_': '/tools/buildbot/bin/python'} 07:54:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:30 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)) 07:54:30 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)) 07:54:30 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)) 07:54:30 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)) 07:54:30 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)) 07:54:30 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)) 07:54:30 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)) 07:54:30 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)) 07:54:30 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)) 07:54:30 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)) 07:54:30 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)) 07:54:30 INFO - Cleaning up... 07:54:30 INFO - Return code: 0 07:54:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:54:30 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')]} 07:54:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:30 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')]} 07:54:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:30 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 0xa461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc12a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb5a30>, '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 0xdb67f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb6ca0>, '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': 'df17445c3590ff7897617a0e00000225-1494600819.515925-727620629', '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 07:54:30 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 07:54:30 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 07:54:30 INFO - Using env: {'DISPLAY': ':0', 07:54:30 INFO - 'HOME': '/home/cltbld', 07:54:30 INFO - 'LANG': 'en_US.UTF-8', 07:54:30 INFO - 'LANGUAGE': 'en_US:en', 07:54:30 INFO - 'LOGNAME': 'cltbld', 07:54:30 INFO - 'MAIL': '/var/mail/cltbld', 07:54:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:30 INFO - 'MOZ_NO_REMOTE': '1', 07:54:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:30 INFO - 'NO_EM_RESTART': '1', 07:54:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:30 INFO - 'PWD': '/builds/slave/test', 07:54:30 INFO - 'SHELL': '/bin/bash', 07:54:30 INFO - 'SHLVL': '1', 07:54:30 INFO - 'TERM': 'linux', 07:54:30 INFO - 'TMOUT': '86400', 07:54:30 INFO - 'USER': 'cltbld', 07:54:30 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1494600819.515925-727620629', 07:54:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:30 INFO - '_': '/tools/buildbot/bin/python'} 07:54:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:54:30 INFO - Cleaning up... 07:54:30 INFO - Return code: 0 07:54:30 INFO - Running post-action listener: _resource_record_post_action 07:54:30 INFO - Running post-action listener: _start_resource_monitoring 07:54:30 INFO - Starting resource monitoring. 07:54:30 INFO - [mozharness: 2017-05-12 14:54:30.786786Z] Finished create-virtualenv step (success) 07:54:30 INFO - [mozharness: 2017-05-12 14:54:30.787303Z] Running install step. 07:54:30 INFO - Running pre-action listener: _resource_record_pre_action 07:54:30 INFO - Running main action method: install 07:54:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:54:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:54:30 INFO - Reading from file tmpfile_stdout 07:54:30 INFO - Detecting whether we're running mozinstall >=1.0... 07:54:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:54:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:54:31 INFO - Reading from file tmpfile_stdout 07:54:31 INFO - Output received: 07:54:31 INFO - Usage: mozinstall [options] installer 07:54:31 INFO - Options: 07:54:31 INFO - -h, --help show this help message and exit 07:54:31 INFO - -d DEST, --destination=DEST 07:54:31 INFO - Directory to install application into. [default: 07:54:31 INFO - "/builds/slave/test"] 07:54:31 INFO - --app=APP Application being installed. [default: firefox] 07:54:31 INFO - mkdir: /builds/slave/test/build/application 07:54:31 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'] 07:54:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:54:48 INFO - Reading from file tmpfile_stdout 07:54:48 INFO - Output received: 07:54:48 INFO - /builds/slave/test/build/application/firefox/firefox 07:54:48 INFO - Running post-action listener: _resource_record_post_action 07:54:48 INFO - [mozharness: 2017-05-12 14:54:48.370314Z] Finished install step (success) 07:54:48 INFO - [mozharness: 2017-05-12 14:54:48.370421Z] Running run-tests step. 07:54:48 INFO - Running pre-action listener: _resource_record_pre_action 07:54:48 INFO - Running main action method: run_tests 07:54:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:54:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:54:48 INFO - Python 2.7.3 07:54:48 INFO - Return code: 0 07:54:48 INFO - grabbing minidump binary from tooltool 07:54: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')]} 07:54:48 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 0xdb5a30>, '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 0xdb67f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb6ca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:54:48 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 07:54:48 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 07:54:48 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 07:54:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:54:48 INFO - Return code: 0 07:54:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:54:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:54:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:54:48 INFO - ENV: RUST_BACKTRACE is now 1 07:54:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:54:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:54:48 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/KI_iaByYSeeSOnxUNs4HQA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 07:54:48 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/KI_iaByYSeeSOnxUNs4HQA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 07:54:48 INFO - Using env: {'DISPLAY': ':0', 07:54:48 INFO - 'HOME': '/home/cltbld', 07:54:48 INFO - 'LANG': 'en_US.UTF-8', 07:54:48 INFO - 'LANGUAGE': 'en_US:en', 07:54:48 INFO - 'LOGNAME': 'cltbld', 07:54:48 INFO - 'MAIL': '/var/mail/cltbld', 07:54:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:54:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:54:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:48 INFO - 'MOZ_NO_REMOTE': '1', 07:54:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:54:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:54:48 INFO - 'NO_EM_RESTART': '1', 07:54:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:54:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:48 INFO - 'PWD': '/builds/slave/test', 07:54:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:54:48 INFO - 'RUST_BACKTRACE': '1', 07:54:48 INFO - 'SHELL': '/bin/bash', 07:54:48 INFO - 'SHLVL': '1', 07:54:48 INFO - 'TERM': 'linux', 07:54:48 INFO - 'TMOUT': '86400', 07:54:48 INFO - 'USER': 'cltbld', 07:54:48 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1494600819.515925-727620629', 07:54:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:48 INFO - '_': '/tools/buildbot/bin/python'} 07:54:48 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/KI_iaByYSeeSOnxUNs4HQA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 07:54:48 INFO - mozversion application_buildid: 20170512140107 07:54:48 INFO - mozversion application_changeset: 1ec1d88637208098802e57d13db9033902e5a229 07:54:48 INFO - mozversion application_display_name: Nightly 07:54:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:54:48 INFO - mozversion application_name: Firefox 07:54:48 INFO - mozversion application_remotingname: firefox 07:54:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:54:48 INFO - mozversion application_vendor: Mozilla 07:54:48 INFO - mozversion application_version: 55.0a1 07:54:48 INFO - mozversion platform_buildid: 20170512140107 07:54:48 INFO - mozversion platform_changeset: 1ec1d88637208098802e57d13db9033902e5a229 07:54:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:54:48 INFO - mozversion platform_version: 55.0a1 07:54:48 INFO - using testdate: 1494600888 07:54:48 INFO - actual date: 1494600888 07:54:48 INFO - starting webserver on 'localhost:46425' 07:54:48 INFO - SUITE-START | Running 2 tests 07:54:48 INFO - TEST-START | dromaeo_css 07:54:48 INFO - operating with platform_type : linux_ 07:54:48 INFO - Initialising browser for dromaeo_css test... 07:54:48 INFO - TEST-INFO | started process 32240 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNyUUiA/profile http://localhost:46425/getInfo.html) 07:54:52 INFO - PID 32240 | __metrics Screen width/height:1600/1200 07:54:52 INFO - PID 32240 | colorDepth:24 07:54:52 INFO - PID 32240 | Browser inner width/height: 1024/695 07:54:52 INFO - PID 32240 | __metrics 07:54:54 INFO - PID 32240 | 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" 07:54:54 INFO - PID 32240 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:54:55 INFO - TEST-INFO | 32240: exit 0 07:54:55 INFO - Browser initialized. 07:54:55 INFO - Running cycle 1/1 for dromaeo_css test... 07:54:55 INFO - TEST-INFO | started process 32340 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNyUUiA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:55:07 INFO - PID 32340 | RSS: Main: 149553152 07:55:07 INFO - PID 32340 | 07:58:10 INFO - PID 32340 | Cycle 1(1): loaded http://localhost:46425/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46425/tests/dromaeo/cssquery-ext.html) 07:58:11 INFO - PID 32340 | RSS: Main: 260841472 07:58:11 INFO - PID 32340 | 08:01:13 INFO - PID 32340 | Cycle 1(1): loaded http://localhost:46425/tests/dromaeo/cssquery-ext.html (next: http://localhost:46425/tests/dromaeo/cssquery-jquery.html) 08:01:14 INFO - PID 32340 | RSS: Main: 230072320 08:01:14 INFO - PID 32340 | 08:04:15 INFO - PID 32340 | Cycle 1(1): loaded http://localhost:46425/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46425/tests/dromaeo/cssquery-mootools.html) 08:04:16 INFO - PID 32340 | RSS: Main: 238014464 08:04:16 INFO - PID 32340 | 08:07:18 INFO - PID 32340 | Cycle 1(1): loaded http://localhost:46425/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46425/tests/dromaeo/cssquery-prototype.html) 08:07:19 INFO - PID 32340 | RSS: Main: 176332800 08:07:19 INFO - PID 32340 | 08:10:21 INFO - PID 32340 | Cycle 1(1): loaded http://localhost:46425/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46425/tests/dromaeo/cssquery-yui.html) 08:10:22 INFO - PID 32340 | RSS: Main: 177704960 08:10:22 INFO - PID 32340 | 08:13:24 INFO - PID 32340 | Cycle 1(1): loaded http://localhost:46425/tests/dromaeo/cssquery-yui.html (next: http://localhost:46425/tests/dromaeo/cssquery-dojo.html) 08:13:24 INFO - PID 32340 | RSS: Main: 267567104 08:13:24 INFO - PID 32340 | 08:13:24 INFO - PID 32340 | __start_tp_report 08:13:24 INFO - PID 32340 | _x_x_mozilla_page_load 08:13:24 INFO - PID 32340 | _x_x_mozilla_page_load_details 08:13:24 INFO - PID 32340 | |i|pagename|runs| 08:13:24 INFO - PID 32340 | |0;dojo.html;3353.480210567362;3371.258323168902;3382.847771850268;3384.1708781348557;3399.116229780258;5690.118031705082;5804.477597016267;5831.3293971193325;5833.824985250439;5868.794592189269;5766;5784.074548072309;5792.218050563172;5836.649801011942;5920.437558431953;4764.833230836922;5038.319826823387;5137.537621614054;5204.531592156705;5245.160774276116;5181.145111056671;5191.221316802491;5272.367315922094;5273.525382715555;5274.630775845692;5068.391792984847;5130.179171332569;5158.871028224287;5188.118019936582;5238.083335416325;5180.766865491062;5190.532852043334;5201.635885488017;5204.583633309364;5262.657927234717;5141;5192.61055420845;5195.558377537914;5197.454267301917;5227.921581176285;5657.12314591239;5687.744051517691;5718.59969802114;5720.399358067426;5820.941790582082;6145.924463218918;6155.292141403751;6156.415140561639;6159.3224745277985;6162.13730077785;6130.298782221731;6170.907436388457;6192.907106393408;6196.47329976948;6197.690115494207;5825.126231065374;5847.532197424196;5894.233749612566;5900.468957793776;5928.940710592925;6476.6114033158165;6478.093066970534;6480.287168411471;6489.545731798823;6490.286068532458;6069.817905462844;6100.490342048369;6102.701334035102;6110.541709371815;6196.659183744938;6191.938080619136;6233.34549872266;6234.251889773256;6238.719257633417;6240.781572644935;6065.484433823174;6195.721192546346;6204.503639708812;6237;6238.157848690369;6148.569600127948;6155.045967874987;6160.845978850475;6172.4136207060255;6173.722182501798;4691.601213896857;4710;4712.528747125329;4714.127886341038;4714.5992590630185;4186.874393768192;4237.279662457389;4273.102648443862;4280.743155410623;4281.272183728774;5824.475797178275;5864.325602555676;5866.530677545786;5885.529157667376;5894.204282421904;6211.3167551569295;6230.252369715663;6243.063540468966;6270.9372906270355;6310.400511951358;5927.1405646181065;5929.4070592941225;5932.851678707981;5940.049592065336;5996.13056106862;5244.737763111829;5304.23088652151;5312.867178320495;5314.548263397577;5320.733963301819;6467.644279564575;6522;6568.67156642166;6572;6576;6329.335419780857;6355.1420558224045;6358.90461643085;6373.936260637334;6382.904256436064;6706.228783689938;6707.966460167668;6710.027046078389;6713.194416669836;6724.361185687352;6088.360722124113;6114.3277820888225;6122.428649698624;6243.469305109116;6258.468030217483;6185.257769067561;6300.464460520724;6308.179936608395;6314.652694101868;6334.524910631629;6098.969505152446;6150.10823430609;6151.84620384494;6154.261488621394;6159.938400616115;6125.84685382869;6129.049997250433;6134;6143.201383820075;6143.84640383994;5945.64326140433;6003.249593800775;6023.518118550418;6035;6104.4200800923845;6129.664444256008;6132.336724663555;6138.138078135459;6146.5390095742105;6147.0779383092895;5945.762169513171;5947.791827286024;5980.641161530322;5988.520918326611;6037.245344331958 08:13:24 INFO - PID 32340 | |1;ext.html;749.7226026370244;799.6361655446773;817.3951276055718;1143.091242462242;1145.37004647444;29612.40775184495;36769.26461470769;37280.81359593205;37412.43881341782;37427.438588421195;38910.80544597273;38997.8050109749;39235;39292.410613840744;39361;5556.305461817273;5686.31764188298;7034.85930281394;7174.139103307611;7178.49750517464;6961.617111058889;7084.43324534036;7110.395616372589;7115.501914865961;7116.822079448029;7148.213696493382;7212.60330681815;7230.674619642129;7235.819104522377;7237.457190710717;7129.5365801223015;7170.103737032871;7173.820654483654;7177.748778792769;7183.784486465414;7099.148102227714;7130.5365151265005;7139.571625702474;7149.106361704787;7153.821154471128;35377.823110884536;35436.29127417463;35539.78053840593;35568.466473002925;35592;3489.5114683944266;3525.0834782956617;3538.6992105671047;3539.681428671406;3540.451230059319;27486.312842178904;27529.174124776087;27534.173974780788;27574.310642233904;27599.724002759915;3740.989932718178;3743.8315275812383;3783.5838057813617;3784.5836957934607;3829.5787463379006;189571;191232;191351;191595;191845;46784.5321546787;46825.76587117043;46969.295460568115;47067;47140.5285947143;49908;49924.75037624789;49998.75000625046;50034.749826250634;50124.24813627799;13749.518766843112;13864.722705545833;13870.364630720333;13872.930635346758;13875.653108672364;10278.33190842593;10386.584536618451;11429.428528573539;11569.6529104127;11579.88420115788;13688.93155534216;13711.177329360271;13723.656908577366;13880.23658698761;13910.234937078356;5373.919391209135;5391.973040134774;5436;5479.726013699299;5533.280673512498;1062.3785085724937;1098.1983152298867;1102.7298311913632;1109.545086514525;1122.4780477078198;24426.877865610913;24473.63289550658;24579.508409831702;24594.877025614758;24627.753722462545;1184.549871049013;1194.8805119488156;1199.1426130316866;1214.4534959268365;1227.2820400066062;12833.165844220282;13017.284049377375;13118.672033199246;13137.34313284332;13179.802302965463;212357;212400;213468;214485;215302;49846;49869;49926.750366247936;50076.248856267186;50078.49921500811;1485.9405623774928;1514.2277438506221;1539.95380138596;1542.1980570103483;1547.7678348247853;23534.058637654303;24233.636495452934;24582.262532124067;24731.258062258163;24899.253022408633;38293.617063829006;38308.616913830505;38341.80829095837;38366;38406.6159338403;188684;188924;189015;189019;189995;29274.268143296587;29786.702132978393;31726.206844829063;32605.347893041533;33198.83400582981;37576;38925.805370972965;39094.4135837957;39281.803590981865;39371.409428858016;29363.85318073396;29564.852175738983;29788.702112978594;29960.101196964126;30135.095947121623;29435.558466622588;29668.851655741582;29831.403371932873;30398.696013039586;30410.391792164475;34304.485432719026;34471.82764086264;34666;34798.82600586981;35086.82456587701;28144.43711125807;28526;28818.567721483774;29310;29524.704752952195;22847;24168.274951751475;24189.75810241875;24210.88414969424;24693.87653061723 08:13:24 INFO - PID 32340 | |2;jquery.html;437.13665510616556;445.30310064748664;449.7211728728189;456.89034631688406;464.3151351756159;18416.447506574823;19668.90165549172;20298.289559865407;20403.897980510093;20518.179272829067;20266.797332026676;21086.789132108675;21118.472038199052;21238.787612123913;21630.3510894673;5512.228288039678;5702.6863522506455;5710.114932185518;5710.971445142768;5720.914186287209;5424;5493.7802487900435;5515;5558.833235002936;5567.164925261202;5540.445955404468;5546.500814926656;5551.306086739158;5556.499915007648;5557.083081291582;5336.386315573701;5509.338879334486;5514.91727624086;5532.2531458253225;5549.278593782782;5071.112555302844;5074.264231686422;5080.618953578496;5081.237814327844;5082.1106306396605;24564.877175614187;24915.377115572075;24992.750072499224;25108.24675259745;25190;2162.653975363934;2190.6823510590875;2196.7254093238344;2197.8021978021893;2198.8350873684376;16832.57918552034;17496.737548936777;17510.387136450292;17640.647187056187;17647.823521764745;2094.7381577302835;2103.1587365053947;2158.104386679526;2164.6536554151417;2185.7923497267734;93044.53477732568;94590.99999999932;95411.52294238553;96718;97745;12391.690207744878;12525.498980040697;12831.743365132645;12919.677008074874;12957.093003489665;18167.63664726698;18197.09014549267;18217.544561385806;18227.26591011359;18263.72604410935;8584.828303433897;8699.43453675509;8872;8876.20114189726;8954.955225223832;7817.765467035998;7947.761567152995;7982.962214912141;8122.431429799975;8131.308838748772;7909.20907909216;7987.520748755093;8025.400725168923;8208.876866847002;8225.259726624632;2220.7890250426185;2222.75549689534;2238.5634801213605;2251.8311126665567;2286.725592928859;1077.8359371878353;1095.4139535348709;1104.094642393246;1106.6790630717162;1113.2763703592568;19087.809121908882;19456.8054319455;20294.18823247083;20685.89657051735;20895.582088358147;1113.4377139544479;1120.7417054634918;1122.354646078508;1124.7356871135278;1148.064327573042;10825.242233043611;11106.278091924;11182.66452006441;11299.627078313646;11412.201145919706;466331;468661;469467;472674;478719;91432;95805;96449;96967.51516242514;98202;1212.2120621596034;1235.2711899979056;1269.707967167538;1275.8915492183269;1285.370168617352;20196.29312974039;20508.58982820365;20816.895915520327;20928.895355523124;21259.36221913345;43961;44759;45259;45364.31953520634;45510.54489455063;55571;57292.42707572871;57465.71267143638;57809;59100;9454.480003599592;9584.185344245818;9663.903360966582;9714.368566043184;10061.69814905554;14647.340869660678;14690;14807.481738139113;14862.405503779728;15562;12628.747425051632;12891.419886105336;12935.482580696667;13076.346182691017;13280.335983200994;12168.391580421121;12494.0004799614;12575.93712031434;12703.42834572428;12870.099093063396;12983.675408114495;13019.153755005895;13422.127561708458;13611.387487562886;13949;9496.905030949601;9608.231341492803;9653.46905920181;9697;9913.851292230478;12974.740505190031;13063.934680326918;13161.53934612284;13293.734125317245;13450.86549134496 08:13:24 INFO - PID 32340 | |3;mootools.html;1190.6368557589942;1312.304478626328;1368.1107280267825;1381.6062422209673;1391.4573316406609;9899.950500247498;11198.272112312694;11552.306861588311;11756.7648647027;11810.940945295262;11563.53745850167;11643.243189192717;11650.592229271977;11665.066794656428;11677.299362038284;2392.976070239297;2432.683751112353;2437.695288088989;2437.9756202437925;2438.67077944477;2096.790320967906;2151.4298710841563;2348.1429278313376;2441.5361081394476;2454.754524547549;2440.9511809763794;2463.8521688698734;2469.715982661999;2471.9752802472017;2472.4807790363957;2423.0307876849224;2445.1075357494565;2447.79193768529;2448.4123810285405;2452.509498100378;2313.9421514462106;2344.39045848079;2346.7093098795763;2347.248880358286;2352.1061996441413;11142.27575207609;11332.660020199408;11355.432228388547;11357.829632555518;11362;6449.12936753537;6624.370684784938;6639.435647969928;6648.634325112117;6682.732690692366;3889.3388124018984;4101.364288535282;4183.560726123774;4200.789960501963;4203.642690371322;1347.1311004402105;1361.7276544691003;1409.8429403013406;1415.716856628668;1445.4724025730532;17448.389306374214;17623.295068197258;17655;17664.735028974577;17675.116244187866;5461.754221060062;5602.4957753802355;5749.281339832521;5760.279965004374;5783.2192653992015;14289.785653215211;14308.213048282445;14311;14329.283535823168;14333.713325733635;6149.600275982047;6482.481401487964;6494.253160886464;6500.837479063061;6508.739650414025;5848.766049358063;5861.970690146607;5862.765489380462;5879.764809407576;5884.852878677982;4140.834366625301;4294.227039132986;4543.38664280318;4615.576822168321;4655.674102812838;1352;1385.8267716535433;1387.091455096913;1392.679683672761;1397;841.7180244617999;864.3819668936741;875.0505701314019;884.1644645809648;903.6972614174193;6326.841828954221;6387.808365749035;6430.356964303533;6434.067060276234;6439.291677915426;946.947917864524;959.9664011759695;963.1235575626287;968.2205824311496;977.8142152990908;4280.636145927631;4475.545447729501;4486.371907932892;4516.23224051912;4693.366395536627;15085.54743357679;15200.46798362052;15601;15636;15643.921780391025;15036.323365448581;15301.846981530041;15333.923330383277;15370.615734606725;15495.690086198212;9332.206762425134;9422.199113075329;9495.525223738785;9545.140937315537;9551.379160354554;6776.661166941534;6805.149356330458;6805.829854253683;6818.8636227276165;6946.235914049349;13331.33343332849;13483.05618606688;13778.448862045807;13806.65483362924;13820.37808298649;13688.110272832235;13842.515511957034;13868;14102.929485352508;14123.43506259738;9417.199538039344;9423.764405889908;9516.571754270935;9521.61913523479;9586.890884005508;9799.265055120752;10028.448435336126;10851.945740271563;10906.563737450413;11128.276662016942;9416.717498475056;9446.338756286994;9448.196903263299;9610.759731006781;9768.56041478121;9275.2579793615;9287.953560232427;9313.39462934907;9350.906490935004;9493.477858717837;8473.110323416198;8501.064882863004;8583.484990900566;8672.436291641023;8685.305175586065;5839.726984095556;5950.464458198783;6056.939430605637;6089.725962331794;6160.291566469734;6012.488938440281;6021.2473440819895;6039.094135879477;6096.5732398733435;6136.815895523141 08:13:24 INFO - PID 32340 | |4;prototype.html;417.67212738000666;419.5552714123029;429.1974008603911;429.59188770667856;435.25788530555405;5710.343310519292;5845.123231515269;5856.76572937082;5881.5294776417895;5882.205902203206;5706.942930570693;5718.571107166968;5727.484526392624;5750.654960702361;5775.10485874689;4249.405083288342;4380.89047773805;4389.517153113155;4406.096750166208;4564.246899261626;4388.144311859189;4400.97799511002;4405.6695747818885;4406.65596992917;4407.757573333465;4351.934720979188;4363.410939523172;4369.497507786597;4378.605925466707;4389.890252743675;4336.392904993303;4341.696081274312;4375.453068366454;4386.56134386562;4411.345745345496;3819.8090095495113;3820.847166113352;3834.5398552173638;3836.1943991761764;3837.0982819037504;5627.915581266284;5641.605087643867;5651.463111004489;5652.604317697763;5659.773609055633;5057.544820966131;5091.974540127313;5126.7183204198955;5140.434552199255;5170.983316506566;6086.847828804271;6103.35914728956;6105.023196288573;6118.592723673535;6128.295246046672;4266.50672264708;4299.50555686097;4312.072904325553;4316.115196384733;4323.437953066113;6086.391360863922;6189.2572891252885;6273.466755325803;6408.423241908204;6439.259485159219;4798.1123492154065;4850.320955066293;4890.559849613481;4904.705717656952;4917.286993385939;4953.90092198154;4962.727050012212;4964;4972.950270497321;4973.1297023020825;5386.13821788512;5394.829208549212;5433.239346491494;5440.809571665052;5440.891182176334;6112.908306375319;6163.84590385244;6167.599106058092;6183.536234782319;6186.721597528122;1701.8298170182882;1703.9574010649833;1718.0293134379035;1718.089412611318;1731.6450127723785;1252.8872401483911;1258.8804063613943;1261.867503912076;1265;1265.677252300676;5914.940850591525;5935.703214839241;5938.703064846827;5943.465088142001;5943.940560594425;6080.878382432326;6236.407541283571;6248.687565621701;6270.805218173603;6278.937210627927;5865.325487568899;5888.882222355529;5893;5913.970430147908;5917.467427931507;3232.3696879108347;3310.427546915196;3316.8673253070087;3336.849841757078;3359.2441700617164;6567;6571.211454625475;6573.769918052845;6597.538172327987;6605;6400.647964361911;6401.583897046677;6409.391107844747;6412.134361861183;6444.484441244689;6391.904121438182;6539.673016349164;6560.770373036826;6562.376574225441;6630.336511805701;6249.625022498664;6254.21822272216;6257.5932564383165;6268.435840774352;6280.371962803683;5969.432903874125;6114.755409783559;6204.81385558434;6226;6244.250689917239;6391.456726178327;6443.097966284818;6447;6454.806355809334;6459;4880.292357608056;4881.511848815232;4887.413510378778;4893.339399181065;4896.681715688469;6169.167162433194;6310.968445157929;6319.2622028942405;6330.430261276507;6348.396902294275;6160.291566469913;6160.476359509492;6164.383561643979;6178.196834411678;6189.96905015472;5985.191999080069;6145.877082458236;6164.044573091178;6174.722137503913;6195;6164.291106522807;6167.938320616916;6168.383161683796;6169.81490555284;6173.41352571505;5965.850853728692;6202;6221.5333849960525;6223.533235007302;6224.751009959551;5907;5959.0763431668165;5972.492338151305;5973.193618861398;5986.07215881539 08:13:24 INFO - PID 32340 | |5;yui.html;849.8810166576684;859.9183077607629;865.5585651317826;867.2758246863867;876.084491706167;16876.746848797247;17134.48596542104;17389.913050434745;17405.738913916302;17428.302867885286;14898.255087245621;15094.16982065986;15120.621984450394;15121.470748523803;15169.014014089076;947.829390709672;950.4059962523423;956.942583444992;958.7555173430766;962.1773383756893;951.4053716427233;978.9510524473783;990.9554070066828;991.6231831903866;999.3504222255519;1049.942253176075;1051.9579216831316;1053.5048527192207;1056.6037735849056;1059.2585190366735;1036.19694736579;1039.2309690828808;1039.656913218636;1040.8646875906122;1042.8852826189113;766.7431410477496;768.6771555946516;768.6963649358472;770.249007217958;771.5910567399287;16875.493735187963;16996.40512582066;17044.48866534006;17751.378701745376;17905;18815.529611759677;18901.905490472596;18975.525611859677;18999.05004749771;19230.423087307405;13763.655908602264;13779.104358216784;13909.652258693512;14084.084534505224;14090.577282681536;3485.372632926072;3520.471929210639;3527.8588856445713;3529.1530032792202;3529.205928666055;94754.52622736842;95292.52353738256;95503.52248238784;95721;97213.51393242988;13904.51334203298;13935.651608709863;14052.508162214273;14110.153390796586;14217.928910355382;27316.59025114625;27579.586306205423;27786;28028;28048.29879253035;8219;8228.42401031934;8235.629396677165;8347.624356903954;8360.372972027122;4005.739626924299;4081.9999100220634;4088.9182216356103;4092.815823287959;4095.7542547447247;4535.841245556456;4544.909101817945;4589.128065667513;4605.286180642006;4636.466806317249;838.4969018588798;858.043281740867;867.0332579174176;869.5087275689216;871.1419252036738;691.560858854631;695.4679670052413;709.0109297529917;718.1489934427719;727.9090113735783;10008.199344052458;10166.085052345177;10352.896471035343;10399.896001040044;10662.360258384522;701.2706784943704;714.1822613107962;714.2678754276803;716.2479396633514;724.77169691547;4839.951600484021;4848.200046992278;4879.4876537963;4927.926081108786;5014.34813474246;70043;70527.29472705207;72750.63624681842;76075.23924760793;79004.60497697475;66437;67346.326536734;68763.65618171977;69578;69614.65192674004;60541.394586054455;61388.07917881235;61518;61944.69027654923;62026;11012.724681883017;11622.128340374336;11694.9482738811;11754.532412938033;11762.470688819194;32143.196420089684;32332.35335293328;32521;32797;33775;51867.2219916694;53615.463845361046;54148.729256353465;55587;56722.43277567172;16559.586010349838;16633.916830416256;17297.65404691874;17491.825081749528;17520;16895.155242238085;17193.656126877642;17589;17901.19444624969;18015.549611259823;15602.531924041843;16064.759028614346;16074.67850643004;16289.51131466058;16296.348146074024;15033.398664053753;15214.315355808794;15418.922905385401;15598.064116153068;15924;15266.084034957938;15341.923290383476;15781.21093945321;15990.040597564184;16237.350505979628;11195;11236.381998990135;11285.661430157108;11438.428078596204;11628.94185529067;12341.382930853242;12710.110292279822;12763.425645846144;12799.872001279868;12809.359532023547 08:13:24 INFO - PID 32340 | __end_tp_report 08:13:24 INFO - PID 32340 | __start_cc_report 08:13:24 INFO - PID 32340 | _x_x_mozilla_cycle_collect,1188 08:13:24 INFO - PID 32340 | __end_cc_report 08:13:24 INFO - PID 32340 | __startTimestamp1494602004252__endTimestamp 08:13:24 INFO - PID 32340 | 08:13:24 INFO - PID 32340 | ------- Summary: start ------- 08:13:24 INFO - PID 32340 | Number of tests: 6 08:13:24 INFO - PID 32340 | 08:13:24 INFO - PID 32340 | [#0] dojo.html Cycles:165 Average:5781.79 Median:6035.00 stddev:693.54 (11.5%) stddev-sans-first:668.99 08:13:24 INFO - PID 32340 | Values: 3353.5 3371.3 3382.8 3384.2 3399.1 5690.1 5804.5 5831.3 5833.8 5868.8 5766.0 5784.1 5792.2 5836.6 5920.4 4764.8 5038.3 5137.5 5204.5 5245.2 5181.1 5191.2 5272.4 5273.5 5274.6 5068.4 5130.2 5158.9 5188.1 5238.1 5180.8 5190.5 5201.6 5204.6 5262.7 5141.0 5192.6 5195.6 5197.5 5227.9 5657.1 5687.7 5718.6 5720.4 5820.9 6145.9 6155.3 6156.4 6159.3 6162.1 6130.3 6170.9 6192.9 6196.5 6197.7 5825.1 5847.5 5894.2 5900.5 5928.9 6476.6 6478.1 6480.3 6489.5 6490.3 6069.8 6100.5 6102.7 6110.5 6196.7 6191.9 6233.3 6234.3 6238.7 6240.8 6065.5 6195.7 6204.5 6237.0 6238.2 6148.6 6155.0 6160.8 6172.4 6173.7 4691.6 4710.0 4712.5 4714.1 4714.6 4186.9 4237.3 4273.1 4280.7 4281.3 5824.5 5864.3 5866.5 5885.5 5894.2 6211.3 6230.3 6243.1 6270.9 6310.4 5927.1 5929.4 5932.9 5940.0 5996.1 5244.7 5304.2 5312.9 5314.5 5320.7 6467.6 6522.0 6568.7 6572.0 6576.0 6329.3 6355.1 6358.9 6373.9 6382.9 6706.2 6708.0 6710.0 6713.2 6724.4 6088.4 6114.3 6122.4 6243.5 6258.5 6185.3 6300.5 6308.2 6314.7 6334.5 6099.0 6150.1 6151.8 6154.3 6159.9 6125.8 6129.0 6134.0 6143.2 6143.8 5945.6 6003.2 6023.5 6035.0 6104.4 6129.7 6132.3 6138.1 6146.5 6147.1 5945.8 5947.8 5980.6 5988.5 6037.2 08:13:24 INFO - PID 32340 | 08:13:24 INFO - PID 32340 | [#1] ext.html Cycles:180 Average:35770.64 Median:32165.78 stddev:51360.94 (159.7%) stddev-sans-first:51437.70 08:13:24 INFO - PID 32340 | Values: 749.7 799.6 817.4 1143.1 1145.4 29612.4 36769.3 37280.8 37412.4 37427.4 38910.8 38997.8 39235.0 39292.4 39361.0 5556.3 5686.3 7034.9 7174.1 7178.5 6961.6 7084.4 7110.4 7115.5 7116.8 7148.2 7212.6 7230.7 7235.8 7237.5 7129.5 7170.1 7173.8 7177.7 7183.8 7099.1 7130.5 7139.6 7149.1 7153.8 35377.8 35436.3 35539.8 35568.5 35592.0 3489.5 3525.1 3538.7 3539.7 3540.5 27486.3 27529.2 27534.2 27574.3 27599.7 3741.0 3743.8 3783.6 3784.6 3829.6 189571.0 191232.0 191351.0 191595.0 191845.0 46784.5 46825.8 46969.3 47067.0 47140.5 49908.0 49924.8 49998.8 50034.7 50124.2 13749.5 13864.7 13870.4 13872.9 13875.7 10278.3 10386.6 11429.4 11569.7 11579.9 13688.9 13711.2 13723.7 13880.2 13910.2 5373.9 5392.0 5436.0 5479.7 5533.3 1062.4 1098.2 1102.7 1109.5 1122.5 24426.9 24473.6 24579.5 24594.9 24627.8 1184.5 1194.9 1199.1 1214.5 1227.3 12833.2 13017.3 13118.7 13137.3 13179.8 212357.0 212400.0 213468.0 214485.0 215302.0 49846.0 49869.0 49926.8 50076.2 50078.5 1485.9 1514.2 1540.0 1542.2 1547.8 23534.1 24233.6 24582.3 24731.3 24899.3 38293.6 38308.6 38341.8 38366.0 38406.6 188684.0 188924.0 189015.0 189019.0 189995.0 29274.3 29786.7 31726.2 32605.3 33198.8 37576.0 38925.8 39094.4 39281.8 39371.4 29363.9 29564.9 29788.7 29960.1 30135.1 29435.6 29668.9 29831.4 30398.7 30410.4 34304.5 34471.8 34666.0 34798.8 35086.8 28144.4 28526.0 28818.6 29310.0 29524.7 22847.0 24168.3 24189.8 24210.9 24693.9 08:13:24 INFO - PID 32340 | 08:13:24 INFO - PID 32340 | [#2] jquery.html Cycles:180 Average:30004.78 Median:2209.81 stddev:78019.68 (3530.6%) stddev-sans-first:78206.96 08:13:24 INFO - PID 32340 | Values: 437.1 445.3 449.7 456.9 464.3 18416.4 19668.9 20298.3 20403.9 20518.2 20266.8 21086.8 21118.5 21238.8 21630.4 5512.2 5702.7 5710.1 5711.0 5720.9 5424.0 5493.8 5515.0 5558.8 5567.2 5540.4 5546.5 5551.3 5556.5 5557.1 5336.4 5509.3 5514.9 5532.3 5549.3 5071.1 5074.3 5080.6 5081.2 5082.1 24564.9 24915.4 24992.8 25108.2 25190.0 2162.7 2190.7 2196.7 2197.8 2198.8 16832.6 17496.7 17510.4 17640.6 17647.8 2094.7 2103.2 2158.1 2164.7 2185.8 93044.5 94591.0 95411.5 96718.0 97745.0 12391.7 12525.5 12831.7 12919.7 12957.1 18167.6 18197.1 18217.5 18227.3 18263.7 8584.8 8699.4 8872.0 8876.2 8955.0 7817.8 7947.8 7983.0 8122.4 8131.3 7909.2 7987.5 8025.4 8208.9 8225.3 2220.8 2222.8 2238.6 2251.8 2286.7 1077.8 1095.4 1104.1 1106.7 1113.3 19087.8 19456.8 20294.2 20685.9 20895.6 1113.4 1120.7 1122.4 1124.7 1148.1 10825.2 11106.3 11182.7 11299.6 11412.2 466331.0 468661.0 469467.0 472674.0 478719.0 91432.0 95805.0 96449.0 96967.5 98202.0 1212.2 1235.3 1269.7 1275.9 1285.4 20196.3 20508.6 20816.9 20928.9 21259.4 43961.0 44759.0 45259.0 45364.3 45510.5 55571.0 57292.4 57465.7 57809.0 59100.0 9454.5 9584.2 9663.9 9714.4 10061.7 14647.3 14690.0 14807.5 14862.4 15562.0 12628.7 12891.4 12935.5 13076.3 13280.3 12168.4 12494.0 12575.9 12703.4 12870.1 12983.7 13019.2 13422.1 13611.4 13949.0 9496.9 9608.2 9653.5 9697.0 9913.9 12974.7 13063.9 13161.5 13293.7 13450.9 08:13:24 INFO - PID 32340 | 08:13:24 INFO - PID 32340 | [#3] mootools.html Cycles:180 Average:7285.21 Median:4162.20 stddev:4715.48 (113.3%) stddev-sans-first:4706.47 08:13:24 INFO - PID 32340 | Values: 1190.6 1312.3 1368.1 1381.6 1391.5 9900.0 11198.3 11552.3 11756.8 11810.9 11563.5 11643.2 11650.6 11665.1 11677.3 2393.0 2432.7 2437.7 2438.0 2438.7 2096.8 2151.4 2348.1 2441.5 2454.8 2441.0 2463.9 2469.7 2472.0 2472.5 2423.0 2445.1 2447.8 2448.4 2452.5 2313.9 2344.4 2346.7 2347.2 2352.1 11142.3 11332.7 11355.4 11357.8 11362.0 6449.1 6624.4 6639.4 6648.6 6682.7 3889.3 4101.4 4183.6 4200.8 4203.6 1347.1 1361.7 1409.8 1415.7 1445.5 17448.4 17623.3 17655.0 17664.7 17675.1 5461.8 5602.5 5749.3 5760.3 5783.2 14289.8 14308.2 14311.0 14329.3 14333.7 6149.6 6482.5 6494.3 6500.8 6508.7 5848.8 5862.0 5862.8 5879.8 5884.9 4140.8 4294.2 4543.4 4615.6 4655.7 1352.0 1385.8 1387.1 1392.7 1397.0 841.7 864.4 875.1 884.2 903.7 6326.8 6387.8 6430.4 6434.1 6439.3 946.9 960.0 963.1 968.2 977.8 4280.6 4475.5 4486.4 4516.2 4693.4 15085.5 15200.5 15601.0 15636.0 15643.9 15036.3 15301.8 15333.9 15370.6 15495.7 9332.2 9422.2 9495.5 9545.1 9551.4 6776.7 6805.1 6805.8 6818.9 6946.2 13331.3 13483.1 13778.4 13806.7 13820.4 13688.1 13842.5 13868.0 14102.9 14123.4 9417.2 9423.8 9516.6 9521.6 9586.9 9799.3 10028.4 10851.9 10906.6 11128.3 9416.7 9446.3 9448.2 9610.8 9768.6 9275.3 9288.0 9313.4 9350.9 9493.5 8473.1 8501.1 8583.5 8672.4 8685.3 5839.7 5950.5 6056.9 6089.7 6160.3 6012.5 6021.2 6039.1 6096.6 6136.8 08:13:24 INFO - PID 32340 | 08:13:24 INFO - PID 32340 | [#4] prototype.html Cycles:180 Average:5187.59 Median:5885.54 stddev:1493.36 (25.4%) stddev-sans-first:1454.00 08:13:24 INFO - PID 32340 | Values: 417.7 419.6 429.2 429.6 435.3 5710.3 5845.1 5856.8 5881.5 5882.2 5706.9 5718.6 5727.5 5750.7 5775.1 4249.4 4380.9 4389.5 4406.1 4564.2 4388.1 4401.0 4405.7 4406.7 4407.8 4351.9 4363.4 4369.5 4378.6 4389.9 4336.4 4341.7 4375.5 4386.6 4411.3 3819.8 3820.8 3834.5 3836.2 3837.1 5627.9 5641.6 5651.5 5652.6 5659.8 5057.5 5092.0 5126.7 5140.4 5171.0 6086.8 6103.4 6105.0 6118.6 6128.3 4266.5 4299.5 4312.1 4316.1 4323.4 6086.4 6189.3 6273.5 6408.4 6439.3 4798.1 4850.3 4890.6 4904.7 4917.3 4953.9 4962.7 4964.0 4973.0 4973.1 5386.1 5394.8 5433.2 5440.8 5440.9 6112.9 6163.8 6167.6 6183.5 6186.7 1701.8 1704.0 1718.0 1718.1 1731.6 1252.9 1258.9 1261.9 1265.0 1265.7 5914.9 5935.7 5938.7 5943.5 5943.9 6080.9 6236.4 6248.7 6270.8 6278.9 5865.3 5888.9 5893.0 5914.0 5917.5 3232.4 3310.4 3316.9 3336.8 3359.2 6567.0 6571.2 6573.8 6597.5 6605.0 6400.6 6401.6 6409.4 6412.1 6444.5 6391.9 6539.7 6560.8 6562.4 6630.3 6249.6 6254.2 6257.6 6268.4 6280.4 5969.4 6114.8 6204.8 6226.0 6244.3 6391.5 6443.1 6447.0 6454.8 6459.0 4880.3 4881.5 4887.4 4893.3 4896.7 6169.2 6311.0 6319.3 6330.4 6348.4 6160.3 6160.5 6164.4 6178.2 6190.0 5985.2 6145.9 6164.0 6174.7 6195.0 6164.3 6167.9 6168.4 6169.8 6173.4 5965.9 6202.0 6221.5 6223.5 6224.8 5907.0 5959.1 5972.5 5973.2 5986.1 08:13:24 INFO - PID 32340 | 08:13:24 INFO - PID 32340 | [#5] yui.html Cycles:180 Average:18659.33 Median:32237.77 stddev:22989.10 (71.3%) stddev-sans-first:23014.69 08:13:24 INFO - PID 32340 | Values: 849.9 859.9 865.6 867.3 876.1 16876.7 17134.5 17389.9 17405.7 17428.3 14898.3 15094.2 15120.6 15121.5 15169.0 947.8 950.4 956.9 958.8 962.2 951.4 979.0 991.0 991.6 999.4 1049.9 1052.0 1053.5 1056.6 1059.3 1036.2 1039.2 1039.7 1040.9 1042.9 766.7 768.7 768.7 770.2 771.6 16875.5 16996.4 17044.5 17751.4 17905.0 18815.5 18901.9 18975.5 18999.1 19230.4 13763.7 13779.1 13909.7 14084.1 14090.6 3485.4 3520.5 3527.9 3529.2 3529.2 94754.5 95292.5 95503.5 95721.0 97213.5 13904.5 13935.7 14052.5 14110.2 14217.9 27316.6 27579.6 27786.0 28028.0 28048.3 8219.0 8228.4 8235.6 8347.6 8360.4 4005.7 4082.0 4088.9 4092.8 4095.8 4535.8 4544.9 4589.1 4605.3 4636.5 838.5 858.0 867.0 869.5 871.1 691.6 695.5 709.0 718.1 727.9 10008.2 10166.1 10352.9 10399.9 10662.4 701.3 714.2 714.3 716.2 724.8 4840.0 4848.2 4879.5 4927.9 5014.3 70043.0 70527.3 72750.6 76075.2 79004.6 66437.0 67346.3 68763.7 69578.0 69614.7 60541.4 61388.1 61518.0 61944.7 62026.0 11012.7 11622.1 11694.9 11754.5 11762.5 32143.2 32332.4 32521.0 32797.0 33775.0 51867.2 53615.5 54148.7 55587.0 56722.4 16559.6 16633.9 17297.7 17491.8 17520.0 16895.2 17193.7 17589.0 17901.2 18015.5 15602.5 16064.8 16074.7 16289.5 16296.3 15033.4 15214.3 15418.9 15598.1 15924.0 15266.1 15341.9 15781.2 15990.0 16237.4 11195.0 11236.4 11285.7 11438.4 11628.9 12341.4 12710.1 12763.4 12799.9 12809.4 08:13:24 INFO - PID 32340 | -------- Summary: end -------- 08:13:24 INFO - PID 32340 | 08:13:25 INFO - TEST-INFO | 32340: exit 0 08:13:25 INFO - TEST-OK | dromaeo_css | took 1116412ms 08:13:25 INFO - TEST-START | kraken 08:13:25 INFO - operating with platform_type : linux_ 08:13:25 INFO - Initialising browser for kraken test... 08:13:25 INFO - TEST-INFO | started process 32675 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHU_HBY/profile http://localhost:46425/getInfo.html) 08:13:29 INFO - PID 32675 | __metrics Screen width/height:1600/1200 08:13:29 INFO - PID 32675 | colorDepth:24 08:13:29 INFO - PID 32675 | Browser inner width/height: 1024/695 08:13:29 INFO - PID 32675 | __metrics 08:13:30 INFO - PID 32675 | 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" 08:13:30 INFO - PID 32675 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:13:31 INFO - TEST-INFO | 32675: exit 0 08:13:31 INFO - Browser initialized. 08:13:31 INFO - Running cycle 1/1 for kraken test... 08:13:31 INFO - TEST-INFO | started process 303 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHU_HBY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:13:43 INFO - PID 303 | RSS: Main: 145002496 08:13:43 INFO - PID 303 | 08:13:45 INFO - PID 303 | Cycle 1(1): loaded http://localhost:46425/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46425/tests/kraken/driver.html?testName=audio-beat-detection) 08:13:46 INFO - PID 303 | RSS: Main: 217227264 08:13:46 INFO - PID 303 | 08:13:49 INFO - PID 303 | Cycle 1(1): loaded http://localhost:46425/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46425/tests/kraken/driver.html?testName=audio-dft) 08:13:49 INFO - PID 303 | RSS: Main: 178790400 08:13:49 INFO - PID 303 | 08:13:52 INFO - PID 303 | Cycle 1(1): loaded http://localhost:46425/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46425/tests/kraken/driver.html?testName=audio-fft) 08:13:53 INFO - PID 303 | RSS: Main: 260681728 08:13:53 INFO - PID 303 | 08:13:55 INFO - PID 303 | Cycle 1(1): loaded http://localhost:46425/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46425/tests/kraken/driver.html?testName=audio-oscillator) 08:13:55 INFO - PID 303 | RSS: Main: 172642304 08:13:55 INFO - PID 303 | 08:13:57 INFO - PID 303 | Cycle 1(1): loaded http://localhost:46425/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46425/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:13:58 INFO - PID 303 | RSS: Main: 174788608 08:13:58 INFO - PID 303 | 08:14:01 INFO - PID 303 | Cycle 1(1): loaded http://localhost:46425/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46425/tests/kraken/driver.html?testName=imaging-darkroom) 08:14:02 INFO - PID 303 | RSS: Main: 235855872 08:14:02 INFO - PID 303 | 08:14:05 INFO - PID 303 | Cycle 1(1): loaded http://localhost:46425/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46425/tests/kraken/driver.html?testName=imaging-desaturate) 08:14:06 INFO - PID 303 | RSS: Main: 250712064 08:14:06 INFO - PID 303 | 08:14:08 INFO - PID 303 | Cycle 1(1): loaded http://localhost:46425/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46425/tests/kraken/driver.html?testName=json-parse-financial) 08:14:09 INFO - PID 303 | RSS: Main: 261107712 08:14:09 INFO - PID 303 | 08:14:10 INFO - PID 303 | Cycle 1(1): loaded http://localhost:46425/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46425/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:14:11 INFO - PID 303 | RSS: Main: 198545408 08:14:11 INFO - PID 303 | 08:14:13 INFO - PID 303 | Cycle 1(1): loaded http://localhost:46425/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46425/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:14:13 INFO - PID 303 | RSS: Main: 203517952 08:14:13 INFO - PID 303 | 08:14:15 INFO - PID 303 | Cycle 1(1): loaded http://localhost:46425/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46425/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:14:16 INFO - PID 303 | RSS: Main: 213204992 08:14:16 INFO - PID 303 | 08:14:18 INFO - PID 303 | Cycle 1(1): loaded http://localhost:46425/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46425/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:14:19 INFO - PID 303 | RSS: Main: 216944640 08:14:19 INFO - PID 303 | 08:14:22 INFO - PID 303 | Cycle 1(1): loaded http://localhost:46425/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46425/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:14:23 INFO - PID 303 | RSS: Main: 217145344 08:14:23 INFO - PID 303 | 08:14:24 INFO - PID 303 | Cycle 1(1): loaded http://localhost:46425/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46425/tests/kraken/driver.html?testName=ai-astar) 08:14:24 INFO - PID 303 | RSS: Main: 267710464 08:14:24 INFO - PID 303 | 08:14:24 INFO - PID 303 | __start_tp_report 08:14:24 INFO - PID 303 | _x_x_mozilla_page_load 08:14:24 INFO - PID 303 | _x_x_mozilla_page_load_details 08:14:24 INFO - PID 303 | |i|pagename|runs| 08:14:24 INFO - PID 303 | |0;ai-astar;101;110;110;110;110;111;109;110;112;110 08:14:24 INFO - PID 303 | |1;audio-beat-detection;144;116;119;179;120;118;121;117;139;116 08:14:24 INFO - PID 303 | |2;audio-dft;160;162;160;162;160;161;162;161;161;160 08:14:24 INFO - PID 303 | |3;audio-fft;78;75;74;119;74;74;75;74;93;74 08:14:24 INFO - PID 303 | |4;audio-oscillator;82;82;112;82;82;82;99;82;81;111 08:14:24 INFO - PID 303 | |5;imaging-gaussian-blur;112;112;113;113;113;113;113;113;113;113 08:14:24 INFO - PID 303 | |6;imaging-darkroom;146;146;147;146;147;146;146;146;146;145 08:14:24 INFO - PID 303 | |7;imaging-desaturate;96;93;94;94;94;94;94;94;93;93 08:14:24 INFO - PID 303 | |8;json-parse-financial;46;46;48;45;46;47;47;47;46;47 08:14:24 INFO - PID 303 | |9;json-stringify-tinderbox;54;54;54;54;55;55;56;55;55;56 08:14:24 INFO - PID 303 | |10;stanford-crypto-aes;78;79;80;81;78;80;78;78;85;79 08:14:24 INFO - PID 303 | |11;stanford-crypto-ccm;129;127;133;125;122;128;122;124;205;121 08:14:24 INFO - PID 303 | |12;stanford-crypto-pbkdf2;173;188;181;187;171;177;189;184;187;191 08:14:24 INFO - PID 303 | |13;stanford-crypto-sha256-iterative;65;67;67;65;65;65;65;64;63;65 08:14:24 INFO - PID 303 | __end_tp_report 08:14:24 INFO - PID 303 | __start_cc_report 08:14:24 INFO - PID 303 | _x_x_mozilla_cycle_collect,1665 08:14:24 INFO - PID 303 | __end_cc_report 08:14:24 INFO - PID 303 | __startTimestamp1494602064956__endTimestamp 08:14:24 INFO - PID 303 | 08:14:24 INFO - PID 303 | ------- Summary: start ------- 08:14:24 INFO - PID 303 | Number of tests: 14 08:14:24 INFO - PID 303 | 08:14:24 INFO - PID 303 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.00 stddev:3.02 (2.7%) stddev-sans-first:0.83 08:14:24 INFO - PID 303 | Values: 101.0 110.0 110.0 110.0 110.0 111.0 109.0 110.0 112.0 110.0 08:14:24 INFO - PID 303 | 08:14:24 INFO - PID 303 | [#1] audio-beat-detection Cycles:10 Average:128.90 Median:120.50 stddev:20.20 (16.8%) stddev-sans-first:20.67 08:14:24 INFO - PID 303 | Values: 144.0 116.0 119.0 179.0 120.0 118.0 121.0 117.0 139.0 116.0 08:14:24 INFO - PID 303 | 08:14:24 INFO - PID 303 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.87 08:14:24 INFO - PID 303 | Values: 160.0 162.0 160.0 162.0 160.0 161.0 162.0 161.0 161.0 160.0 08:14:24 INFO - PID 303 | 08:14:24 INFO - PID 303 | [#3] audio-fft Cycles:10 Average:81.00 Median:74.50 stddev:14.58 (19.6%) stddev-sans-first:15.43 08:14:24 INFO - PID 303 | Values: 78.0 75.0 74.0 119.0 74.0 74.0 75.0 74.0 93.0 74.0 08:14:24 INFO - PID 303 | 08:14:24 INFO - PID 303 | [#4] audio-oscillator Cycles:10 Average:89.50 Median:82.00 stddev:12.77 (15.6%) stddev-sans-first:13.26 08:14:24 INFO - PID 303 | Values: 82.0 82.0 112.0 82.0 82.0 82.0 99.0 82.0 81.0 111.0 08:14:24 INFO - PID 303 | 08:14:24 INFO - PID 303 | [#5] imaging-gaussian-blur Cycles:10 Average:112.80 Median:113.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 08:14:24 INFO - PID 303 | Values: 112.0 112.0 113.0 113.0 113.0 113.0 113.0 113.0 113.0 113.0 08:14:24 INFO - PID 303 | 08:14:24 INFO - PID 303 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 08:14:24 INFO - PID 303 | Values: 146.0 146.0 147.0 146.0 147.0 146.0 146.0 146.0 146.0 145.0 08:14:24 INFO - PID 303 | 08:14:24 INFO - PID 303 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.88 (0.9%) stddev-sans-first:0.50 08:14:24 INFO - PID 303 | Values: 96.0 93.0 94.0 94.0 94.0 94.0 94.0 94.0 93.0 93.0 08:14:24 INFO - PID 303 | 08:14:24 INFO - PID 303 | [#8] json-parse-financial Cycles:10 Average:46.50 Median:47.00 stddev:0.85 (1.8%) stddev-sans-first:0.88 08:14:24 INFO - PID 303 | Values: 46.0 46.0 48.0 45.0 46.0 47.0 47.0 47.0 46.0 47.0 08:14:24 INFO - PID 303 | 08:14:24 INFO - PID 303 | [#9] json-stringify-tinderbox Cycles:10 Average:54.80 Median:55.00 stddev:0.79 (1.4%) stddev-sans-first:0.78 08:14:24 INFO - PID 303 | Values: 54.0 54.0 54.0 54.0 55.0 55.0 56.0 55.0 55.0 56.0 08:14:24 INFO - PID 303 | 08:14:24 INFO - PID 303 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:79.50 stddev:2.17 (2.7%) stddev-sans-first:2.22 08:14:24 INFO - PID 303 | Values: 78.0 79.0 80.0 81.0 78.0 80.0 78.0 78.0 85.0 79.0 08:14:24 INFO - PID 303 | 08:14:24 INFO - PID 303 | [#11] stanford-crypto-ccm Cycles:10 Average:133.60 Median:127.50 stddev:25.36 (19.9%) stddev-sans-first:26.84 08:14:24 INFO - PID 303 | Values: 129.0 127.0 133.0 125.0 122.0 128.0 122.0 124.0 205.0 121.0 08:14:24 INFO - PID 303 | 08:14:24 INFO - PID 303 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.80 Median:187.00 stddev:7.00 (3.7%) stddev-sans-first:6.47 08:14:24 INFO - PID 303 | Values: 173.0 188.0 181.0 187.0 171.0 177.0 189.0 184.0 187.0 191.0 08:14:24 INFO - PID 303 | 08:14:24 INFO - PID 303 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.00 stddev:1.20 (1.8%) stddev-sans-first:1.27 08:14:24 INFO - PID 303 | Values: 65.0 67.0 67.0 65.0 65.0 65.0 65.0 64.0 63.0 65.0 08:14:24 INFO - PID 303 | -------- Summary: end -------- 08:14:24 INFO - PID 303 | 08:14:26 INFO - TEST-INFO | 303: exit 0 08:14:26 INFO - TEST-OK | kraken | took 61065ms 08:14:26 INFO - SUITE-END | took 1177s 08:14:26 INFO - Completed test suite (00:19:37) 08:14:26 INFO - javascript benchmark 08:14:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7640.445686551623, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3353.480210567362, 3371.258323168902, 3382.847771850268, 3384.1708781348557, 3399.116229780258, 5690.118031705082, 5804.477597016267, 5831.3293971193325, 5833.824985250439, 5868.794592189269, 5766.0, 5784.074548072309, 5792.218050563172, 5836.649801011942, 5920.437558431953, 4764.833230836922, 5038.319826823387, 5137.537621614054, 5204.531592156705, 5245.160774276116, 5181.145111056671, 5191.221316802491, 5272.367315922094, 5273.525382715555, 5274.630775845692, 5068.391792984847, 5130.179171332569, 5158.871028224287, 5188.118019936582, 5238.083335416325, 5180.766865491062, 5190.532852043334, 5201.635885488017, 5204.583633309364, 5262.657927234717, 5141.0, 5192.61055420845, 5195.558377537914, 5197.454267301917, 5227.921581176285, 5657.12314591239, 5687.744051517691, 5718.59969802114, 5720.399358067426, 5820.941790582082, 6145.924463218918, 6155.292141403751, 6156.415140561639, 6159.3224745277985, 6162.13730077785, 6130.298782221731, 6170.907436388457, 6192.907106393408, 6196.47329976948, 6197.690115494207, 5825.126231065374, 5847.532197424196, 5894.233749612566, 5900.468957793776, 5928.940710592925, 6476.6114033158165, 6478.093066970534, 6480.287168411471, 6489.545731798823, 6490.286068532458, 6069.817905462844, 6100.490342048369, 6102.701334035102, 6110.541709371815, 6196.659183744938, 6191.938080619136, 6233.34549872266, 6234.251889773256, 6238.719257633417, 6240.781572644935, 6065.484433823174, 6195.721192546346, 6204.503639708812, 6237.0, 6238.157848690369, 6148.569600127948, 6155.045967874987, 6160.845978850475, 6172.4136207060255, 6173.722182501798, 4691.601213896857, 4710.0, 4712.528747125329, 4714.127886341038, 4714.5992590630185, 4186.874393768192, 4237.279662457389, 4273.102648443862, 4280.743155410623, 4281.272183728774, 5824.475797178275, 5864.325602555676, 5866.530677545786, 5885.529157667376, 5894.204282421904, 6211.3167551569295, 6230.252369715663, 6243.063540468966, 6270.9372906270355, 6310.400511951358, 5927.1405646181065, 5929.4070592941225, 5932.851678707981, 5940.049592065336, 5996.13056106862, 5244.737763111829, 5304.23088652151, 5312.867178320495, 5314.548263397577, 5320.733963301819, 6467.644279564575, 6522.0, 6568.67156642166, 6572.0, 6576.0, 6329.335419780857, 6355.1420558224045, 6358.90461643085, 6373.936260637334, 6382.904256436064, 6706.228783689938, 6707.966460167668, 6710.027046078389, 6713.194416669836, 6724.361185687352, 6088.360722124113, 6114.3277820888225, 6122.428649698624, 6243.469305109116, 6258.468030217483, 6185.257769067561, 6300.464460520724, 6308.179936608395, 6314.652694101868, 6334.524910631629, 6098.969505152446, 6150.10823430609, 6151.84620384494, 6154.261488621394, 6159.938400616115, 6125.84685382869, 6129.049997250433, 6134.0, 6143.201383820075, 6143.84640383994, 5945.64326140433, 6003.249593800775, 6023.518118550418, 6035.0, 6104.4200800923845, 6129.664444256008, 6132.336724663555, 6138.138078135459, 6146.5390095742105, 6147.0779383092895, 5945.762169513171, 5947.791827286024, 5980.641161530322, 5988.520918326611, 6037.245344331958], "value": 5733.198946195895, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [749.7226026370244, 799.6361655446773, 817.3951276055718, 1143.091242462242, 1145.37004647444, 29612.40775184495, 36769.26461470769, 37280.81359593205, 37412.43881341782, 37427.438588421195, 38910.80544597273, 38997.8050109749, 39235.0, 39292.410613840744, 39361.0, 5556.305461817273, 5686.31764188298, 7034.85930281394, 7174.139103307611, 7178.49750517464, 6961.617111058889, 7084.43324534036, 7110.395616372589, 7115.501914865961, 7116.822079448029, 7148.213696493382, 7212.60330681815, 7230.674619642129, 7235.819104522377, 7237.457190710717, 7129.5365801223015, 7170.103737032871, 7173.820654483654, 7177.748778792769, 7183.784486465414, 7099.148102227714, 7130.5365151265005, 7139.571625702474, 7149.106361704787, 7153.821154471128, 35377.823110884536, 35436.29127417463, 35539.78053840593, 35568.466473002925, 35592.0, 3489.5114683944266, 3525.0834782956617, 3538.6992105671047, 3539.681428671406, 3540.451230059319, 27486.312842178904, 27529.174124776087, 27534.173974780788, 27574.310642233904, 27599.724002759915, 3740.989932718178, 3743.8315275812383, 3783.5838057813617, 3784.5836957934607, 3829.5787463379006, 189571.0, 191232.0, 191351.0, 191595.0, 191845.0, 46784.5321546787, 46825.76587117043, 46969.295460568115, 47067.0, 47140.5285947143, 49908.0, 49924.75037624789, 49998.75000625046, 50034.749826250634, 50124.24813627799, 13749.518766843112, 13864.722705545833, 13870.364630720333, 13872.930635346758, 13875.653108672364, 10278.33190842593, 10386.584536618451, 11429.428528573539, 11569.6529104127, 11579.88420115788, 13688.93155534216, 13711.177329360271, 13723.656908577366, 13880.23658698761, 13910.234937078356, 5373.919391209135, 5391.973040134774, 5436.0, 5479.726013699299, 5533.280673512498, 1062.3785085724937, 1098.1983152298867, 1102.7298311913632, 1109.545086514525, 1122.4780477078198, 24426.877865610913, 24473.63289550658, 24579.508409831702, 24594.877025614758, 24627.753722462545, 1184.549871049013, 1194.8805119488156, 1199.1426130316866, 1214.4534959268365, 1227.2820400066062, 12833.165844220282, 13017.284049377375, 13118.672033199246, 13137.34313284332, 13179.802302965463, 212357.0, 212400.0, 213468.0, 214485.0, 215302.0, 49846.0, 49869.0, 49926.750366247936, 50076.248856267186, 50078.49921500811, 1485.9405623774928, 1514.2277438506221, 1539.95380138596, 1542.1980570103483, 1547.7678348247853, 23534.058637654303, 24233.636495452934, 24582.262532124067, 24731.258062258163, 24899.253022408633, 38293.617063829006, 38308.616913830505, 38341.80829095837, 38366.0, 38406.6159338403, 188684.0, 188924.0, 189015.0, 189019.0, 189995.0, 29274.268143296587, 29786.702132978393, 31726.206844829063, 32605.347893041533, 33198.83400582981, 37576.0, 38925.805370972965, 39094.4135837957, 39281.803590981865, 39371.409428858016, 29363.85318073396, 29564.852175738983, 29788.702112978594, 29960.101196964126, 30135.095947121623, 29435.558466622588, 29668.851655741582, 29831.403371932873, 30398.696013039586, 30410.391792164475, 34304.485432719026, 34471.82764086264, 34666.0, 34798.82600586981, 35086.82456587701, 28144.43711125807, 28526.0, 28818.567721483774, 29310.0, 29524.704752952195, 22847.0, 24168.274951751475, 24189.75810241875, 24210.88414969424, 24693.87653061723], "value": 16339.924540934344, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [437.13665510616556, 445.30310064748664, 449.7211728728189, 456.89034631688406, 464.3151351756159, 18416.447506574823, 19668.90165549172, 20298.289559865407, 20403.897980510093, 20518.179272829067, 20266.797332026676, 21086.789132108675, 21118.472038199052, 21238.787612123913, 21630.3510894673, 5512.228288039678, 5702.6863522506455, 5710.114932185518, 5710.971445142768, 5720.914186287209, 5424.0, 5493.7802487900435, 5515.0, 5558.833235002936, 5567.164925261202, 5540.445955404468, 5546.500814926656, 5551.306086739158, 5556.499915007648, 5557.083081291582, 5336.386315573701, 5509.338879334486, 5514.91727624086, 5532.2531458253225, 5549.278593782782, 5071.112555302844, 5074.264231686422, 5080.618953578496, 5081.237814327844, 5082.1106306396605, 24564.877175614187, 24915.377115572075, 24992.750072499224, 25108.24675259745, 25190.0, 2162.653975363934, 2190.6823510590875, 2196.7254093238344, 2197.8021978021893, 2198.8350873684376, 16832.57918552034, 17496.737548936777, 17510.387136450292, 17640.647187056187, 17647.823521764745, 2094.7381577302835, 2103.1587365053947, 2158.104386679526, 2164.6536554151417, 2185.7923497267734, 93044.53477732568, 94590.99999999932, 95411.52294238553, 96718.0, 97745.0, 12391.690207744878, 12525.498980040697, 12831.743365132645, 12919.677008074874, 12957.093003489665, 18167.63664726698, 18197.09014549267, 18217.544561385806, 18227.26591011359, 18263.72604410935, 8584.828303433897, 8699.43453675509, 8872.0, 8876.20114189726, 8954.955225223832, 7817.765467035998, 7947.761567152995, 7982.962214912141, 8122.431429799975, 8131.308838748772, 7909.20907909216, 7987.520748755093, 8025.400725168923, 8208.876866847002, 8225.259726624632, 2220.7890250426185, 2222.75549689534, 2238.5634801213605, 2251.8311126665567, 2286.725592928859, 1077.8359371878353, 1095.4139535348709, 1104.094642393246, 1106.6790630717162, 1113.2763703592568, 19087.809121908882, 19456.8054319455, 20294.18823247083, 20685.89657051735, 20895.582088358147, 1113.4377139544479, 1120.7417054634918, 1122.354646078508, 1124.7356871135278, 1148.064327573042, 10825.242233043611, 11106.278091924, 11182.66452006441, 11299.627078313646, 11412.201145919706, 466331.0, 468661.0, 469467.0, 472674.0, 478719.0, 91432.0, 95805.0, 96449.0, 96967.51516242514, 98202.0, 1212.2120621596034, 1235.2711899979056, 1269.707967167538, 1275.8915492183269, 1285.370168617352, 20196.29312974039, 20508.58982820365, 20816.895915520327, 20928.895355523124, 21259.36221913345, 43961.0, 44759.0, 45259.0, 45364.31953520634, 45510.54489455063, 55571.0, 57292.42707572871, 57465.71267143638, 57809.0, 59100.0, 9454.480003599592, 9584.185344245818, 9663.903360966582, 9714.368566043184, 10061.69814905554, 14647.340869660678, 14690.0, 14807.481738139113, 14862.405503779728, 15562.0, 12628.747425051632, 12891.419886105336, 12935.482580696667, 13076.346182691017, 13280.335983200994, 12168.391580421121, 12494.0004799614, 12575.93712031434, 12703.42834572428, 12870.099093063396, 12983.675408114495, 13019.153755005895, 13422.127561708458, 13611.387487562886, 13949.0, 9496.905030949601, 9608.231341492803, 9653.46905920181, 9697.0, 9913.851292230478, 12974.740505190031, 13063.934680326918, 13161.53934612284, 13293.734125317245, 13450.86549134496], "value": 10162.807353381872, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1190.6368557589942, 1312.304478626328, 1368.1107280267825, 1381.6062422209673, 1391.4573316406609, 9899.950500247498, 11198.272112312694, 11552.306861588311, 11756.7648647027, 11810.940945295262, 11563.53745850167, 11643.243189192717, 11650.592229271977, 11665.066794656428, 11677.299362038284, 2392.976070239297, 2432.683751112353, 2437.695288088989, 2437.9756202437925, 2438.67077944477, 2096.790320967906, 2151.4298710841563, 2348.1429278313376, 2441.5361081394476, 2454.754524547549, 2440.9511809763794, 2463.8521688698734, 2469.715982661999, 2471.9752802472017, 2472.4807790363957, 2423.0307876849224, 2445.1075357494565, 2447.79193768529, 2448.4123810285405, 2452.509498100378, 2313.9421514462106, 2344.39045848079, 2346.7093098795763, 2347.248880358286, 2352.1061996441413, 11142.27575207609, 11332.660020199408, 11355.432228388547, 11357.829632555518, 11362.0, 6449.12936753537, 6624.370684784938, 6639.435647969928, 6648.634325112117, 6682.732690692366, 3889.3388124018984, 4101.364288535282, 4183.560726123774, 4200.789960501963, 4203.642690371322, 1347.1311004402105, 1361.7276544691003, 1409.8429403013406, 1415.716856628668, 1445.4724025730532, 17448.389306374214, 17623.295068197258, 17655.0, 17664.735028974577, 17675.116244187866, 5461.754221060062, 5602.4957753802355, 5749.281339832521, 5760.279965004374, 5783.2192653992015, 14289.785653215211, 14308.213048282445, 14311.0, 14329.283535823168, 14333.713325733635, 6149.600275982047, 6482.481401487964, 6494.253160886464, 6500.837479063061, 6508.739650414025, 5848.766049358063, 5861.970690146607, 5862.765489380462, 5879.764809407576, 5884.852878677982, 4140.834366625301, 4294.227039132986, 4543.38664280318, 4615.576822168321, 4655.674102812838, 1352.0, 1385.8267716535433, 1387.091455096913, 1392.679683672761, 1397.0, 841.7180244617999, 864.3819668936741, 875.0505701314019, 884.1644645809648, 903.6972614174193, 6326.841828954221, 6387.808365749035, 6430.356964303533, 6434.067060276234, 6439.291677915426, 946.947917864524, 959.9664011759695, 963.1235575626287, 968.2205824311496, 977.8142152990908, 4280.636145927631, 4475.545447729501, 4486.371907932892, 4516.23224051912, 4693.366395536627, 15085.54743357679, 15200.46798362052, 15601.0, 15636.0, 15643.921780391025, 15036.323365448581, 15301.846981530041, 15333.923330383277, 15370.615734606725, 15495.690086198212, 9332.206762425134, 9422.199113075329, 9495.525223738785, 9545.140937315537, 9551.379160354554, 6776.661166941534, 6805.149356330458, 6805.829854253683, 6818.8636227276165, 6946.235914049349, 13331.33343332849, 13483.05618606688, 13778.448862045807, 13806.65483362924, 13820.37808298649, 13688.110272832235, 13842.515511957034, 13868.0, 14102.929485352508, 14123.43506259738, 9417.199538039344, 9423.764405889908, 9516.571754270935, 9521.61913523479, 9586.890884005508, 9799.265055120752, 10028.448435336126, 10851.945740271563, 10906.563737450413, 11128.276662016942, 9416.717498475056, 9446.338756286994, 9448.196903263299, 9610.759731006781, 9768.56041478121, 9275.2579793615, 9287.953560232427, 9313.39462934907, 9350.906490935004, 9493.477858717837, 8473.110323416198, 8501.064882863004, 8583.484990900566, 8672.436291641023, 8685.305175586065, 5839.726984095556, 5950.464458198783, 6056.939430605637, 6089.725962331794, 6160.291566469734, 6012.488938440281, 6021.2473440819895, 6039.094135879477, 6096.5732398733435, 6136.815895523141], "value": 5475.795061859149, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.67212738000666, 419.5552714123029, 429.1974008603911, 429.59188770667856, 435.25788530555405, 5710.343310519292, 5845.123231515269, 5856.76572937082, 5881.5294776417895, 5882.205902203206, 5706.942930570693, 5718.571107166968, 5727.484526392624, 5750.654960702361, 5775.10485874689, 4249.405083288342, 4380.89047773805, 4389.517153113155, 4406.096750166208, 4564.246899261626, 4388.144311859189, 4400.97799511002, 4405.6695747818885, 4406.65596992917, 4407.757573333465, 4351.934720979188, 4363.410939523172, 4369.497507786597, 4378.605925466707, 4389.890252743675, 4336.392904993303, 4341.696081274312, 4375.453068366454, 4386.56134386562, 4411.345745345496, 3819.8090095495113, 3820.847166113352, 3834.5398552173638, 3836.1943991761764, 3837.0982819037504, 5627.915581266284, 5641.605087643867, 5651.463111004489, 5652.604317697763, 5659.773609055633, 5057.544820966131, 5091.974540127313, 5126.7183204198955, 5140.434552199255, 5170.983316506566, 6086.847828804271, 6103.35914728956, 6105.023196288573, 6118.592723673535, 6128.295246046672, 4266.50672264708, 4299.50555686097, 4312.072904325553, 4316.115196384733, 4323.437953066113, 6086.391360863922, 6189.2572891252885, 6273.466755325803, 6408.423241908204, 6439.259485159219, 4798.1123492154065, 4850.320955066293, 4890.559849613481, 4904.705717656952, 4917.286993385939, 4953.90092198154, 4962.727050012212, 4964.0, 4972.950270497321, 4973.1297023020825, 5386.13821788512, 5394.829208549212, 5433.239346491494, 5440.809571665052, 5440.891182176334, 6112.908306375319, 6163.84590385244, 6167.599106058092, 6183.536234782319, 6186.721597528122, 1701.8298170182882, 1703.9574010649833, 1718.0293134379035, 1718.089412611318, 1731.6450127723785, 1252.8872401483911, 1258.8804063613943, 1261.867503912076, 1265.0, 1265.677252300676, 5914.940850591525, 5935.703214839241, 5938.703064846827, 5943.465088142001, 5943.940560594425, 6080.878382432326, 6236.407541283571, 6248.687565621701, 6270.805218173603, 6278.937210627927, 5865.325487568899, 5888.882222355529, 5893.0, 5913.970430147908, 5917.467427931507, 3232.3696879108347, 3310.427546915196, 3316.8673253070087, 3336.849841757078, 3359.2441700617164, 6567.0, 6571.211454625475, 6573.769918052845, 6597.538172327987, 6605.0, 6400.647964361911, 6401.583897046677, 6409.391107844747, 6412.134361861183, 6444.484441244689, 6391.904121438182, 6539.673016349164, 6560.770373036826, 6562.376574225441, 6630.336511805701, 6249.625022498664, 6254.21822272216, 6257.5932564383165, 6268.435840774352, 6280.371962803683, 5969.432903874125, 6114.755409783559, 6204.81385558434, 6226.0, 6244.250689917239, 6391.456726178327, 6443.097966284818, 6447.0, 6454.806355809334, 6459.0, 4880.292357608056, 4881.511848815232, 4887.413510378778, 4893.339399181065, 4896.681715688469, 6169.167162433194, 6310.968445157929, 6319.2622028942405, 6330.430261276507, 6348.396902294275, 6160.291566469913, 6160.476359509492, 6164.383561643979, 6178.196834411678, 6189.96905015472, 5985.191999080069, 6145.877082458236, 6164.044573091178, 6174.722137503913, 6195.0, 6164.291106522807, 6167.938320616916, 6168.383161683796, 6169.81490555284, 6173.41352571505, 5965.850853728692, 6202.0, 6221.5333849960525, 6223.533235007302, 6224.751009959551, 5907.0, 5959.0763431668165, 5972.492338151305, 5973.193618861398, 5986.07215881539], "value": 4744.327648287857, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [849.8810166576684, 859.9183077607629, 865.5585651317826, 867.2758246863867, 876.084491706167, 16876.746848797247, 17134.48596542104, 17389.913050434745, 17405.738913916302, 17428.302867885286, 14898.255087245621, 15094.16982065986, 15120.621984450394, 15121.470748523803, 15169.014014089076, 947.829390709672, 950.4059962523423, 956.942583444992, 958.7555173430766, 962.1773383756893, 951.4053716427233, 978.9510524473783, 990.9554070066828, 991.6231831903866, 999.3504222255519, 1049.942253176075, 1051.9579216831316, 1053.5048527192207, 1056.6037735849056, 1059.2585190366735, 1036.19694736579, 1039.2309690828808, 1039.656913218636, 1040.8646875906122, 1042.8852826189113, 766.7431410477496, 768.6771555946516, 768.6963649358472, 770.249007217958, 771.5910567399287, 16875.493735187963, 16996.40512582066, 17044.48866534006, 17751.378701745376, 17905.0, 18815.529611759677, 18901.905490472596, 18975.525611859677, 18999.05004749771, 19230.423087307405, 13763.655908602264, 13779.104358216784, 13909.652258693512, 14084.084534505224, 14090.577282681536, 3485.372632926072, 3520.471929210639, 3527.8588856445713, 3529.1530032792202, 3529.205928666055, 94754.52622736842, 95292.52353738256, 95503.52248238784, 95721.0, 97213.51393242988, 13904.51334203298, 13935.651608709863, 14052.508162214273, 14110.153390796586, 14217.928910355382, 27316.59025114625, 27579.586306205423, 27786.0, 28028.0, 28048.29879253035, 8219.0, 8228.42401031934, 8235.629396677165, 8347.624356903954, 8360.372972027122, 4005.739626924299, 4081.9999100220634, 4088.9182216356103, 4092.815823287959, 4095.7542547447247, 4535.841245556456, 4544.909101817945, 4589.128065667513, 4605.286180642006, 4636.466806317249, 838.4969018588798, 858.043281740867, 867.0332579174176, 869.5087275689216, 871.1419252036738, 691.560858854631, 695.4679670052413, 709.0109297529917, 718.1489934427719, 727.9090113735783, 10008.199344052458, 10166.085052345177, 10352.896471035343, 10399.896001040044, 10662.360258384522, 701.2706784943704, 714.1822613107962, 714.2678754276803, 716.2479396633514, 724.77169691547, 4839.951600484021, 4848.200046992278, 4879.4876537963, 4927.926081108786, 5014.34813474246, 70043.0, 70527.29472705207, 72750.63624681842, 76075.23924760793, 79004.60497697475, 66437.0, 67346.326536734, 68763.65618171977, 69578.0, 69614.65192674004, 60541.394586054455, 61388.07917881235, 61518.0, 61944.69027654923, 62026.0, 11012.724681883017, 11622.128340374336, 11694.9482738811, 11754.532412938033, 11762.470688819194, 32143.196420089684, 32332.35335293328, 32521.0, 32797.0, 33775.0, 51867.2219916694, 53615.463845361046, 54148.729256353465, 55587.0, 56722.43277567172, 16559.586010349838, 16633.916830416256, 17297.65404691874, 17491.825081749528, 17520.0, 16895.155242238085, 17193.656126877642, 17589.0, 17901.19444624969, 18015.549611259823, 15602.531924041843, 16064.759028614346, 16074.67850643004, 16289.51131466058, 16296.348146074024, 15033.398664053753, 15214.315355808794, 15418.922905385401, 15598.064116153068, 15924.0, 15266.084034957938, 15341.923290383476, 15781.21093945321, 15990.040597564184, 16237.350505979628, 11195.0, 11236.381998990135, 11285.661430157108, 11438.428078596204, 11628.94185529067, 12341.382930853242, 12710.110292279822, 12763.425645846144, 12799.872001279868, 12809.359532023547], "value": 8042.678118561404, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1484.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 110.0, 110.0, 110.0, 111.0, 109.0, 110.0, 112.0, 110.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 116.0, 119.0, 179.0, 120.0, 118.0, 121.0, 117.0, 139.0, 116.0], "value": 128.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 160.0, 162.0, 160.0, 161.0, 162.0, 161.0, 161.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 74.0, 119.0, 74.0, 74.0, 75.0, 74.0, 93.0, 74.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 112.0, 82.0, 82.0, 82.0, 99.0, 82.0, 81.0, 111.0], "value": 89.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0], "value": 112.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 93.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 46.0, 48.0, 45.0, 46.0, 47.0, 47.0, 47.0, 46.0, 47.0], "value": 46.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 55.0, 55.0, 56.0, 55.0, 55.0, 56.0], "value": 54.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 80.0, 81.0, 78.0, 80.0, 78.0, 78.0, 85.0, 79.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 127.0, 133.0, 125.0, 122.0, 128.0, 122.0, 124.0, 205.0, 121.0], "value": 133.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 188.0, 181.0, 187.0, 171.0, 177.0, 189.0, 184.0, 187.0, 191.0], "value": 182.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 67.0, 65.0, 65.0, 65.0, 65.0, 64.0, 63.0, 65.0], "value": 65.1, "unit": "score"}]}]} 08:14:26 INFO - Return code: 0 08:14:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:14:26 INFO - # TBPL SUCCESS # 08:14:26 INFO - Running post-action listener: _resource_record_post_action 08:14:26 INFO - [mozharness: 2017-05-12 15:14:26.766975Z] Finished run-tests step (success) 08:14:26 INFO - Running post-run listener: _resource_record_post_run 08:14:26 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 385744896; Read time: 0; Write time: 448992 08:14:26 INFO - TinderboxPrint: CPU usage
12.9% 08:14:26 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:14:26 INFO - TinderboxPrint: I/O write bytes / time
385,744,896 / 448,992 08:14:26 INFO - TinderboxPrint: CPU idle
8,307.4 (87.1%) 08:14:26 INFO - TinderboxPrint: CPU user
1,182.3 (12.4%) 08:14:26 INFO - TinderboxPrint: Swap in / out
0 / 0 08:14:26 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 74657792; Read time: 0; Write time: 32220 08:14:26 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 260083712; Read time: 0; Write time: 292960 08:14:27 INFO - Running post-run listener: _upload_blobber_files 08:14:27 INFO - Blob upload gear active. 08:14:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:14:27 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 08:14:27 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'] 08:14:27 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 08:14:27 INFO - (blobuploader) - INFO - Open directory for files ... 08:14:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:14:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:14:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:14:28 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:14:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:14:28 INFO - (blobuploader) - INFO - Done attempting. 08:14:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:14:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:14:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:14:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:14:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:14:32 INFO - (blobuploader) - INFO - Done attempting. 08:14:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:14:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:14:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:14:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:14:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:14:33 INFO - (blobuploader) - INFO - Done attempting. 08:14:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:14:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:14:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:14:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:14:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:14:33 INFO - (blobuploader) - INFO - Done attempting. 08:14:33 INFO - (blobuploader) - INFO - Iteration through files over. 08:14:33 INFO - Return code: 0 08:14:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:14:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:14:33 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24b969f73c24e5caddc53a0964f27939a5266d073aa7681619151d374844375ce8451cf9c74c57dd0f8f5ea4d2dd49ac9007c69d95e54e1dbdb16091f0e6b978", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/12f59dc93d523d02fc01423821fc3206bf9e57210996d2544f3a1bc7ce431e464b7aa75e926d887382393fc040c59b5d5c3cdd46db6d3413ac8d6271a9060f72", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3d33cd479056cb573571aa9958ee04c05c98b69db9e7ee73698861b751f1aaa0f9c1908df55c425e1fb7eb017d48870642bdcd735bc088467e4481d13bdcfe5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ab2ee4efa588ad506c3c72e81d68aa063824bff1bba432894d225cbd3d9ab77a70a0a790bde52c9a877e5fa91050e2554a7abda4afac0bd7791d6a22304cfaf"} 08:14:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:14:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:14:33 INFO - Contents: 08:14:33 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24b969f73c24e5caddc53a0964f27939a5266d073aa7681619151d374844375ce8451cf9c74c57dd0f8f5ea4d2dd49ac9007c69d95e54e1dbdb16091f0e6b978", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/12f59dc93d523d02fc01423821fc3206bf9e57210996d2544f3a1bc7ce431e464b7aa75e926d887382393fc040c59b5d5c3cdd46db6d3413ac8d6271a9060f72", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3d33cd479056cb573571aa9958ee04c05c98b69db9e7ee73698861b751f1aaa0f9c1908df55c425e1fb7eb017d48870642bdcd735bc088467e4481d13bdcfe5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ab2ee4efa588ad506c3c72e81d68aa063824bff1bba432894d225cbd3d9ab77a70a0a790bde52c9a877e5fa91050e2554a7abda4afac0bd7791d6a22304cfaf"} 08:14:33 INFO - Running post-run listener: copy_logs_to_upload_dir 08:14:33 INFO - Copying logs to upload dir... 08:14:33 INFO - mkdir: /builds/slave/test/build/upload/logs 08:14:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.331604 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-05-12 08:14:33.768008) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-12 08:14:33.776927) ========= 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=df17445c3590ff7897617a0e00000225-1494600819.515925-727620629 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24b969f73c24e5caddc53a0964f27939a5266d073aa7681619151d374844375ce8451cf9c74c57dd0f8f5ea4d2dd49ac9007c69d95e54e1dbdb16091f0e6b978", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/12f59dc93d523d02fc01423821fc3206bf9e57210996d2544f3a1bc7ce431e464b7aa75e926d887382393fc040c59b5d5c3cdd46db6d3413ac8d6271a9060f72", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3d33cd479056cb573571aa9958ee04c05c98b69db9e7ee73698861b751f1aaa0f9c1908df55c425e1fb7eb017d48870642bdcd735bc088467e4481d13bdcfe5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ab2ee4efa588ad506c3c72e81d68aa063824bff1bba432894d225cbd3d9ab77a70a0a790bde52c9a877e5fa91050e2554a7abda4afac0bd7791d6a22304cfaf"} build_url:https://queue.taskcluster.net/v1/task/KI_iaByYSeeSOnxUNs4HQA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011398 build_url: 'https://queue.taskcluster.net/v1/task/KI_iaByYSeeSOnxUNs4HQA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24b969f73c24e5caddc53a0964f27939a5266d073aa7681619151d374844375ce8451cf9c74c57dd0f8f5ea4d2dd49ac9007c69d95e54e1dbdb16091f0e6b978", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/12f59dc93d523d02fc01423821fc3206bf9e57210996d2544f3a1bc7ce431e464b7aa75e926d887382393fc040c59b5d5c3cdd46db6d3413ac8d6271a9060f72", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3d33cd479056cb573571aa9958ee04c05c98b69db9e7ee73698861b751f1aaa0f9c1908df55c425e1fb7eb017d48870642bdcd735bc088467e4481d13bdcfe5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ab2ee4efa588ad506c3c72e81d68aa063824bff1bba432894d225cbd3d9ab77a70a0a790bde52c9a877e5fa91050e2554a7abda4afac0bd7791d6a22304cfaf"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-12 08:14:33.801686) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 08:14:33.802006) ========= 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=df17445c3590ff7897617a0e00000225-1494600819.515925-727620629 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004399 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 08:14:33.886180) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-12 08:14:33.886480) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-12 08:14:33.888791) ========= ========= Total master_lag: 0.22 =========