builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-029 starttime: 1495083329.61 results: success (0) revision: 0b529227685dc071774480f756bf41dff7068452 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-17 21:55:29.611147) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-17 21:55:29.611595) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-17 21:55:29.611870) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-17 21:55:29.655768) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 21:55:29.656092) ========= 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=ba164b0a7b0ec7655860e956000001c1-1495076262.570638-979291685 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-17 21:55:29-- 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% 111M=0s 2017-05-17 21:55:30 (111 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.171147 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 21:55:29.840212) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 21:55:29.843537) ========= 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=ba164b0a7b0ec7655860e956000001c1-1495076262.570638-979291685 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016046 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 21:55:29.893054) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 21:55:29.896406) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0b529227685dc071774480f756bf41dff7068452 --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 0b529227685dc071774480f756bf41dff7068452 --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=ba164b0a7b0ec7655860e956000001c1-1495076262.570638-979291685 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-17 21:55:30,212 truncating revision to first 12 chars 2017-05-17 21:55:30,212 Setting DEBUG logging. 2017-05-17 21:55:30,212 attempt 1/10 2017-05-17 21:55:30,212 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0b529227685d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-17 21:55:30,721 unpacking tar archive at: mozilla-central-0b529227685d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.816625 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 21:55:30.725090) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-17 21:55:30.728422) ========= script_repo_revision: 0b529227685dc071774480f756bf41dff7068452 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-17 21:55:30.728804) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-17 21:55:30.729068) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-17 21:55:30.737897) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-05-17 21:55:30.738267) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=ba164b0a7b0ec7655860e956000001c1-1495076262.570638-979291685 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:55:31 INFO - MultiFileLogger online at 20170517 21:55:31 in /builds/slave/test 21:55:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:55:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:55:31 INFO - {'append_to_log': False, 21:55:31 INFO - 'base_work_dir': '/builds/slave/test', 21:55:31 INFO - 'blob_upload_branch': 'Firefox', 21:55:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:55:31 INFO - 'branch': 'Firefox', 21:55:31 INFO - 'buildbot_json_path': 'buildprops.json', 21:55:31 INFO - 'config_files': ('talos/linux_config.py',), 21:55:31 INFO - 'default_actions': ('clobber', 21:55:31 INFO - 'read-buildbot-config', 21:55:31 INFO - 'download-and-extract', 21:55:31 INFO - 'populate-webroot', 21:55:31 INFO - 'create-virtualenv', 21:55:31 INFO - 'install', 21:55:31 INFO - 'run-tests'), 21:55:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:55:31 INFO - 'download_minidump_stackwalk': True, 21:55:31 INFO - 'download_symbols': 'ondemand', 21:55:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:55:31 INFO - 'tooltool.py': '/tools/tooltool.py', 21:55:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:55:31 INFO - '/tools/misc-python/virtualenv.py')}, 21:55:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:55:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:55:31 INFO - 'gecko_profile': False, 21:55:31 INFO - 'gecko_profile_interval': 0, 21:55:31 INFO - 'installer_path': 'installer.exe', 21:55:31 INFO - 'log_level': 'info', 21:55:31 INFO - 'log_name': 'talos', 21:55:31 INFO - 'log_to_console': True, 21:55:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:55:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:55:31 INFO - 'opt_config_files': (), 21:55:31 INFO - 'pip_index': False, 21:55:31 INFO - 'suite': 'dromaeojs-e10s', 21:55:31 INFO - 'system_bits': '32', 21:55:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:55:31 INFO - 'title': 'talos-linux64-ix-029', 21:55:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:55:31 INFO - 'use_talos_json': True, 21:55:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:55:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:55:31 INFO - 'work_dir': 'build'} 21:55:31 INFO - [mozharness: 2017-05-18 04:55:31.154254Z] Running clobber step. 21:55:31 INFO - Running pre-action listener: _resource_record_pre_action 21:55:31 INFO - Running main action method: clobber 21:55:31 INFO - rmtree: /builds/slave/test/build 21:55:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:55:32 INFO - Running post-action listener: _resource_record_post_action 21:55:32 INFO - [mozharness: 2017-05-18 04:55:32.661839Z] Finished clobber step (success) 21:55:32 INFO - [mozharness: 2017-05-18 04:55:32.661938Z] Running read-buildbot-config step. 21:55:32 INFO - Running pre-action listener: _resource_record_pre_action 21:55:32 INFO - Running main action method: read_buildbot_config 21:55:32 INFO - Using buildbot properties: 21:55:32 INFO - { 21:55:32 INFO - "project": "", 21:55:32 INFO - "product": "firefox", 21:55:32 INFO - "who": "ihsiao@mozilla.com", 21:55:32 INFO - "installer_path": "public/build/target.tar.bz2", 21:55:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 21:55:32 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 21:55:32 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 21:55:32 INFO - "stage_platform": "linux64-styloseq", 21:55:32 INFO - "basedir": "/builds/slave/test", 21:55:32 INFO - "buildnumber": 9, 21:55:32 INFO - "platform": "ubuntu64_hw_styloseq", 21:55:32 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:55:32 INFO - "slavebuilddir": "test", 21:55:32 INFO - "taskId": "BHWknU4rThuaIPg5NlxKzA", 21:55:32 INFO - "branch": "mozilla-central", 21:55:32 INFO - "script_repo_revision": "production", 21:55:32 INFO - "revision": "0b529227685dc071774480f756bf41dff7068452", 21:55:32 INFO - "slavename": "talos-linux64-ix-029", 21:55:32 INFO - "repo_path": "mozilla-central" 21:55:32 INFO - } 21:55:32 INFO - Finding installer, test and symbols from parent task. 21:55:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BHWknU4rThuaIPg5NlxKzA'}, attempt #1 21:55:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BHWknU4rThuaIPg5NlxKzA'}, attempt #1 21:55:33 INFO - Task dependencies: Ng2ZE6IuS9S32HYlv8C-HA 21:55:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA'}, attempt #1 21:55:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.tar.bz2 21:55:34 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/test_packages.json 21:55:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.crashreporter-symbols.zip 21:55:34 INFO - Running post-action listener: _resource_record_post_action 21:55:34 INFO - [mozharness: 2017-05-18 04:55:34.074112Z] Finished read-buildbot-config step (success) 21:55:34 INFO - [mozharness: 2017-05-18 04:55:34.074332Z] Running download-and-extract step. 21:55:34 INFO - Running pre-action listener: _resource_record_pre_action 21:55:34 INFO - Running main action method: download_and_extract 21:55:34 INFO - mkdir: /builds/slave/test/build/tests 21:55:34 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')]} 21:55:34 INFO - trying https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.test_packages.json 21:55:34 INFO - Downloading https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 21:55:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 21:55:34 INFO - Downloaded 986 bytes. 21:55:34 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 21:55:34 INFO - Using the following test package requirements: 21:55:34 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 21:55:34 INFO - u'common': [u'target.common.tests.zip'], 21:55:34 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 21:55:34 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 21:55:34 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 21:55:34 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 21:55:34 INFO - u'mozbase': [u'target.common.tests.zip'], 21:55:34 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 21:55:34 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 21:55:34 INFO - u'web-platform': [u'target.common.tests.zip', 21:55:34 INFO - u'target.web-platform.tests.zip'], 21:55:34 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 21:55:34 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 21:55:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.common.tests.zip 21:55:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:55:34 INFO - Fetch https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.common.tests.zip into memory 21:55:35 INFO - Content-Length response header: 62459748 21:55:35 INFO - Bytes received: 62459748 21:55:46 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 21:55:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.common.tests.zip 21:55:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:55:46 INFO - Fetch https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.common.tests.zip into memory 21:55:48 INFO - Content-Length response header: 62459748 21:55:48 INFO - Bytes received: 62459748 21:55:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.talos.tests.zip 21:55:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 21:55:59 INFO - Fetch https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.talos.tests.zip into memory 21:56:00 INFO - Content-Length response header: 14410001 21:56:00 INFO - Bytes received: 14410001 21:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:56:00 INFO - trying https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.tar.bz2 21:56:00 INFO - Downloading https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 21:56:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 21:56:01 INFO - Downloaded 59722408 bytes. 21:56:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.tar.bz2 21:56:01 INFO - mkdir: /builds/slave/test/properties 21:56:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:56:01 INFO - Writing to file /builds/slave/test/properties/build_url 21:56:01 INFO - Contents: 21:56:01 INFO - build_url:https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.tar.bz2 21:56:01 INFO - Running post-action listener: _resource_record_post_action 21:56:01 INFO - Running post-action listener: set_extra_try_arguments 21:56:01 INFO - [mozharness: 2017-05-18 04:56:01.954567Z] Finished download-and-extract step (success) 21:56:01 INFO - [mozharness: 2017-05-18 04:56:01.954663Z] Running populate-webroot step. 21:56:01 INFO - Running pre-action listener: _resource_record_pre_action 21:56:01 INFO - Running main action method: populate_webroot 21:56:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:56:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:56:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:56:01 INFO - '--tppagecycles', 21:56:01 INFO - '7'], 21:56:01 INFO - 'tests': ['tsvgm']}}, 21:56:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:56:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:56:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:56:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:56:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:56:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:56:01 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:56:01 INFO - 'talos_options': ['--disable-e10s'], 21:56:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:56:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:56:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:56:01 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:56:01 INFO - 'talos_options': ['--disable-e10s'], 21:56:01 INFO - 'tests': ['damp', 'tps']}, 21:56:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:56:01 INFO - 'tests': ['damp', 'tps']}, 21:56:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:56:01 INFO - 'tests': ['dromaeo_dom']}, 21:56:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:56:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:56:01 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 21:56:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 21:56:01 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 21:56:01 INFO - 'tests': ['ts_paint', 'tp5o']}, 21:56:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:56:01 INFO - 'tests': ['a11yr', 21:56:01 INFO - 'ts_paint', 21:56:01 INFO - 'tpaint', 21:56:01 INFO - 'sessionrestore', 21:56:01 INFO - 'sessionrestore_no_auto_restore', 21:56:01 INFO - 'tabpaint']}, 21:56:01 INFO - 'other-e10s': {'tests': ['a11yr', 21:56:01 INFO - 'ts_paint', 21:56:01 INFO - 'tpaint', 21:56:01 INFO - 'sessionrestore', 21:56:01 INFO - 'sessionrestore_no_auto_restore', 21:56:01 INFO - 'tabpaint']}, 21:56:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:56:01 INFO - 'ts_paint', 21:56:01 INFO - 'tpaint', 21:56:01 INFO - 'sessionrestore', 21:56:01 INFO - 'sessionrestore_no_auto_restore', 21:56:01 INFO - 'tabpaint']}, 21:56:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:56:01 INFO - 'ts_paint', 21:56:01 INFO - 'tpaint', 21:56:01 INFO - 'sessionrestore', 21:56:01 INFO - 'sessionrestore_no_auto_restore', 21:56:01 INFO - 'tabpaint']}, 21:56:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:56:01 INFO - 'tests': ['a11yr', 21:56:01 INFO - 'ts_paint', 21:56:01 INFO - 'tpaint', 21:56:01 INFO - 'sessionrestore', 21:56:01 INFO - 'sessionrestore_no_auto_restore', 21:56:01 INFO - 'tabpaint']}, 21:56:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:56:01 INFO - 'tests': ['a11yr', 21:56:01 INFO - 'ts_paint', 21:56:01 INFO - 'tpaint', 21:56:01 INFO - 'sessionrestore', 21:56:01 INFO - 'sessionrestore_no_auto_restore', 21:56:01 INFO - 'tabpaint']}, 21:56:01 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 21:56:01 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 21:56:01 INFO - 'bloom_basic_ref']}, 21:56:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:56:01 INFO - 'tests': ['tsvgx', 21:56:01 INFO - 'tsvgr_opacity', 21:56:01 INFO - 'tart', 21:56:01 INFO - 'tscrollx', 21:56:01 INFO - 'cart', 21:56:01 INFO - 'tsvg_static']}, 21:56:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:56:01 INFO - 'tsvgr_opacity', 21:56:01 INFO - 'tart', 21:56:01 INFO - 'tscrollx', 21:56:01 INFO - 'cart', 21:56:01 INFO - 'tsvg_static']}, 21:56:01 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:56:01 INFO - 'talos_options': ['--disable-e10s'], 21:56:01 INFO - 'tests': ['tp5o']}, 21:56:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:56:01 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:56:01 INFO - 'talos_options': ['--disable-e10s', 21:56:01 INFO - '--xperf_path', 21:56:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:56:01 INFO - 'tests': ['tp5n']}, 21:56:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:56:01 INFO - 'talos_options': ['--xperf_path', 21:56:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:56:01 INFO - 'tests': ['tp5n']}}, 21:56:01 INFO - 'talos.zip': {'path': '', 21:56:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:56:01 INFO - Running post-action listener: _resource_record_post_action 21:56:01 INFO - [mozharness: 2017-05-18 04:56:01.968535Z] Finished populate-webroot step (success) 21:56:01 INFO - [mozharness: 2017-05-18 04:56:01.968624Z] Running create-virtualenv step. 21:56:01 INFO - Running pre-action listener: _resource_record_pre_action 21:56:01 INFO - Running main action method: create_virtualenv 21:56:01 INFO - Creating virtualenv /builds/slave/test/build/venv 21:56:01 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 21:56:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:56:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:56:02 INFO - Using real prefix '/usr' 21:56:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:56:02 INFO - Installing distribute.............................................................................................................................................................................................done. 21:56:04 INFO - Installing pip.................done. 21:56:04 INFO - Return code: 0 21:56:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:56:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:56:04 INFO - Reading from file tmpfile_stdout 21:56:04 INFO - Output received: 21:56:04 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) 21:56:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:56:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2419a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25bf5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bc7a0>, '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 0x25bd6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bdb30>, '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': 'ba164b0a7b0ec7655860e956000001c1-1495076262.570638-979291685', '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 21:56:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:56:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:56:04 INFO - Using env: {'DISPLAY': ':0', 21:56:04 INFO - 'HOME': '/home/cltbld', 21:56:04 INFO - 'LANG': 'en_US.UTF-8', 21:56:04 INFO - 'LANGUAGE': 'en_US:en', 21:56:04 INFO - 'LOGNAME': 'cltbld', 21:56:04 INFO - 'MAIL': '/var/mail/cltbld', 21:56:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:04 INFO - 'MOZ_NO_REMOTE': '1', 21:56:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:04 INFO - 'NO_EM_RESTART': '1', 21:56:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:04 INFO - 'PWD': '/builds/slave/test', 21:56:04 INFO - 'SHELL': '/bin/bash', 21:56:04 INFO - 'SHLVL': '1', 21:56:04 INFO - 'TERM': 'linux', 21:56:04 INFO - 'TMOUT': '86400', 21:56:04 INFO - 'USER': 'cltbld', 21:56:04 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495076262.570638-979291685', 21:56:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:04 INFO - '_': '/tools/buildbot/bin/python'} 21:56:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:04 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 21:56:04 INFO - Cleaning up... 21:56:04 INFO - Return code: 0 21:56:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:56:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x224c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2419a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25bf5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bc7a0>, '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 0x25bd6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bdb30>, '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': 'ba164b0a7b0ec7655860e956000001c1-1495076262.570638-979291685', '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 21:56:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:56:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:56:04 INFO - Using env: {'DISPLAY': ':0', 21:56:04 INFO - 'HOME': '/home/cltbld', 21:56:04 INFO - 'LANG': 'en_US.UTF-8', 21:56:04 INFO - 'LANGUAGE': 'en_US:en', 21:56:04 INFO - 'LOGNAME': 'cltbld', 21:56:04 INFO - 'MAIL': '/var/mail/cltbld', 21:56:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:04 INFO - 'MOZ_NO_REMOTE': '1', 21:56:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:04 INFO - 'NO_EM_RESTART': '1', 21:56:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:04 INFO - 'PWD': '/builds/slave/test', 21:56:04 INFO - 'SHELL': '/bin/bash', 21:56:04 INFO - 'SHLVL': '1', 21:56:04 INFO - 'TERM': 'linux', 21:56:04 INFO - 'TMOUT': '86400', 21:56:04 INFO - 'USER': 'cltbld', 21:56:04 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495076262.570638-979291685', 21:56:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:04 INFO - '_': '/tools/buildbot/bin/python'} 21:56:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:05 INFO - Downloading/unpacking psutil>=3.1.1 21:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:56:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:56:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:56:06 INFO - Installing collected packages: psutil 21:56:06 INFO - Running setup.py install for psutil 21:56:06 INFO - building 'psutil._psutil_linux' extension 21:56:06 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 21:56:06 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 21:56:06 INFO - building 'psutil._psutil_posix' extension 21:56:06 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 21:56:06 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 21:56:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:56:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:56:06 INFO - Successfully installed psutil 21:56:06 INFO - Cleaning up... 21:56:06 INFO - Return code: 0 21:56:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:56:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:06 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 0x224c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2419a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25bf5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bc7a0>, '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 0x25bd6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bdb30>, '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': 'ba164b0a7b0ec7655860e956000001c1-1495076262.570638-979291685', '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 21:56:06 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 21:56:06 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 21:56:06 INFO - Using env: {'DISPLAY': ':0', 21:56:06 INFO - 'HOME': '/home/cltbld', 21:56:06 INFO - 'LANG': 'en_US.UTF-8', 21:56:06 INFO - 'LANGUAGE': 'en_US:en', 21:56:06 INFO - 'LOGNAME': 'cltbld', 21:56:06 INFO - 'MAIL': '/var/mail/cltbld', 21:56:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:06 INFO - 'MOZ_NO_REMOTE': '1', 21:56:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:06 INFO - 'NO_EM_RESTART': '1', 21:56:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:06 INFO - 'PWD': '/builds/slave/test', 21:56:06 INFO - 'SHELL': '/bin/bash', 21:56:06 INFO - 'SHLVL': '1', 21:56:06 INFO - 'TERM': 'linux', 21:56:06 INFO - 'TMOUT': '86400', 21:56:06 INFO - 'USER': 'cltbld', 21:56:06 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495076262.570638-979291685', 21:56:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:06 INFO - '_': '/tools/buildbot/bin/python'} 21:56:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:56:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:56:08 INFO - Installing collected packages: mozsystemmonitor 21:56:08 INFO - Running setup.py install for mozsystemmonitor 21:56:08 INFO - Successfully installed mozsystemmonitor 21:56:08 INFO - Cleaning up... 21:56:08 INFO - Return code: 0 21:56:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:56:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x224c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2419a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25bf5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bc7a0>, '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 0x25bd6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bdb30>, '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': 'ba164b0a7b0ec7655860e956000001c1-1495076262.570638-979291685', '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 21:56:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:56:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:56:08 INFO - Using env: {'DISPLAY': ':0', 21:56:08 INFO - 'HOME': '/home/cltbld', 21:56:08 INFO - 'LANG': 'en_US.UTF-8', 21:56:08 INFO - 'LANGUAGE': 'en_US:en', 21:56:08 INFO - 'LOGNAME': 'cltbld', 21:56:08 INFO - 'MAIL': '/var/mail/cltbld', 21:56:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:08 INFO - 'MOZ_NO_REMOTE': '1', 21:56:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:08 INFO - 'NO_EM_RESTART': '1', 21:56:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:08 INFO - 'PWD': '/builds/slave/test', 21:56:08 INFO - 'SHELL': '/bin/bash', 21:56:08 INFO - 'SHLVL': '1', 21:56:08 INFO - 'TERM': 'linux', 21:56:08 INFO - 'TMOUT': '86400', 21:56:08 INFO - 'USER': 'cltbld', 21:56:08 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495076262.570638-979291685', 21:56:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:08 INFO - '_': '/tools/buildbot/bin/python'} 21:56:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:08 INFO - Downloading/unpacking jsonschema==2.5.1 21:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:56:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:09 INFO - Downloading functools32-3.2.3-2.tar.gz 21:56:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:56:09 INFO - warning: no files found matching '*.txt' 21:56:09 INFO - no previously-included directories found matching 'build' 21:56:09 INFO - no previously-included directories found matching 'dist' 21:56:09 INFO - no previously-included directories found matching '.git*' 21:56:09 INFO - Installing collected packages: jsonschema, functools32 21:56:10 INFO - Running setup.py install for functools32 21:56:10 INFO - warning: no files found matching '*.txt' 21:56:10 INFO - no previously-included directories found matching 'build' 21:56:10 INFO - no previously-included directories found matching 'dist' 21:56:10 INFO - no previously-included directories found matching '.git*' 21:56:10 INFO - Successfully installed jsonschema functools32 21:56:10 INFO - Cleaning up... 21:56:10 INFO - Return code: 0 21:56:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:56:10 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')]} 21:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:10 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')]} 21:56:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:10 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 0x224c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2419a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25bf5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bc7a0>, '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 0x25bd6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bdb30>, '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': 'ba164b0a7b0ec7655860e956000001c1-1495076262.570638-979291685', '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 21:56:10 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 21:56:10 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 21:56:10 INFO - Using env: {'DISPLAY': ':0', 21:56:10 INFO - 'HOME': '/home/cltbld', 21:56:10 INFO - 'LANG': 'en_US.UTF-8', 21:56:10 INFO - 'LANGUAGE': 'en_US:en', 21:56:10 INFO - 'LOGNAME': 'cltbld', 21:56:10 INFO - 'MAIL': '/var/mail/cltbld', 21:56:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:10 INFO - 'MOZ_NO_REMOTE': '1', 21:56:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:10 INFO - 'NO_EM_RESTART': '1', 21:56:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:10 INFO - 'PWD': '/builds/slave/test', 21:56:10 INFO - 'SHELL': '/bin/bash', 21:56:10 INFO - 'SHLVL': '1', 21:56:10 INFO - 'TERM': 'linux', 21:56:10 INFO - 'TMOUT': '86400', 21:56:10 INFO - 'USER': 'cltbld', 21:56:10 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495076262.570638-979291685', 21:56:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:10 INFO - '_': '/tools/buildbot/bin/python'} 21:56:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:56:10 INFO - Cleaning up... 21:56:10 INFO - Return code: 0 21:56:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:56:10 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')]} 21:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:10 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')]} 21:56:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:10 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 0x224c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2419a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25bf5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bc7a0>, '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 0x25bd6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bdb30>, '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': 'ba164b0a7b0ec7655860e956000001c1-1495076262.570638-979291685', '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 21:56:10 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 21:56:10 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 21:56:10 INFO - Using env: {'DISPLAY': ':0', 21:56:10 INFO - 'HOME': '/home/cltbld', 21:56:10 INFO - 'LANG': 'en_US.UTF-8', 21:56:10 INFO - 'LANGUAGE': 'en_US:en', 21:56:10 INFO - 'LOGNAME': 'cltbld', 21:56:10 INFO - 'MAIL': '/var/mail/cltbld', 21:56:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:10 INFO - 'MOZ_NO_REMOTE': '1', 21:56:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:10 INFO - 'NO_EM_RESTART': '1', 21:56:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:10 INFO - 'PWD': '/builds/slave/test', 21:56:10 INFO - 'SHELL': '/bin/bash', 21:56:10 INFO - 'SHLVL': '1', 21:56:10 INFO - 'TERM': 'linux', 21:56:10 INFO - 'TMOUT': '86400', 21:56:10 INFO - 'USER': 'cltbld', 21:56:10 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495076262.570638-979291685', 21:56:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:10 INFO - '_': '/tools/buildbot/bin/python'} 21:56:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:10 INFO - Downloading/unpacking blobuploader==1.2.4 21:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:11 INFO - Downloading blobuploader-1.2.4.tar.gz 21:56:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:56:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:56:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:56:12 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 21:56:12 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 21:56:12 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 21:56:12 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 21:56:12 INFO - Downloading docopt-0.6.1.tar.gz 21:56:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:56:12 INFO - Installing collected packages: blobuploader, requests, docopt 21:56:12 INFO - Running setup.py install for blobuploader 21:56:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:56:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:56:12 INFO - Running setup.py install for requests 21:56:12 INFO - Running setup.py install for docopt 21:56:12 INFO - Successfully installed blobuploader requests docopt 21:56:12 INFO - Cleaning up... 21:56:12 INFO - Return code: 0 21:56:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:56: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')]} 21:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56: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')]} 21:56:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:12 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 0x224c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2419a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25bf5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bc7a0>, '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 0x25bd6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bdb30>, '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': 'ba164b0a7b0ec7655860e956000001c1-1495076262.570638-979291685', '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 21:56:12 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 21:56:12 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 21:56:12 INFO - Using env: {'DISPLAY': ':0', 21:56:12 INFO - 'HOME': '/home/cltbld', 21:56:12 INFO - 'LANG': 'en_US.UTF-8', 21:56:12 INFO - 'LANGUAGE': 'en_US:en', 21:56:12 INFO - 'LOGNAME': 'cltbld', 21:56:12 INFO - 'MAIL': '/var/mail/cltbld', 21:56:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:12 INFO - 'MOZ_NO_REMOTE': '1', 21:56:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:12 INFO - 'NO_EM_RESTART': '1', 21:56:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:12 INFO - 'PWD': '/builds/slave/test', 21:56:12 INFO - 'SHELL': '/bin/bash', 21:56:12 INFO - 'SHLVL': '1', 21:56:12 INFO - 'TERM': 'linux', 21:56:12 INFO - 'TMOUT': '86400', 21:56:12 INFO - 'USER': 'cltbld', 21:56:12 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495076262.570638-979291685', 21:56:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:12 INFO - '_': '/tools/buildbot/bin/python'} 21:56:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:56:13 INFO - Running setup.py (path:/tmp/pip-OOLiWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:56:13 INFO - Running setup.py (path:/tmp/pip-DFH2Lj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:56:13 INFO - Running setup.py (path:/tmp/pip-8YyNnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:56:13 INFO - Running setup.py (path:/tmp/pip-gD1Qcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:56:13 INFO - Running setup.py (path:/tmp/pip-X8cREQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:56:13 INFO - Running setup.py (path:/tmp/pip-nmn5p9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:56:13 INFO - Running setup.py (path:/tmp/pip-hIOkt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:56:13 INFO - Running setup.py (path:/tmp/pip-IF2L8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:56:13 INFO - Running setup.py (path:/tmp/pip-JRNwBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:56:13 INFO - Running setup.py (path:/tmp/pip-J09czT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:56:13 INFO - Running setup.py (path:/tmp/pip-nNJThx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:56:13 INFO - Running setup.py (path:/tmp/pip-_EhIb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:56:14 INFO - Running setup.py (path:/tmp/pip-w2wVVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:56:14 INFO - Running setup.py (path:/tmp/pip-tdngMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:56:14 INFO - Running setup.py (path:/tmp/pip-GTBZpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:56:14 INFO - Running setup.py (path:/tmp/pip-Hm0cTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:56:14 INFO - Running setup.py (path:/tmp/pip-fLL4wD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:56:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:56:14 INFO - Running setup.py install for manifestparser 21:56:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:56:14 INFO - Running setup.py install for mozcrash 21:56:14 INFO - Running setup.py install for mozdebug 21:56:14 INFO - Running setup.py install for mozdevice 21:56:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:56:14 INFO - Running setup.py install for mozfile 21:56:14 INFO - Running setup.py install for mozhttpd 21:56:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:56:14 INFO - Running setup.py install for mozinfo 21:56:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:56:15 INFO - Running setup.py install for mozInstall 21:56:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:56:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:56:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:56:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:56:15 INFO - Running setup.py install for mozleak 21:56:15 INFO - Running setup.py install for mozlog 21:56:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:56:15 INFO - Running setup.py install for moznetwork 21:56:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:56:15 INFO - Running setup.py install for mozprocess 21:56:15 INFO - Running setup.py install for mozprofile 21:56:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:56:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:56:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:56:15 INFO - Running setup.py install for mozrunner 21:56:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:56:15 INFO - Running setup.py install for mozscreenshot 21:56:15 INFO - Running setup.py install for moztest 21:56:16 INFO - Running setup.py install for mozversion 21:56:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:56:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:56:16 INFO - Cleaning up... 21:56:16 INFO - Return code: 0 21:56:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:56: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')]} 21:56:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56: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')]} 21:56:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:16 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 0x224c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2419a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25bf5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bc7a0>, '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 0x25bd6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bdb30>, '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': 'ba164b0a7b0ec7655860e956000001c1-1495076262.570638-979291685', '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 21:56:16 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 21:56:16 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 21:56:16 INFO - Using env: {'DISPLAY': ':0', 21:56:16 INFO - 'HOME': '/home/cltbld', 21:56:16 INFO - 'LANG': 'en_US.UTF-8', 21:56:16 INFO - 'LANGUAGE': 'en_US:en', 21:56:16 INFO - 'LOGNAME': 'cltbld', 21:56:16 INFO - 'MAIL': '/var/mail/cltbld', 21:56:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:16 INFO - 'MOZ_NO_REMOTE': '1', 21:56:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:16 INFO - 'NO_EM_RESTART': '1', 21:56:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:16 INFO - 'PWD': '/builds/slave/test', 21:56:16 INFO - 'SHELL': '/bin/bash', 21:56:16 INFO - 'SHLVL': '1', 21:56:16 INFO - 'TERM': 'linux', 21:56:16 INFO - 'TMOUT': '86400', 21:56:16 INFO - 'USER': 'cltbld', 21:56:16 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495076262.570638-979291685', 21:56:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:16 INFO - '_': '/tools/buildbot/bin/python'} 21:56:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:56:16 INFO - Running setup.py (path:/tmp/pip-g_ONhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:56:16 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)) 21:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:56:16 INFO - Running setup.py (path:/tmp/pip-NFV8FP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:56:16 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)) 21:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:56:16 INFO - Running setup.py (path:/tmp/pip-9lywr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:56:16 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)) 21:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:56:16 INFO - Running setup.py (path:/tmp/pip-ZtIuOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:56:16 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)) 21:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:56:16 INFO - Running setup.py (path:/tmp/pip-vvoR3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:56:16 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)) 21:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:56:16 INFO - Running setup.py (path:/tmp/pip-G_AzwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:56:16 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)) 21:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:56:16 INFO - Running setup.py (path:/tmp/pip-Ddsa2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:56:16 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)) 21:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:56:16 INFO - Running setup.py (path:/tmp/pip-9p5x7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:56:16 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)) 21:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:56:16 INFO - Running setup.py (path:/tmp/pip-mwbJr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:56:17 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)) 21:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:56:17 INFO - Running setup.py (path:/tmp/pip-DoUPPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:56:17 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)) 21:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:56:17 INFO - Running setup.py (path:/tmp/pip-KYvQWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:56:17 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)) 21:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:56:17 INFO - Running setup.py (path:/tmp/pip-oMiM_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:56:17 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)) 21:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:56:17 INFO - Running setup.py (path:/tmp/pip-XkK7y9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:56:17 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)) 21:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:56:17 INFO - Running setup.py (path:/tmp/pip-4R_gCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:56:17 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)) 21:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:56:17 INFO - Running setup.py (path:/tmp/pip-F81Kus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:56:17 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)) 21:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:56:17 INFO - Running setup.py (path:/tmp/pip-pKLaue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:56:17 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)) 21:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:56:17 INFO - Running setup.py (path:/tmp/pip-3LJCne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:56:17 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)) 21:56:17 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)) 21:56:17 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)) 21:56:17 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)) 21:56:17 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)) 21:56:17 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)) 21:56:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:56:17 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 21:56:17 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 21:56:17 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 21:56:17 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 21:56:18 INFO - Downloading blessings-1.6.tar.gz 21:56:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:56:18 INFO - Installing collected packages: blessings 21:56:18 INFO - Running setup.py install for blessings 21:56:18 INFO - Successfully installed blessings 21:56:18 INFO - Cleaning up... 21:56:18 INFO - Return code: 0 21:56:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:56:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:56:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:56:19 INFO - Reading from file tmpfile_stdout 21:56:19 INFO - Current package versions: 21:56:19 INFO - argparse == 1.2.1 21:56:19 INFO - blessings == 1.6 21:56:19 INFO - blobuploader == 1.2.4 21:56:19 INFO - docopt == 0.6.1 21:56:19 INFO - functools32 == 3.2.3-2 21:56:19 INFO - jsonschema == 2.5.1 21:56:19 INFO - manifestparser == 1.1 21:56:19 INFO - mozInstall == 1.12 21:56:19 INFO - mozcrash == 1.0 21:56:19 INFO - mozdebug == 0.1 21:56:19 INFO - mozdevice == 0.50 21:56:19 INFO - mozfile == 1.2 21:56:19 INFO - mozhttpd == 0.7 21:56:19 INFO - mozinfo == 0.9 21:56:19 INFO - mozleak == 0.1 21:56:19 INFO - mozlog == 3.4 21:56:19 INFO - moznetwork == 0.27 21:56:19 INFO - mozprocess == 0.25 21:56:19 INFO - mozprofile == 0.28 21:56:19 INFO - mozrunner == 6.13 21:56:19 INFO - mozscreenshot == 0.1 21:56:19 INFO - mozsystemmonitor == 0.3 21:56:19 INFO - moztest == 0.8 21:56:19 INFO - mozversion == 1.4 21:56:19 INFO - psutil == 3.1.1 21:56:19 INFO - requests == 1.2.3 21:56:19 INFO - wsgiref == 0.1.2 21:56:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:56: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')]} 21:56:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56: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')]} 21:56:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:19 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 0x224c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2419a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25bf5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bc7a0>, '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 0x25bd6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bdb30>, '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': 'ba164b0a7b0ec7655860e956000001c1-1495076262.570638-979291685', '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 21:56:19 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 21:56:19 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 21:56:19 INFO - Using env: {'DISPLAY': ':0', 21:56:19 INFO - 'HOME': '/home/cltbld', 21:56:19 INFO - 'LANG': 'en_US.UTF-8', 21:56:19 INFO - 'LANGUAGE': 'en_US:en', 21:56:19 INFO - 'LOGNAME': 'cltbld', 21:56:19 INFO - 'MAIL': '/var/mail/cltbld', 21:56:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:19 INFO - 'MOZ_NO_REMOTE': '1', 21:56:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:19 INFO - 'NO_EM_RESTART': '1', 21:56:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:19 INFO - 'PWD': '/builds/slave/test', 21:56:19 INFO - 'SHELL': '/bin/bash', 21:56:19 INFO - 'SHLVL': '1', 21:56:19 INFO - 'TERM': 'linux', 21:56:19 INFO - 'TMOUT': '86400', 21:56:19 INFO - 'USER': 'cltbld', 21:56:19 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495076262.570638-979291685', 21:56:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:19 INFO - '_': '/tools/buildbot/bin/python'} 21:56:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:19 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)) 21:56:19 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)) 21:56:19 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)) 21:56:19 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)) 21:56:19 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)) 21:56:19 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)) 21:56:19 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)) 21:56:19 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)) 21:56:19 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)) 21:56:19 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)) 21:56:19 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)) 21:56:19 INFO - Cleaning up... 21:56:19 INFO - Return code: 0 21:56:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:56: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')]} 21:56:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56: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')]} 21:56:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2419a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25bf5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bc7a0>, '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 0x25bd6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bdb30>, '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': 'ba164b0a7b0ec7655860e956000001c1-1495076262.570638-979291685', '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 21:56: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'] in /builds/slave/test/build 21:56: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 21:56:19 INFO - Using env: {'DISPLAY': ':0', 21:56:19 INFO - 'HOME': '/home/cltbld', 21:56:19 INFO - 'LANG': 'en_US.UTF-8', 21:56:19 INFO - 'LANGUAGE': 'en_US:en', 21:56:19 INFO - 'LOGNAME': 'cltbld', 21:56:19 INFO - 'MAIL': '/var/mail/cltbld', 21:56:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:19 INFO - 'MOZ_NO_REMOTE': '1', 21:56:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:19 INFO - 'NO_EM_RESTART': '1', 21:56:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:19 INFO - 'PWD': '/builds/slave/test', 21:56:19 INFO - 'SHELL': '/bin/bash', 21:56:19 INFO - 'SHLVL': '1', 21:56:19 INFO - 'TERM': 'linux', 21:56:19 INFO - 'TMOUT': '86400', 21:56:19 INFO - 'USER': 'cltbld', 21:56:19 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495076262.570638-979291685', 21:56:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:19 INFO - '_': '/tools/buildbot/bin/python'} 21:56:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:56:19 INFO - Cleaning up... 21:56:19 INFO - Return code: 0 21:56:19 INFO - Running post-action listener: _resource_record_post_action 21:56:19 INFO - Running post-action listener: _start_resource_monitoring 21:56:19 INFO - Starting resource monitoring. 21:56:19 INFO - [mozharness: 2017-05-18 04:56:19.645289Z] Finished create-virtualenv step (success) 21:56:19 INFO - [mozharness: 2017-05-18 04:56:19.645837Z] Running install step. 21:56:19 INFO - Running pre-action listener: _resource_record_pre_action 21:56:19 INFO - Running main action method: install 21:56:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:56:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:56:19 INFO - Reading from file tmpfile_stdout 21:56:19 INFO - Detecting whether we're running mozinstall >=1.0... 21:56:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:56:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:56:19 INFO - Reading from file tmpfile_stdout 21:56:19 INFO - Output received: 21:56:19 INFO - Usage: mozinstall [options] installer 21:56:19 INFO - Options: 21:56:19 INFO - -h, --help show this help message and exit 21:56:19 INFO - -d DEST, --destination=DEST 21:56:19 INFO - Directory to install application into. [default: 21:56:19 INFO - "/builds/slave/test"] 21:56:19 INFO - --app=APP Application being installed. [default: firefox] 21:56:19 INFO - mkdir: /builds/slave/test/build/application 21:56:19 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'] 21:56:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 21:56:37 INFO - Reading from file tmpfile_stdout 21:56:37 INFO - Output received: 21:56:37 INFO - /builds/slave/test/build/application/firefox/firefox 21:56:37 INFO - Running post-action listener: _resource_record_post_action 21:56:37 INFO - [mozharness: 2017-05-18 04:56:37.184948Z] Finished install step (success) 21:56:37 INFO - [mozharness: 2017-05-18 04:56:37.185184Z] Running run-tests step. 21:56:37 INFO - Running pre-action listener: _resource_record_pre_action 21:56:37 INFO - Running main action method: run_tests 21:56:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:56:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:56:37 INFO - Python 2.7.3 21:56:37 INFO - Return code: 0 21:56:37 INFO - grabbing minidump binary from tooltool 21:56:37 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')]} 21:56:37 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 0x25bc7a0>, '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 0x25bd6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bdb30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:56:37 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 21:56:37 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 21:56:37 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 21:56:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:56:37 INFO - Return code: 0 21:56:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:56:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:56:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:56:37 INFO - ENV: RUST_BACKTRACE is now 1 21:56:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:56:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:56:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 21:56:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 21:56:37 INFO - Using env: {'DISPLAY': ':0', 21:56:37 INFO - 'HOME': '/home/cltbld', 21:56:37 INFO - 'LANG': 'en_US.UTF-8', 21:56:37 INFO - 'LANGUAGE': 'en_US:en', 21:56:37 INFO - 'LOGNAME': 'cltbld', 21:56:37 INFO - 'MAIL': '/var/mail/cltbld', 21:56:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:56:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:56:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:37 INFO - 'MOZ_NO_REMOTE': '1', 21:56:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:56:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:37 INFO - 'NO_EM_RESTART': '1', 21:56:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:37 INFO - 'PWD': '/builds/slave/test', 21:56:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:56:37 INFO - 'RUST_BACKTRACE': '1', 21:56:37 INFO - 'SHELL': '/bin/bash', 21:56:37 INFO - 'SHLVL': '1', 21:56:37 INFO - 'TERM': 'linux', 21:56:37 INFO - 'TMOUT': '86400', 21:56:37 INFO - 'USER': 'cltbld', 21:56:37 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495076262.570638-979291685', 21:56:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:37 INFO - '_': '/tools/buildbot/bin/python'} 21:56:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 21:56:37 INFO - mozversion application_buildid: 20170518040217 21:56:37 INFO - mozversion application_changeset: 0b529227685dc071774480f756bf41dff7068452 21:56:37 INFO - mozversion application_display_name: Nightly 21:56:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:56:37 INFO - mozversion application_name: Firefox 21:56:37 INFO - mozversion application_remotingname: firefox 21:56:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:56:37 INFO - mozversion application_vendor: Mozilla 21:56:37 INFO - mozversion application_version: 55.0a1 21:56:37 INFO - mozversion platform_buildid: 20170518040217 21:56:37 INFO - mozversion platform_changeset: 0b529227685dc071774480f756bf41dff7068452 21:56:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:56:37 INFO - mozversion platform_version: 55.0a1 21:56:37 INFO - using testdate: 1495083397 21:56:37 INFO - actual date: 1495083397 21:56:37 INFO - starting webserver on 'localhost:57089' 21:56:37 INFO - SUITE-START | Running 2 tests 21:56:37 INFO - TEST-START | dromaeo_css 21:56:37 INFO - operating with platform_type : linux_ 21:56:37 INFO - Initialising browser for dromaeo_css test... 21:56:37 INFO - TEST-INFO | started process 8248 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKqMyIq/profile http://localhost:57089/getInfo.html) 21:56:38 INFO - PID 8248 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2939: String.localeCompare is deprecated; use String.prototype.localeCompare instead 21:56:41 INFO - PID 8248 | __metrics Screen width/height:1600/1200 21:56:41 INFO - PID 8248 | colorDepth:24 21:56:41 INFO - PID 8248 | Browser inner width/height: 1024/695 21:56:41 INFO - PID 8248 | __metrics 21:56:44 INFO - TEST-INFO | 8248: exit 0 21:56:44 INFO - Browser initialized. 21:56:44 INFO - Running cycle 1/1 for dromaeo_css test... 21:56:44 INFO - TEST-INFO | started process 8431 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKqMyIq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:56:55 INFO - PID 8431 | RSS: Main: 168968192 21:56:55 INFO - PID 8431 | 22:00:00 INFO - PID 8431 | Cycle 1(1): loaded http://localhost:57089/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57089/tests/dromaeo/cssquery-ext.html) 22:00:01 INFO - PID 8431 | RSS: Main: 174694400 22:00:01 INFO - PID 8431 | 22:03:03 INFO - PID 8431 | Cycle 1(1): loaded http://localhost:57089/tests/dromaeo/cssquery-ext.html (next: http://localhost:57089/tests/dromaeo/cssquery-jquery.html) 22:03:04 INFO - PID 8431 | RSS: Main: 176058368 22:03:04 INFO - PID 8431 | 22:06:06 INFO - PID 8431 | Cycle 1(1): loaded http://localhost:57089/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57089/tests/dromaeo/cssquery-mootools.html) 22:06:07 INFO - PID 8431 | RSS: Main: 178094080 22:06:07 INFO - PID 8431 | 22:09:08 INFO - PID 8431 | Cycle 1(1): loaded http://localhost:57089/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57089/tests/dromaeo/cssquery-prototype.html) 22:09:09 INFO - PID 8431 | RSS: Main: 173727744 22:09:09 INFO - PID 8431 | 22:12:12 INFO - PID 8431 | Cycle 1(1): loaded http://localhost:57089/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57089/tests/dromaeo/cssquery-yui.html) 22:12:13 INFO - PID 8431 | RSS: Main: 175099904 22:12:13 INFO - PID 8431 | 22:15:15 INFO - PID 8431 | Cycle 1(1): loaded http://localhost:57089/tests/dromaeo/cssquery-yui.html (next: http://localhost:57089/tests/dromaeo/cssquery-dojo.html) 22:15:15 INFO - PID 8431 | RSS: Main: 181424128 22:15:15 INFO - PID 8431 | 22:15:15 INFO - PID 8431 | __start_tp_report 22:15:15 INFO - PID 8431 | _x_x_mozilla_page_load 22:15:15 INFO - PID 8431 | _x_x_mozilla_page_load_details 22:15:15 INFO - PID 8431 | |i|pagename|runs| 22:15:15 INFO - PID 8431 | |0;dojo.html;2672.861137835292;2678.156380740068;2688.7176846431125;2708.7020427752955;2716.3073416278844;5073.822416215433;5206.062908676437;5216.217567364893;5229.633925625208;5258.158694608864;5176.896462070757;5205.739713014353;5262.684238945656;5279.445658205891;5293.15309550471;4385.166818304528;4569.588737013668;4670.276107203372;4692.0381321828945;4696.412948381452;4704.136412983925;4729.2433210686295;4747.003129342842;4768.189407800664;4771.308160316752;4562.406887104688;4610.723356598614;4644.698094623838;4658.487566367697;4665.440147182326;4677.158111539921;4684.765761711901;4689.577937985564;4704.9059018819435;4739;4615.123126605934;4651.88370290742;4671.065786842645;4672.649551283634;4719.976400117977;5053.242013697938;5144.279800827887;5170.431252562215;5223.843284701465;5282.894342113174;5588.133839254922;5601;5674.375818659944;5677.943220567783;5685.545156387479;5596.664200147963;5608.327000759894;5609.663420194802;5636.802711905105;5645.5483561314995;5109.667871588409;5252.947470525246;5263.157894736901;5267.104592219332;5268.868278293074;5707.429257074343;5797.942020579824;5856.765729370777;5873.530117590582;5883.7058147092475;5470.863228419242;5484.561235101182;5511.559075273968;5516.034693928546;5520.723963801794;5455.399906010336;5499.395066542677;5591.804286849941;5604.187392828017;5691.630044047124;5497.202905578669;5574.1917421973585;5604.8318550443555;5632.436756324417;5652.3217213934595;5410.161424979135;5452.754626041838;5536.390996990328;5609.326880774333;5647.209390685307;4696.201645720235;4732.242841145469;4736.7631618418945;4754.643401744883;4774.856754297377;4026.275270451347;4051.4125451809323;4051.493563304587;4057.918841623151;4089.734167279117;4589.495155532889;4654.162250794821;4675.742834144155;4717.43390793107;4722.173619616553;5680.062789639664;5681.914771278434;5709.942900571024;5711.143328500758;5713.171590119409;4688.109259240733;4695.201815691341;4697.671163018625;4701.3653156824075;4742.099001189763;4861.222204447272;4927.088488629615;4994.925076123861;4997.200447928314;5008.77460514285;5203.505666961632;5210.947890521046;5238.083335416363;5258.237555554347;5275.683458992473;5581.609287349846;5602.047651899105;5631.070873305859;5659.6887171204335;5669.546436285004;5047.444781074006;5122.129238029618;5232.2936403586555;5233.450487698737;5238.214267859851;5566.248556444828;5588.329400471969;5595;5596.440355964371;5618.269624948731;5654.971725141348;5663.490285874291;5667.886642267049;5674.801381951612;5692.857678558069;5379.300690910157;5451.4276001019325;5454.209139674805;5489.972550137224;5498.45015498447;5449.891002179855;5489.066858634122;5489.780408783604;5500.477454641803;5556.555475562026;5379.73101344939;5380.515753582196;5421.213923980922;5431.995080910045;5475.753591088331;5372.059889519241;5442.0748472760515;5475.041867673221;5520.089185284543;5539.279893613804;5360.758765855624;5372.516473517402;5398.64908780928;5433;5433.5381492572 22:15:15 INFO - PID 8431 | |1;ext.html;673.5958424945034;730.1384366447592;752.9322360987512;995.8406654935203;999.175680063947;31495.9055322808;32867;32898.8355058225;32993.50509742356;33124.503132453036;34531;34969.3006139877;35306;35318.64681353186;35347.4697879532;6833.794986150423;6929.376356127935;7022.683979220922;7036.648167591626;7087.114110736158;7036.577805331671;7138.78583642489;7144.321289477517;7146.106736657918;7150.499465037449;7105.076340075809;7128.6079265640365;7138.357547820695;7152.463565232602;7152.821179470503;7117.501774875761;7127.42980561559;7130.073090498254;7130.429565634737;7137.82155446118;6975.476839237078;7008;7030.472714546429;7035.366816986445;7074.151101867808;31963.84018079918;32179.83910080458;32187.678123218702;32213.194670133435;32268.354632907445;2807.8174918630225;2825.0677276498704;2827.4486475137355;2840.9289767755763;2842.2468045967835;24192.395190120387;24261.757382426127;24296.39259018521;24404.267871963693;24471.510569788505;3034.499307614241;3048.1769922121125;3055.5569442430947;3079.3687294104657;3085.7531397488146;144262;145590.27204863908;146989;152479;153065;39204;39523.80238098791;39572.40641390382;39581;39600;40368.19263614711;40386.19227615431;40593.59406405957;40649.39025914614;40656.59343406587;11287.435628218556;11291.3789741565;11359.488823002985;11360.886391136148;11434.428278586038;9035.593398297093;9061.77345566353;9064.864027039599;9065.320100992452;9067.818643627223;12875.356232188353;12982.285974271506;12992.870071299356;13025.47898084085;13220.140690855256;5275.182346736262;5463.426340234298;5478.643888147258;5528.55771538276;5558.305211848519;852.9402941794015;891.3047822698305;894.5890824228642;920.3189639666732;931.888173419194;20947;20959.476013099793;21350.35948921535;21527.46181345479;21852.781472185394;976.3751199232497;978.1685567267765;978.6525783346951;997.5012493753123;1009.6869970309227;11055.281406708538;11429.428528573539;11523.884761152449;11524.654260372203;11590.188686792013;170623;170790;171061;171128;171345;39112.21775564473;39851.80074099611;39867.80066099709;39892.60107398947;39894.401583976265;1178.5011060602344;1218.6892342452795;1227.6439832448668;1229.16416836552;1234.6419538333782;19518.707219392003;19695.606087877877;20396.184152633727;21242.575148496635;21351.359459216248;29467.85266073656;29636.259093522833;29651.258718532208;29696.851515742284;29735.553966690084;142311;142842;142878;143042;143264;28364;29620.851895740383;30255.848720756254;30712;30731;35519;36131.458028130124;36194.45708314325;36255.09362265859;36316;26700.732992669826;27263.86368068147;27407.725922741316;28152.29619259535;29535.113946581638;26999;27017.72982270152;27402.81611543457;28662.283442914093;28945.421091577628;30257.24356891007;30799.692003079683;30905.227369315948;31169.220769480944;31539.36921261608;23924.64113038271;24148.87925560361;24640.876795615906;24924.750752492244;25051.74948250567;21796.782032179475;22359.66460503061;22746.545069098855;22757.772422275564;22764.544709106056 22:15:15 INFO - PID 8431 | |2;jquery.html;411.34185303514363;417.8621055051833;420.87794539583524;433.2353396255609;439.5011661763897;16910.23903924323;17551.824481755193;17552.64894702105;17633.206505707243;18098.27606895726;18284;18494.537636559093;18542.536436589093;18694.252229910788;18793.24827006918;5428.864278393033;5474.479924407185;5581.7209139543065;5613.943860561383;5663.490285874271;5398.272552783111;5505.256790333294;5522.171674248854;5534.4742249486235;5537.390887002426;5334.199870019509;5422.701751403672;5449.6730196188155;5472.069748142825;5517.917231241515;5484.670919744808;5499.532539734088;5509.531689806371;5516.310461192351;5523.6409633373905;4929.556339929423;4969.080720066763;5010.997800439926;5011.047900898854;5012.924806127911;21291.467713307135;21791.564168716537;21895.138913192397;22449.663255051186;22576.75827829469;1616.5877701186123;1631.3556145322532;1664.1429663723193;1699.7535357373235;1708.9743653845203;14809.33357998882;14945.551633451014;15077.773833392508;15138.924305378403;15226.847731522654;2051.2307884543297;2068.7897579915766;2115.6509175985943;2143.699882016519;2151.2363111095647;82484.58757706173;90772;92724;101567;103105.48447257715;10965.396903170242;10975.560977560968;11113.611023614134;11217.15871309655;11320.433978301053;15250.771238431433;15266.160361180242;15294;15319.387224510894;15360.769588456182;6718.832029199211;7043.330883566053;7065.364117229474;7186.353228209487;7215.458840586977;6188.690565471708;6227.595206311666;6339.302676705559;6379.872402551923;6422.325655806073;6887.621180835002;6979.40675042627;6983.755568555178;7000.684969176399;7063.682134303968;2002.1958279269504;2011.2055737983414;2051.1590247998247;2064.669652855536;2200.7799220078186;818.8935438392971;838.7022606974558;861.4960248254841;867.9175478329548;869.3523325122824;16104.03375797456;16786.580335491468;17141.57146071358;17163.485095446908;17228.91385543064;858.8754630578657;863.2834747159842;869.3566760597113;873.8645509945968;884.5090974509209;8879.866801997976;9309.906900930904;9404.106609872051;9422.623095076257;9455.669051583161;358044;374026;374946;376366;381952;76938;79522.20477795263;80462.19537804546;81608.59195703984;81818.59090704628;1045.7333379988054;1072.9088027517591;1118.9272697274814;1121.8261169518737;1122.685648018556;16994.235259413603;17403.912980435016;17673.558161046076;17727.468175954742;17746.733798992766;37986;38361.42457863079;38878;39670.404943925285;40041;44103.33844992264;45073.323900140866;46079.3088103672;46937.76531117323;47058;8109.10799812032;8174.877376839471;8175.877361839696;8611.741647750578;8781.56092195375;11237.55049797999;12181.573644922386;12591.68520786951;13161.73676526445;13478.595642130751;10944.39805810688;11264.493097810455;11272.887271127183;11389.088872890314;11698.76602467929;9872.654457093968;9949.850752238866;10139.188864890939;10196.3372380795;10550.683479495627;11507.136964727511;11583.420828958688;11694.29834209916;11789.646310610695;11821.82267266009;8190.7133250335955;8274.379421543288;8382.832343352977;8389.203025712548;8592.054873963983;11198.272112313;11269.211155219056;11271.436428178395;11283.66149015531;11570.710732231762 22:15:15 INFO - PID 8431 | |3;mootools.html;1223.8164275358697;1301.5119330251157;1301.934903254837;1305.060356543289;1306.536179656222;10066.547005384757;10287.22845786567;10505;10509.054185123337;10717.892821071806;10504.947475262632;10613.946930265358;10630.840537391945;10708.143348532118;10724.463776811148;2289.3132060381904;2329.499157681098;2330.4639932815376;2346.4485845826216;2357.905683772647;2154.5475450155486;2236.955260894781;2237.9776202238013;2252.1892118837204;2252.662100684894;2071.4924843413387;2095.088636443152;2108.768035516092;2124.0441801189527;2126.5109024924277;2164;2164.5021645021575;2199.9890000549894;2220.3449982255274;2221.178164079293;2098.5593025464673;2166.7074944882397;2178.2811672148155;2260.79652831246;2263.5472905418983;10207.744806379826;10222.335548189343;10289.176865850788;10294.53674584638;10311.587536498606;5315.096433606258;5507.917381239285;5517.806876759334;5545.085060964936;5562.7774889004395;3334.2664613784927;3518.577770667511;3589.7128229741556;3600.3519366514015;3612.313660404515;1038.735122543754;1095.8137116690182;1122.78105769375;1140.2930183286333;1144.2447984330302;15219.162946038074;15225;15320.310586023656;15359.846401535953;15405.460808871749;4683.274092515666;4774.641901857305;4904.901901962012;5019.07147177766;5067.087924173684;10918.945405272923;10971.177161712903;10975.176861735401;11011.889881101246;11017;5406.297181366397;5458.972705136449;5463.071277882769;5467.343918729778;5482.835514934558;4923.384576927884;5064.620153488503;5066.645334826527;5081.136206844845;5120.92318615221;3803.5435747710453;3944.822482988215;3992.900177495586;4028.3957406389277;4043.6562892154498;1151.3782557419067;1160.431388619587;1175.5532897498895;1176.3294921894437;1187.5724739093919;697.9232284448707;699.2832346844424;706.2090458686304;709.4182770128446;724.2178447276929;5353.839384818461;5399.946000540023;5435.456454354533;5522.420145884705;5575.661841158093;538.3351560822381;539.4443722965274;543.2204786131913;545.4708932335628;546.3007350591249;3813.733038687321;3818.6754125899056;3868.0909986153233;3927.430522574211;3931.312020396419;12819.487220511262;12965.092443528862;13243.271620060988;13377.66555836112;13385.263810490516;12786.360681965865;13037.869621303855;13234.205947643171;13328.133671311334;13487.05590608648;7370.410367170506;7372.778816635509;7488.812779680552;7494.40044796415;7497.250274972459;5765.654060756368;5875.20684707559;5895.233619629421;6035.6076855004285;6047.606905551125;11604.477798499256;11906.583269585522;12015.399230038638;12058.457369418222;12137.21108127969;11971.162018658959;12207.75584488323;12288.569900053455;12376.319302438453;12444.81332779991;7525.548467091992;7685.38516918634;7691.15397306307;7693.346065584488;7703.88444173349;9272.211861991806;9345.766355841159;9406.81186376255;9411.623535058794;9423.952880235554;7758.943879871951;7906.209379062047;7923.841523169389;8062.5968701563515;8189.754307370788;7538.849223015399;7551.131619863566;7589.064788478902;7624.085109786861;7641.853721941531;7456.478046536908;7634.427417943787;7637.427192960439;7649.120351159465;7653.923460765321;5352.090144675492;5355.70543620089;5400.162974738922;5601.747921343631;5703.800366987136;5263.6578622389425;5339.119045357473;5426.945730542802;5429.53848922846;5653.349864765604 22:15:15 INFO - PID 8431 | |4;prototype.html;371.0464107244383;393.3391901605303;396.6727449853871;400.0279321249363;400.0977795072112;5335.626506144571;5500.339959204896;5530.4193059728705;5531.308586426701;5535.723213839312;5315.627906046579;5392.649477783942;5406.648567843097;5429.294191755076;5440.619156659035;4305.827766889329;4318.417013703157;4332.913341733163;4332.913341733163;4342.413774140482;4279.465066866642;4321.783910804463;4330.285502892019;4349.195398851207;4349.478062632488;4286.742795432268;4299.849505267316;4310.719803212781;4313.762743049131;4318.762468064255;4273.205253793414;4318.9784051079705;4321.114171594815;4324.481062272547;4327.7186982846015;3888.6121351001407;3917.4319723640197;3961.6632586230203;3986.242613903349;3986.382110772835;5306.548943339821;5306.734663266821;5355.437679043722;5382.2464854920345;5405.945940540623;5133.7122763553225;5139.922901156486;5145.434002259748;5158.097332966716;5161.5354618084175;5704.11586204139;5784.3926387729525;5790.7973220937065;5798.710064496759;5830.883382332372;4432.113577284524;4443.688941774077;4446.599806017474;4457.487388950248;4465.173942820588;5879.206307148565;6069.391611223029;6080.331163572004;6090.8781824363705;6168.907466388007;4319.092990472036;4324.243257429937;4332.501762297376;4340.175366680321;4344.1971581793205;4381.956180438155;4387.5393083726385;4404.66964977628;4406.801693923781;4416.432166580882;4882.218844984785;4932.260160975882;4957.3059771632;4973.950260497421;4983.875403114878;5756.769729210785;5776.364599894008;5779.24869766936;5795.623284486495;5830.912536311958;1599.8160211575585;1629.372691513752;1631;1635.893666911647;1644.5477493689332;1149.1496292743477;1170.4089434835353;1171.5782318365552;1186.0630102219322;1203.205884116479;4844.612431005511;4882;4898.730569818623;4911.3369695090705;4912.164931961575;5879.676617785977;5957.761689532457;5975.55183361241;5975.701214939236;5982.670953097621;4803.711777293303;4833.154198015333;4841.370621819141;4859.17780832188;4864.464908860023;3099.3336432667083;3133.2480204750696;3138.419392412411;3139.9215019624235;3143.9214019649235;5357.330333708286;5396.244525766396;5425.213344065089;5457.290552228185;5478.260434841325;6038;6073.331933487313;6073.8437854561;6088.878222435526;6091.451769340781;5464.590155738336;5464.863378415572;5465.863353416196;5476.808311709071;5479.589030822624;5699.831534535493;5859.970700146472;5903.114532820111;5909;5926.288845338587;5615.831525054255;5816.76732930678;5828.154917537018;5841.903790990782;5857.50211232033;5454.154606036071;5457.454254574511;5474.288342515448;5513.531349835149;5518.964569486686;4123.814428350672;4125;4156.210320039304;4159.958400415957;4166.41670166183;5932.644041357532;5977.282726072899;6034.517238620988;6042.788502402394;6046;5783.913241301299;5787.594868359174;5802.303723553201;5808.5062769665055;5839.912401314069;5708.714564271853;5780.421957804186;5795.275590551181;5808.332041815245;5814.30228372581;5695.914561281501;5705.144228365612;5719.056355701263;5738.311402631711;5768.394318596487;5849.61977471463;5864.914990726729;5880.705964701833;5888.4700376966275;5905.40945905406;5585.3297604287745;5625.943740562542;5674.4892959633835;5676.971615141898;5710.314762228559 22:15:15 INFO - PID 8431 | |5;yui.html;732.2823632839813;755.9773206803794;757.3978686943879;771.6141929035482;782.4874707066872;11737.765244695102;12337;13558.322083895815;14276.143431394124;14283.357248923798;14321.78517322241;14872.33074511647;15016;15158.317875695593;15182.620434489143;845.3152946113637;866.1944391715733;870.0516437083578;870.5473153959937;874.33113668044;857.6012154348227;861.027039445429;861.6467248428146;862.6204470033197;863.0808189278398;910.2217603948628;911.1935936696005;913.5158366065963;914.6890057380489;917.1699611851285;902.2421166220406;902.5351943748974;902.6705252582825;902.9638814447414;904.7692838326218;662.407145604686;662.7382184037326;662.8707402056601;665.0987911380107;665.4011389749217;12414.937925310405;12422.627321180378;12942.22346659194;14580.854191458056;14742.262886855722;14859.405623775036;15065.849341506664;15392.153431561259;15412.152331621757;15433.614159645986;12122;12289.877101229053;12429.689257768538;12447.626571202878;12456.190347627466;2926.8097573657856;2931.8973835915854;2931.985340073286;2938.7942844000927;2950.2771820904018;63082;63255.051174231965;63543.6822815883;64138.35861641371;65108;10615.203859710553;10647.094996925349;10715;10828.675139745821;10923.071538919123;17676.469705908843;17681.204345804214;17694;17695.823041769418;17720;6087.239095113111;6104;6356.4279214870885;6363.236411630634;6367.299597044322;3027.197792584967;3097.0399176255432;3098.5042393216977;3099.411111888734;3105.192649910994;3560.145565064366;3632.4551317302617;3632.9636703632627;3938.4683067786054;4069.595989383658;779;798.6685525506966;809.3282575462352;811.5455345006815;812.975610731679;559.6781850436015;584.3367777572486;585.4847733994058;585.733491261475;590.9172715819789;9323.25413966881;9579.629546351738;9627.518624068769;9632.807343853225;10018.549165287579;605.9575829691968;610.9083637454329;614.6772944204239;622.2377587455331;623.5915475363644;4313.390398808739;4406.823727050946;4425.845095421645;4439.4006809080365;4550;56253.43746562482;57713.13430298549;59307.70346148328;63499.36500635027;63770;48576;48669;49539;50489.74755126201;50890;46361.5363846364;46365.53634463612;46575.5342446578;46670;47475.525244747114;9964.451955142536;10158.898411015794;10161.796764064826;10413.635522756971;10786.244962852525;24962.875185623954;25179.622305665063;25300.873495632404;25456.490870182864;25578.744212557634;39216;40911.38632920568;41571;42648.14703705971;43094.13811723811;13900.096493727875;14024.08843425215;14140.78788818148;14260.928695356457;14306;15747.921260394083;16073.276702548179;16082.195890205208;16489.91755041217;16567.50297491077;13902.930485347508;14414.42342306296;14567.198804065878;14623.415063397344;14735;14441;14458.783118253445;14551.85448145505;16166.595835104217;16311.26599303058;14883.553493395215;15047.623809404415;15175.468858589897;15567.221638917783;15801.762973555637;8362.247397734232;8409.453385529921;8658.610362533575;9077.818443630958;9547.486837469409;10695.839562406414;10760.838587421038;11227.438628068727;11359.772804543698;11433.1996760226 22:15:15 INFO - PID 8431 | __end_tp_report 22:15:15 INFO - PID 8431 | __start_cc_report 22:15:15 INFO - PID 8431 | _x_x_mozilla_cycle_collect,284 22:15:15 INFO - PID 8431 | __end_cc_report 22:15:15 INFO - PID 8431 | __startTimestamp1495084515327__endTimestamp 22:15:15 INFO - PID 8431 | 22:15:15 INFO - PID 8431 | ------- Summary: start ------- 22:15:15 INFO - PID 8431 | Number of tests: 6 22:15:15 INFO - PID 8431 | 22:15:15 INFO - PID 8431 | [#0] dojo.html Cycles:165 Average:5137.39 Median:5279.45 stddev:608.69 (11.5%) stddev-sans-first:579.04 22:15:15 INFO - PID 8431 | Values: 2672.9 2678.2 2688.7 2708.7 2716.3 5073.8 5206.1 5216.2 5229.6 5258.2 5176.9 5205.7 5262.7 5279.4 5293.2 4385.2 4569.6 4670.3 4692.0 4696.4 4704.1 4729.2 4747.0 4768.2 4771.3 4562.4 4610.7 4644.7 4658.5 4665.4 4677.2 4684.8 4689.6 4704.9 4739.0 4615.1 4651.9 4671.1 4672.6 4720.0 5053.2 5144.3 5170.4 5223.8 5282.9 5588.1 5601.0 5674.4 5677.9 5685.5 5596.7 5608.3 5609.7 5636.8 5645.5 5109.7 5252.9 5263.2 5267.1 5268.9 5707.4 5797.9 5856.8 5873.5 5883.7 5470.9 5484.6 5511.6 5516.0 5520.7 5455.4 5499.4 5591.8 5604.2 5691.6 5497.2 5574.2 5604.8 5632.4 5652.3 5410.2 5452.8 5536.4 5609.3 5647.2 4696.2 4732.2 4736.8 4754.6 4774.9 4026.3 4051.4 4051.5 4057.9 4089.7 4589.5 4654.2 4675.7 4717.4 4722.2 5680.1 5681.9 5709.9 5711.1 5713.2 4688.1 4695.2 4697.7 4701.4 4742.1 4861.2 4927.1 4994.9 4997.2 5008.8 5203.5 5210.9 5238.1 5258.2 5275.7 5581.6 5602.0 5631.1 5659.7 5669.5 5047.4 5122.1 5232.3 5233.5 5238.2 5566.2 5588.3 5595.0 5596.4 5618.3 5655.0 5663.5 5667.9 5674.8 5692.9 5379.3 5451.4 5454.2 5490.0 5498.5 5449.9 5489.1 5489.8 5500.5 5556.6 5379.7 5380.5 5421.2 5432.0 5475.8 5372.1 5442.1 5475.0 5520.1 5539.3 5360.8 5372.5 5398.6 5433.0 5433.5 22:15:15 INFO - PID 8431 | 22:15:15 INFO - PID 8431 | [#1] ext.html Cycles:180 Average:29801.99 Median:16939.53 stddev:39838.05 (235.2%) stddev-sans-first:39889.77 22:15:15 INFO - PID 8431 | Values: 673.6 730.1 752.9 995.8 999.2 31495.9 32867.0 32898.8 32993.5 33124.5 34531.0 34969.3 35306.0 35318.6 35347.5 6833.8 6929.4 7022.7 7036.6 7087.1 7036.6 7138.8 7144.3 7146.1 7150.5 7105.1 7128.6 7138.4 7152.5 7152.8 7117.5 7127.4 7130.1 7130.4 7137.8 6975.5 7008.0 7030.5 7035.4 7074.2 31963.8 32179.8 32187.7 32213.2 32268.4 2807.8 2825.1 2827.4 2840.9 2842.2 24192.4 24261.8 24296.4 24404.3 24471.5 3034.5 3048.2 3055.6 3079.4 3085.8 144262.0 145590.3 146989.0 152479.0 153065.0 39204.0 39523.8 39572.4 39581.0 39600.0 40368.2 40386.2 40593.6 40649.4 40656.6 11287.4 11291.4 11359.5 11360.9 11434.4 9035.6 9061.8 9064.9 9065.3 9067.8 12875.4 12982.3 12992.9 13025.5 13220.1 5275.2 5463.4 5478.6 5528.6 5558.3 852.9 891.3 894.6 920.3 931.9 20947.0 20959.5 21350.4 21527.5 21852.8 976.4 978.2 978.7 997.5 1009.7 11055.3 11429.4 11523.9 11524.7 11590.2 170623.0 170790.0 171061.0 171128.0 171345.0 39112.2 39851.8 39867.8 39892.6 39894.4 1178.5 1218.7 1227.6 1229.2 1234.6 19518.7 19695.6 20396.2 21242.6 21351.4 29467.9 29636.3 29651.3 29696.9 29735.6 142311.0 142842.0 142878.0 143042.0 143264.0 28364.0 29620.9 30255.8 30712.0 30731.0 35519.0 36131.5 36194.5 36255.1 36316.0 26700.7 27263.9 27407.7 28152.3 29535.1 26999.0 27017.7 27402.8 28662.3 28945.4 30257.2 30799.7 30905.2 31169.2 31539.4 23924.6 24148.9 24640.9 24924.8 25051.7 21796.8 22359.7 22746.5 22757.8 22764.5 22:15:15 INFO - PID 8431 | 22:15:15 INFO - PID 8431 | [#2] jquery.html Cycles:180 Average:25152.38 Median:210156.71 stddev:62292.04 (29.6%) stddev-sans-first:62439.09 22:15:15 INFO - PID 8431 | Values: 411.3 417.9 420.9 433.2 439.5 16910.2 17551.8 17552.6 17633.2 18098.3 18284.0 18494.5 18542.5 18694.3 18793.2 5428.9 5474.5 5581.7 5613.9 5663.5 5398.3 5505.3 5522.2 5534.5 5537.4 5334.2 5422.7 5449.7 5472.1 5517.9 5484.7 5499.5 5509.5 5516.3 5523.6 4929.6 4969.1 5011.0 5011.0 5012.9 21291.5 21791.6 21895.1 22449.7 22576.8 1616.6 1631.4 1664.1 1699.8 1709.0 14809.3 14945.6 15077.8 15138.9 15226.8 2051.2 2068.8 2115.7 2143.7 2151.2 82484.6 90772.0 92724.0 101567.0 103105.5 10965.4 10975.6 11113.6 11217.2 11320.4 15250.8 15266.2 15294.0 15319.4 15360.8 6718.8 7043.3 7065.4 7186.4 7215.5 6188.7 6227.6 6339.3 6379.9 6422.3 6887.6 6979.4 6983.8 7000.7 7063.7 2002.2 2011.2 2051.2 2064.7 2200.8 818.9 838.7 861.5 867.9 869.4 16104.0 16786.6 17141.6 17163.5 17228.9 858.9 863.3 869.4 873.9 884.5 8879.9 9309.9 9404.1 9422.6 9455.7 358044.0 374026.0 374946.0 376366.0 381952.0 76938.0 79522.2 80462.2 81608.6 81818.6 1045.7 1072.9 1118.9 1121.8 1122.7 16994.2 17403.9 17673.6 17727.5 17746.7 37986.0 38361.4 38878.0 39670.4 40041.0 44103.3 45073.3 46079.3 46937.8 47058.0 8109.1 8174.9 8175.9 8611.7 8781.6 11237.6 12181.6 12591.7 13161.7 13478.6 10944.4 11264.5 11272.9 11389.1 11698.8 9872.7 9949.9 10139.2 10196.3 10550.7 11507.1 11583.4 11694.3 11789.6 11821.8 8190.7 8274.4 8382.8 8389.2 8592.1 11198.3 11269.2 11271.4 11283.7 11570.7 22:15:15 INFO - PID 8431 | 22:15:15 INFO - PID 8431 | [#3] mootools.html Cycles:180 Average:6282.89 Median:3808.64 stddev:4052.63 (106.4%) stddev-sans-first:4046.17 22:15:15 INFO - PID 8431 | Values: 1223.8 1301.5 1301.9 1305.1 1306.5 10066.5 10287.2 10505.0 10509.1 10717.9 10504.9 10613.9 10630.8 10708.1 10724.5 2289.3 2329.5 2330.5 2346.4 2357.9 2154.5 2237.0 2238.0 2252.2 2252.7 2071.5 2095.1 2108.8 2124.0 2126.5 2164.0 2164.5 2200.0 2220.3 2221.2 2098.6 2166.7 2178.3 2260.8 2263.5 10207.7 10222.3 10289.2 10294.5 10311.6 5315.1 5507.9 5517.8 5545.1 5562.8 3334.3 3518.6 3589.7 3600.4 3612.3 1038.7 1095.8 1122.8 1140.3 1144.2 15219.2 15225.0 15320.3 15359.8 15405.5 4683.3 4774.6 4904.9 5019.1 5067.1 10918.9 10971.2 10975.2 11011.9 11017.0 5406.3 5459.0 5463.1 5467.3 5482.8 4923.4 5064.6 5066.6 5081.1 5120.9 3803.5 3944.8 3992.9 4028.4 4043.7 1151.4 1160.4 1175.6 1176.3 1187.6 697.9 699.3 706.2 709.4 724.2 5353.8 5399.9 5435.5 5522.4 5575.7 538.3 539.4 543.2 545.5 546.3 3813.7 3818.7 3868.1 3927.4 3931.3 12819.5 12965.1 13243.3 13377.7 13385.3 12786.4 13037.9 13234.2 13328.1 13487.1 7370.4 7372.8 7488.8 7494.4 7497.3 5765.7 5875.2 5895.2 6035.6 6047.6 11604.5 11906.6 12015.4 12058.5 12137.2 11971.2 12207.8 12288.6 12376.3 12444.8 7525.5 7685.4 7691.2 7693.3 7703.9 9272.2 9345.8 9406.8 9411.6 9424.0 7758.9 7906.2 7923.8 8062.6 8189.8 7538.8 7551.1 7589.1 7624.1 7641.9 7456.5 7634.4 7637.4 7649.1 7653.9 5352.1 5355.7 5400.2 5601.7 5703.8 5263.7 5339.1 5426.9 5429.5 5653.3 22:15:15 INFO - PID 8431 | 22:15:15 INFO - PID 8431 | [#4] prototype.html Cycles:180 Average:4818.51 Median:5369.79 stddev:1351.41 (25.2%) stddev-sans-first:1313.32 22:15:15 INFO - PID 8431 | Values: 371.0 393.3 396.7 400.0 400.1 5335.6 5500.3 5530.4 5531.3 5535.7 5315.6 5392.6 5406.6 5429.3 5440.6 4305.8 4318.4 4332.9 4332.9 4342.4 4279.5 4321.8 4330.3 4349.2 4349.5 4286.7 4299.8 4310.7 4313.8 4318.8 4273.2 4319.0 4321.1 4324.5 4327.7 3888.6 3917.4 3961.7 3986.2 3986.4 5306.5 5306.7 5355.4 5382.2 5405.9 5133.7 5139.9 5145.4 5158.1 5161.5 5704.1 5784.4 5790.8 5798.7 5830.9 4432.1 4443.7 4446.6 4457.5 4465.2 5879.2 6069.4 6080.3 6090.9 6168.9 4319.1 4324.2 4332.5 4340.2 4344.2 4382.0 4387.5 4404.7 4406.8 4416.4 4882.2 4932.3 4957.3 4974.0 4983.9 5756.8 5776.4 5779.2 5795.6 5830.9 1599.8 1629.4 1631.0 1635.9 1644.5 1149.1 1170.4 1171.6 1186.1 1203.2 4844.6 4882.0 4898.7 4911.3 4912.2 5879.7 5957.8 5975.6 5975.7 5982.7 4803.7 4833.2 4841.4 4859.2 4864.5 3099.3 3133.2 3138.4 3139.9 3143.9 5357.3 5396.2 5425.2 5457.3 5478.3 6038.0 6073.3 6073.8 6088.9 6091.5 5464.6 5464.9 5465.9 5476.8 5479.6 5699.8 5860.0 5903.1 5909.0 5926.3 5615.8 5816.8 5828.2 5841.9 5857.5 5454.2 5457.5 5474.3 5513.5 5519.0 4123.8 4125.0 4156.2 4160.0 4166.4 5932.6 5977.3 6034.5 6042.8 6046.0 5783.9 5787.6 5802.3 5808.5 5839.9 5708.7 5780.4 5795.3 5808.3 5814.3 5695.9 5705.1 5719.1 5738.3 5768.4 5849.6 5864.9 5880.7 5888.5 5905.4 5585.3 5625.9 5674.5 5677.0 5710.3 22:15:15 INFO - PID 8431 | 22:15:15 INFO - PID 8431 | [#5] yui.html Cycles:180 Average:14643.20 Median:22490.49 stddev:16722.01 (74.4%) stddev-sans-first:16736.28 22:15:15 INFO - PID 8431 | Values: 732.3 756.0 757.4 771.6 782.5 11737.8 12337.0 13558.3 14276.1 14283.4 14321.8 14872.3 15016.0 15158.3 15182.6 845.3 866.2 870.1 870.5 874.3 857.6 861.0 861.6 862.6 863.1 910.2 911.2 913.5 914.7 917.2 902.2 902.5 902.7 903.0 904.8 662.4 662.7 662.9 665.1 665.4 12414.9 12422.6 12942.2 14580.9 14742.3 14859.4 15065.8 15392.2 15412.2 15433.6 12122.0 12289.9 12429.7 12447.6 12456.2 2926.8 2931.9 2932.0 2938.8 2950.3 63082.0 63255.1 63543.7 64138.4 65108.0 10615.2 10647.1 10715.0 10828.7 10923.1 17676.5 17681.2 17694.0 17695.8 17720.0 6087.2 6104.0 6356.4 6363.2 6367.3 3027.2 3097.0 3098.5 3099.4 3105.2 3560.1 3632.5 3633.0 3938.5 4069.6 779.0 798.7 809.3 811.5 813.0 559.7 584.3 585.5 585.7 590.9 9323.3 9579.6 9627.5 9632.8 10018.5 606.0 610.9 614.7 622.2 623.6 4313.4 4406.8 4425.8 4439.4 4550.0 56253.4 57713.1 59307.7 63499.4 63770.0 48576.0 48669.0 49539.0 50489.7 50890.0 46361.5 46365.5 46575.5 46670.0 47475.5 9964.5 10158.9 10161.8 10413.6 10786.2 24962.9 25179.6 25300.9 25456.5 25578.7 39216.0 40911.4 41571.0 42648.1 43094.1 13900.1 14024.1 14140.8 14260.9 14306.0 15747.9 16073.3 16082.2 16489.9 16567.5 13902.9 14414.4 14567.2 14623.4 14735.0 14441.0 14458.8 14551.9 16166.6 16311.3 14883.6 15047.6 15175.5 15567.2 15801.8 8362.2 8409.5 8658.6 9077.8 9547.5 10695.8 10760.8 11227.4 11359.8 11433.2 22:15:15 INFO - PID 8431 | -------- Summary: end -------- 22:15:15 INFO - PID 8431 | 22:15:16 INFO - TEST-INFO | 8431: exit 0 22:15:16 INFO - TEST-OK | dromaeo_css | took 1118695ms 22:15:16 INFO - TEST-START | kraken 22:15:16 INFO - operating with platform_type : linux_ 22:15:16 INFO - Initialising browser for kraken test... 22:15:16 INFO - TEST-INFO | started process 8850 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptPjonx/profile http://localhost:57089/getInfo.html) 22:15:16 INFO - PID 8850 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2939: String.localeCompare is deprecated; use String.prototype.localeCompare instead 22:15:20 INFO - PID 8850 | __metrics Screen width/height:1600/1200 22:15:20 INFO - PID 8850 | colorDepth:24 22:15:20 INFO - PID 8850 | Browser inner width/height: 1024/695 22:15:20 INFO - PID 8850 | __metrics 22:15:22 INFO - TEST-INFO | 8850: exit 0 22:15:22 INFO - Browser initialized. 22:15:22 INFO - Running cycle 1/1 for kraken test... 22:15:22 INFO - TEST-INFO | started process 9028 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptPjonx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:15:34 INFO - PID 9028 | RSS: Main: 168689664 22:15:34 INFO - PID 9028 | 22:15:36 INFO - PID 9028 | Cycle 1(1): loaded http://localhost:57089/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57089/tests/kraken/driver.html?testName=audio-beat-detection) 22:15:37 INFO - PID 9028 | RSS: Main: 173731840 22:15:37 INFO - PID 9028 | 22:15:40 INFO - PID 9028 | Cycle 1(1): loaded http://localhost:57089/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57089/tests/kraken/driver.html?testName=audio-dft) 22:15:41 INFO - PID 9028 | RSS: Main: 173232128 22:15:41 INFO - PID 9028 | 22:15:44 INFO - PID 9028 | Cycle 1(1): loaded http://localhost:57089/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57089/tests/kraken/driver.html?testName=audio-fft) 22:15:44 INFO - PID 9028 | RSS: Main: 168669184 22:15:44 INFO - PID 9028 | 22:15:46 INFO - PID 9028 | Cycle 1(1): loaded http://localhost:57089/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57089/tests/kraken/driver.html?testName=audio-oscillator) 22:15:47 INFO - PID 9028 | RSS: Main: 168964096 22:15:47 INFO - PID 9028 | 22:15:49 INFO - PID 9028 | Cycle 1(1): loaded http://localhost:57089/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57089/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:15:50 INFO - PID 9028 | RSS: Main: 169586688 22:15:50 INFO - PID 9028 | 22:15:53 INFO - PID 9028 | Cycle 1(1): loaded http://localhost:57089/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57089/tests/kraken/driver.html?testName=imaging-darkroom) 22:15:53 INFO - PID 9028 | RSS: Main: 173674496 22:15:53 INFO - PID 9028 | 22:15:57 INFO - PID 9028 | Cycle 1(1): loaded http://localhost:57089/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57089/tests/kraken/driver.html?testName=imaging-desaturate) 22:15:58 INFO - PID 9028 | RSS: Main: 170627072 22:15:58 INFO - PID 9028 | 22:16:01 INFO - PID 9028 | Cycle 1(1): loaded http://localhost:57089/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57089/tests/kraken/driver.html?testName=json-parse-financial) 22:16:01 INFO - PID 9028 | RSS: Main: 171945984 22:16:01 INFO - PID 9028 | 22:16:03 INFO - PID 9028 | Cycle 1(1): loaded http://localhost:57089/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57089/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:16:04 INFO - PID 9028 | RSS: Main: 172310528 22:16:04 INFO - PID 9028 | 22:16:05 INFO - PID 9028 | Cycle 1(1): loaded http://localhost:57089/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57089/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:16:06 INFO - PID 9028 | RSS: Main: 172322816 22:16:06 INFO - PID 9028 | 22:16:08 INFO - PID 9028 | Cycle 1(1): loaded http://localhost:57089/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57089/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:16:09 INFO - PID 9028 | RSS: Main: 172265472 22:16:09 INFO - PID 9028 | 22:16:11 INFO - PID 9028 | Cycle 1(1): loaded http://localhost:57089/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57089/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:16:12 INFO - PID 9028 | RSS: Main: 172134400 22:16:12 INFO - PID 9028 | 22:16:15 INFO - PID 9028 | Cycle 1(1): loaded http://localhost:57089/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57089/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:16:16 INFO - PID 9028 | RSS: Main: 172138496 22:16:16 INFO - PID 9028 | 22:16:18 INFO - PID 9028 | Cycle 1(1): loaded http://localhost:57089/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57089/tests/kraken/driver.html?testName=ai-astar) 22:16:18 INFO - PID 9028 | RSS: Main: 173694976 22:16:18 INFO - PID 9028 | 22:16:18 INFO - PID 9028 | __start_tp_report 22:16:18 INFO - PID 9028 | _x_x_mozilla_page_load 22:16:18 INFO - PID 9028 | _x_x_mozilla_page_load_details 22:16:18 INFO - PID 9028 | |i|pagename|runs| 22:16:18 INFO - PID 9028 | |0;ai-astar;103;115;111;111;112;113;111;110;110;113 22:16:18 INFO - PID 9028 | |1;audio-beat-detection;150;123;129;187;125;125;129;125;151;125 22:16:18 INFO - PID 9028 | |2;audio-dft;162;164;167;163;168;169;176;162;163;164 22:16:18 INFO - PID 9028 | |3;audio-fft;74;74;75;110;77;76;75;79;104;75 22:16:18 INFO - PID 9028 | |4;audio-oscillator;82;84;110;83;82;84;99;83;83;102 22:16:18 INFO - PID 9028 | |5;imaging-gaussian-blur;114;114;114;115;114;115;114;116;118;115 22:16:18 INFO - PID 9028 | |6;imaging-darkroom;150;150;153;150;151;151;151;151;152;151 22:16:18 INFO - PID 9028 | |7;imaging-desaturate;95;96;94;94;94;94;94;99;95;95 22:16:18 INFO - PID 9028 | |8;json-parse-financial;55;55;55;56;60;59;56;56;55;58 22:16:18 INFO - PID 9028 | |9;json-stringify-tinderbox;56;56;55;56;55;56;58;56;56;57 22:16:18 INFO - PID 9028 | |10;stanford-crypto-aes;82;82;83;82;90;81;83;85;82;83 22:16:18 INFO - PID 9028 | |11;stanford-crypto-ccm;135;135;142;136;137;133;141;138;219;144 22:16:18 INFO - PID 9028 | |12;stanford-crypto-pbkdf2;187;187;194;199;196;195;199;198;200;195 22:16:18 INFO - PID 9028 | |13;stanford-crypto-sha256-iterative;76;74;73;82;75;78;75;73;72;77 22:16:18 INFO - PID 9028 | __end_tp_report 22:16:18 INFO - PID 9028 | __start_cc_report 22:16:18 INFO - PID 9028 | _x_x_mozilla_cycle_collect,763 22:16:18 INFO - PID 9028 | __end_cc_report 22:16:18 INFO - PID 9028 | __startTimestamp1495084578719__endTimestamp 22:16:18 INFO - PID 9028 | 22:16:18 INFO - PID 9028 | ------- Summary: start ------- 22:16:18 INFO - PID 9028 | Number of tests: 14 22:16:18 INFO - PID 9028 | 22:16:18 INFO - PID 9028 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.50 stddev:3.18 (2.9%) stddev-sans-first:1.64 22:16:18 INFO - PID 9028 | Values: 103.0 115.0 111.0 111.0 112.0 113.0 111.0 110.0 110.0 113.0 22:16:18 INFO - PID 9028 | 22:16:18 INFO - PID 9028 | [#1] audio-beat-detection Cycles:10 Average:136.90 Median:129.00 stddev:20.45 (15.9%) stddev-sans-first:21.14 22:16:18 INFO - PID 9028 | Values: 150.0 123.0 129.0 187.0 125.0 125.0 129.0 125.0 151.0 125.0 22:16:18 INFO - PID 9028 | 22:16:18 INFO - PID 9028 | [#2] audio-dft Cycles:10 Average:165.80 Median:165.50 stddev:4.37 (2.6%) stddev-sans-first:4.41 22:16:18 INFO - PID 9028 | Values: 162.0 164.0 167.0 163.0 168.0 169.0 176.0 162.0 163.0 164.0 22:16:18 INFO - PID 9028 | 22:16:18 INFO - PID 9028 | [#3] audio-fft Cycles:10 Average:81.90 Median:75.00 stddev:13.39 (17.8%) stddev-sans-first:13.89 22:16:18 INFO - PID 9028 | Values: 74.0 74.0 75.0 110.0 77.0 76.0 75.0 79.0 104.0 75.0 22:16:18 INFO - PID 9028 | 22:16:18 INFO - PID 9028 | [#4] audio-oscillator Cycles:10 Average:89.20 Median:83.00 stddev:10.36 (12.5%) stddev-sans-first:10.65 22:16:18 INFO - PID 9028 | Values: 82.0 84.0 110.0 83.0 82.0 84.0 99.0 83.0 83.0 102.0 22:16:18 INFO - PID 9028 | 22:16:18 INFO - PID 9028 | [#5] imaging-gaussian-blur Cycles:10 Average:114.90 Median:115.00 stddev:1.29 (1.1%) stddev-sans-first:1.32 22:16:18 INFO - PID 9028 | Values: 114.0 114.0 114.0 115.0 114.0 115.0 114.0 116.0 118.0 115.0 22:16:18 INFO - PID 9028 | 22:16:18 INFO - PID 9028 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:151.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 22:16:18 INFO - PID 9028 | Values: 150.0 150.0 153.0 150.0 151.0 151.0 151.0 151.0 152.0 151.0 22:16:18 INFO - PID 9028 | 22:16:18 INFO - PID 9028 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:1.56 (1.6%) stddev-sans-first:1.66 22:16:18 INFO - PID 9028 | Values: 95.0 96.0 94.0 94.0 94.0 94.0 94.0 99.0 95.0 95.0 22:16:18 INFO - PID 9028 | 22:16:18 INFO - PID 9028 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:56.00 stddev:1.84 (3.3%) stddev-sans-first:1.87 22:16:18 INFO - PID 9028 | Values: 55.0 55.0 55.0 56.0 60.0 59.0 56.0 56.0 55.0 58.0 22:16:18 INFO - PID 9028 | 22:16:18 INFO - PID 9028 | [#9] json-stringify-tinderbox Cycles:10 Average:56.10 Median:56.00 stddev:0.88 (1.6%) stddev-sans-first:0.93 22:16:18 INFO - PID 9028 | Values: 56.0 56.0 55.0 56.0 55.0 56.0 58.0 56.0 56.0 57.0 22:16:18 INFO - PID 9028 | 22:16:18 INFO - PID 9028 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:83.00 stddev:2.58 (3.1%) stddev-sans-first:2.70 22:16:18 INFO - PID 9028 | Values: 82.0 82.0 83.0 82.0 90.0 81.0 83.0 85.0 82.0 83.0 22:16:18 INFO - PID 9028 | 22:16:18 INFO - PID 9028 | [#11] stanford-crypto-ccm Cycles:10 Average:146.00 Median:139.50 stddev:25.88 (18.6%) stddev-sans-first:27.15 22:16:18 INFO - PID 9028 | Values: 135.0 135.0 142.0 136.0 137.0 133.0 141.0 138.0 219.0 144.0 22:16:18 INFO - PID 9028 | 22:16:18 INFO - PID 9028 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.00 Median:197.00 stddev:4.67 (2.4%) stddev-sans-first:3.95 22:16:18 INFO - PID 9028 | Values: 187.0 187.0 194.0 199.0 196.0 195.0 199.0 198.0 200.0 195.0 22:16:18 INFO - PID 9028 | 22:16:18 INFO - PID 9028 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.50 Median:75.50 stddev:2.95 (3.9%) stddev-sans-first:3.13 22:16:18 INFO - PID 9028 | Values: 76.0 74.0 73.0 82.0 75.0 78.0 75.0 73.0 72.0 77.0 22:16:18 INFO - PID 9028 | -------- Summary: end -------- 22:16:18 INFO - PID 9028 | 22:16:19 INFO - TEST-INFO | 9028: exit 0 22:16:19 INFO - TEST-OK | kraken | took 63728ms 22:16:19 INFO - SUITE-END | took 1182s 22:16:20 INFO - Completed test suite (00:19:42) 22:16:20 INFO - javascript benchmark 22:16:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6693.462747218325, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2672.861137835292, 2678.156380740068, 2688.7176846431125, 2708.7020427752955, 2716.3073416278844, 5073.822416215433, 5206.062908676437, 5216.217567364893, 5229.633925625208, 5258.158694608864, 5176.896462070757, 5205.739713014353, 5262.684238945656, 5279.445658205891, 5293.15309550471, 4385.166818304528, 4569.588737013668, 4670.276107203372, 4692.0381321828945, 4696.412948381452, 4704.136412983925, 4729.2433210686295, 4747.003129342842, 4768.189407800664, 4771.308160316752, 4562.406887104688, 4610.723356598614, 4644.698094623838, 4658.487566367697, 4665.440147182326, 4677.158111539921, 4684.765761711901, 4689.577937985564, 4704.9059018819435, 4739.0, 4615.123126605934, 4651.88370290742, 4671.065786842645, 4672.649551283634, 4719.976400117977, 5053.242013697938, 5144.279800827887, 5170.431252562215, 5223.843284701465, 5282.894342113174, 5588.133839254922, 5601.0, 5674.375818659944, 5677.943220567783, 5685.545156387479, 5596.664200147963, 5608.327000759894, 5609.663420194802, 5636.802711905105, 5645.5483561314995, 5109.667871588409, 5252.947470525246, 5263.157894736901, 5267.104592219332, 5268.868278293074, 5707.429257074343, 5797.942020579824, 5856.765729370777, 5873.530117590582, 5883.7058147092475, 5470.863228419242, 5484.561235101182, 5511.559075273968, 5516.034693928546, 5520.723963801794, 5455.399906010336, 5499.395066542677, 5591.804286849941, 5604.187392828017, 5691.630044047124, 5497.202905578669, 5574.1917421973585, 5604.8318550443555, 5632.436756324417, 5652.3217213934595, 5410.161424979135, 5452.754626041838, 5536.390996990328, 5609.326880774333, 5647.209390685307, 4696.201645720235, 4732.242841145469, 4736.7631618418945, 4754.643401744883, 4774.856754297377, 4026.275270451347, 4051.4125451809323, 4051.493563304587, 4057.918841623151, 4089.734167279117, 4589.495155532889, 4654.162250794821, 4675.742834144155, 4717.43390793107, 4722.173619616553, 5680.062789639664, 5681.914771278434, 5709.942900571024, 5711.143328500758, 5713.171590119409, 4688.109259240733, 4695.201815691341, 4697.671163018625, 4701.3653156824075, 4742.099001189763, 4861.222204447272, 4927.088488629615, 4994.925076123861, 4997.200447928314, 5008.77460514285, 5203.505666961632, 5210.947890521046, 5238.083335416363, 5258.237555554347, 5275.683458992473, 5581.609287349846, 5602.047651899105, 5631.070873305859, 5659.6887171204335, 5669.546436285004, 5047.444781074006, 5122.129238029618, 5232.2936403586555, 5233.450487698737, 5238.214267859851, 5566.248556444828, 5588.329400471969, 5595.0, 5596.440355964371, 5618.269624948731, 5654.971725141348, 5663.490285874291, 5667.886642267049, 5674.801381951612, 5692.857678558069, 5379.300690910157, 5451.4276001019325, 5454.209139674805, 5489.972550137224, 5498.45015498447, 5449.891002179855, 5489.066858634122, 5489.780408783604, 5500.477454641803, 5556.555475562026, 5379.73101344939, 5380.515753582196, 5421.213923980922, 5431.995080910045, 5475.753591088331, 5372.059889519241, 5442.0748472760515, 5475.041867673221, 5520.089185284543, 5539.279893613804, 5360.758765855624, 5372.516473517402, 5398.64908780928, 5433.0, 5433.5381492572], "value": 5092.789501191489, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [673.5958424945034, 730.1384366447592, 752.9322360987512, 995.8406654935203, 999.175680063947, 31495.9055322808, 32867.0, 32898.8355058225, 32993.50509742356, 33124.503132453036, 34531.0, 34969.3006139877, 35306.0, 35318.64681353186, 35347.4697879532, 6833.794986150423, 6929.376356127935, 7022.683979220922, 7036.648167591626, 7087.114110736158, 7036.577805331671, 7138.78583642489, 7144.321289477517, 7146.106736657918, 7150.499465037449, 7105.076340075809, 7128.6079265640365, 7138.357547820695, 7152.463565232602, 7152.821179470503, 7117.501774875761, 7127.42980561559, 7130.073090498254, 7130.429565634737, 7137.82155446118, 6975.476839237078, 7008.0, 7030.472714546429, 7035.366816986445, 7074.151101867808, 31963.84018079918, 32179.83910080458, 32187.678123218702, 32213.194670133435, 32268.354632907445, 2807.8174918630225, 2825.0677276498704, 2827.4486475137355, 2840.9289767755763, 2842.2468045967835, 24192.395190120387, 24261.757382426127, 24296.39259018521, 24404.267871963693, 24471.510569788505, 3034.499307614241, 3048.1769922121125, 3055.5569442430947, 3079.3687294104657, 3085.7531397488146, 144262.0, 145590.27204863908, 146989.0, 152479.0, 153065.0, 39204.0, 39523.80238098791, 39572.40641390382, 39581.0, 39600.0, 40368.19263614711, 40386.19227615431, 40593.59406405957, 40649.39025914614, 40656.59343406587, 11287.435628218556, 11291.3789741565, 11359.488823002985, 11360.886391136148, 11434.428278586038, 9035.593398297093, 9061.77345566353, 9064.864027039599, 9065.320100992452, 9067.818643627223, 12875.356232188353, 12982.285974271506, 12992.870071299356, 13025.47898084085, 13220.140690855256, 5275.182346736262, 5463.426340234298, 5478.643888147258, 5528.55771538276, 5558.305211848519, 852.9402941794015, 891.3047822698305, 894.5890824228642, 920.3189639666732, 931.888173419194, 20947.0, 20959.476013099793, 21350.35948921535, 21527.46181345479, 21852.781472185394, 976.3751199232497, 978.1685567267765, 978.6525783346951, 997.5012493753123, 1009.6869970309227, 11055.281406708538, 11429.428528573539, 11523.884761152449, 11524.654260372203, 11590.188686792013, 170623.0, 170790.0, 171061.0, 171128.0, 171345.0, 39112.21775564473, 39851.80074099611, 39867.80066099709, 39892.60107398947, 39894.401583976265, 1178.5011060602344, 1218.6892342452795, 1227.6439832448668, 1229.16416836552, 1234.6419538333782, 19518.707219392003, 19695.606087877877, 20396.184152633727, 21242.575148496635, 21351.359459216248, 29467.85266073656, 29636.259093522833, 29651.258718532208, 29696.851515742284, 29735.553966690084, 142311.0, 142842.0, 142878.0, 143042.0, 143264.0, 28364.0, 29620.851895740383, 30255.848720756254, 30712.0, 30731.0, 35519.0, 36131.458028130124, 36194.45708314325, 36255.09362265859, 36316.0, 26700.732992669826, 27263.86368068147, 27407.725922741316, 28152.29619259535, 29535.113946581638, 26999.0, 27017.72982270152, 27402.81611543457, 28662.283442914093, 28945.421091577628, 30257.24356891007, 30799.692003079683, 30905.227369315948, 31169.220769480944, 31539.36921261608, 23924.64113038271, 24148.87925560361, 24640.876795615906, 24924.750752492244, 25051.74948250567, 21796.782032179475, 22359.66460503061, 22746.545069098855, 22757.772422275564, 22764.544709106056], "value": 14348.191406765205, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.34185303514363, 417.8621055051833, 420.87794539583524, 433.2353396255609, 439.5011661763897, 16910.23903924323, 17551.824481755193, 17552.64894702105, 17633.206505707243, 18098.27606895726, 18284.0, 18494.537636559093, 18542.536436589093, 18694.252229910788, 18793.24827006918, 5428.864278393033, 5474.479924407185, 5581.7209139543065, 5613.943860561383, 5663.490285874271, 5398.272552783111, 5505.256790333294, 5522.171674248854, 5534.4742249486235, 5537.390887002426, 5334.199870019509, 5422.701751403672, 5449.6730196188155, 5472.069748142825, 5517.917231241515, 5484.670919744808, 5499.532539734088, 5509.531689806371, 5516.310461192351, 5523.6409633373905, 4929.556339929423, 4969.080720066763, 5010.997800439926, 5011.047900898854, 5012.924806127911, 21291.467713307135, 21791.564168716537, 21895.138913192397, 22449.663255051186, 22576.75827829469, 1616.5877701186123, 1631.3556145322532, 1664.1429663723193, 1699.7535357373235, 1708.9743653845203, 14809.33357998882, 14945.551633451014, 15077.773833392508, 15138.924305378403, 15226.847731522654, 2051.2307884543297, 2068.7897579915766, 2115.6509175985943, 2143.699882016519, 2151.2363111095647, 82484.58757706173, 90772.0, 92724.0, 101567.0, 103105.48447257715, 10965.396903170242, 10975.560977560968, 11113.611023614134, 11217.15871309655, 11320.433978301053, 15250.771238431433, 15266.160361180242, 15294.0, 15319.387224510894, 15360.769588456182, 6718.832029199211, 7043.330883566053, 7065.364117229474, 7186.353228209487, 7215.458840586977, 6188.690565471708, 6227.595206311666, 6339.302676705559, 6379.872402551923, 6422.325655806073, 6887.621180835002, 6979.40675042627, 6983.755568555178, 7000.684969176399, 7063.682134303968, 2002.1958279269504, 2011.2055737983414, 2051.1590247998247, 2064.669652855536, 2200.7799220078186, 818.8935438392971, 838.7022606974558, 861.4960248254841, 867.9175478329548, 869.3523325122824, 16104.03375797456, 16786.580335491468, 17141.57146071358, 17163.485095446908, 17228.91385543064, 858.8754630578657, 863.2834747159842, 869.3566760597113, 873.8645509945968, 884.5090974509209, 8879.866801997976, 9309.906900930904, 9404.106609872051, 9422.623095076257, 9455.669051583161, 358044.0, 374026.0, 374946.0, 376366.0, 381952.0, 76938.0, 79522.20477795263, 80462.19537804546, 81608.59195703984, 81818.59090704628, 1045.7333379988054, 1072.9088027517591, 1118.9272697274814, 1121.8261169518737, 1122.685648018556, 16994.235259413603, 17403.912980435016, 17673.558161046076, 17727.468175954742, 17746.733798992766, 37986.0, 38361.42457863079, 38878.0, 39670.404943925285, 40041.0, 44103.33844992264, 45073.323900140866, 46079.3088103672, 46937.76531117323, 47058.0, 8109.10799812032, 8174.877376839471, 8175.877361839696, 8611.741647750578, 8781.56092195375, 11237.55049797999, 12181.573644922386, 12591.68520786951, 13161.73676526445, 13478.595642130751, 10944.39805810688, 11264.493097810455, 11272.887271127183, 11389.088872890314, 11698.76602467929, 9872.654457093968, 9949.850752238866, 10139.188864890939, 10196.3372380795, 10550.683479495627, 11507.136964727511, 11583.420828958688, 11694.29834209916, 11789.646310610695, 11821.82267266009, 8190.7133250335955, 8274.379421543288, 8382.832343352977, 8389.203025712548, 8592.054873963983, 11198.272112313, 11269.211155219056, 11271.436428178395, 11283.66149015531, 11570.710732231762], "value": 8843.601936593472, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1223.8164275358697, 1301.5119330251157, 1301.934903254837, 1305.060356543289, 1306.536179656222, 10066.547005384757, 10287.22845786567, 10505.0, 10509.054185123337, 10717.892821071806, 10504.947475262632, 10613.946930265358, 10630.840537391945, 10708.143348532118, 10724.463776811148, 2289.3132060381904, 2329.499157681098, 2330.4639932815376, 2346.4485845826216, 2357.905683772647, 2154.5475450155486, 2236.955260894781, 2237.9776202238013, 2252.1892118837204, 2252.662100684894, 2071.4924843413387, 2095.088636443152, 2108.768035516092, 2124.0441801189527, 2126.5109024924277, 2164.0, 2164.5021645021575, 2199.9890000549894, 2220.3449982255274, 2221.178164079293, 2098.5593025464673, 2166.7074944882397, 2178.2811672148155, 2260.79652831246, 2263.5472905418983, 10207.744806379826, 10222.335548189343, 10289.176865850788, 10294.53674584638, 10311.587536498606, 5315.096433606258, 5507.917381239285, 5517.806876759334, 5545.085060964936, 5562.7774889004395, 3334.2664613784927, 3518.577770667511, 3589.7128229741556, 3600.3519366514015, 3612.313660404515, 1038.735122543754, 1095.8137116690182, 1122.78105769375, 1140.2930183286333, 1144.2447984330302, 15219.162946038074, 15225.0, 15320.310586023656, 15359.846401535953, 15405.460808871749, 4683.274092515666, 4774.641901857305, 4904.901901962012, 5019.07147177766, 5067.087924173684, 10918.945405272923, 10971.177161712903, 10975.176861735401, 11011.889881101246, 11017.0, 5406.297181366397, 5458.972705136449, 5463.071277882769, 5467.343918729778, 5482.835514934558, 4923.384576927884, 5064.620153488503, 5066.645334826527, 5081.136206844845, 5120.92318615221, 3803.5435747710453, 3944.822482988215, 3992.900177495586, 4028.3957406389277, 4043.6562892154498, 1151.3782557419067, 1160.431388619587, 1175.5532897498895, 1176.3294921894437, 1187.5724739093919, 697.9232284448707, 699.2832346844424, 706.2090458686304, 709.4182770128446, 724.2178447276929, 5353.839384818461, 5399.946000540023, 5435.456454354533, 5522.420145884705, 5575.661841158093, 538.3351560822381, 539.4443722965274, 543.2204786131913, 545.4708932335628, 546.3007350591249, 3813.733038687321, 3818.6754125899056, 3868.0909986153233, 3927.430522574211, 3931.312020396419, 12819.487220511262, 12965.092443528862, 13243.271620060988, 13377.66555836112, 13385.263810490516, 12786.360681965865, 13037.869621303855, 13234.205947643171, 13328.133671311334, 13487.05590608648, 7370.410367170506, 7372.778816635509, 7488.812779680552, 7494.40044796415, 7497.250274972459, 5765.654060756368, 5875.20684707559, 5895.233619629421, 6035.6076855004285, 6047.606905551125, 11604.477798499256, 11906.583269585522, 12015.399230038638, 12058.457369418222, 12137.21108127969, 11971.162018658959, 12207.75584488323, 12288.569900053455, 12376.319302438453, 12444.81332779991, 7525.548467091992, 7685.38516918634, 7691.15397306307, 7693.346065584488, 7703.88444173349, 9272.211861991806, 9345.766355841159, 9406.81186376255, 9411.623535058794, 9423.952880235554, 7758.943879871951, 7906.209379062047, 7923.841523169389, 8062.5968701563515, 8189.754307370788, 7538.849223015399, 7551.131619863566, 7589.064788478902, 7624.085109786861, 7641.853721941531, 7456.478046536908, 7634.427417943787, 7637.427192960439, 7649.120351159465, 7653.923460765321, 5352.090144675492, 5355.70543620089, 5400.162974738922, 5601.747921343631, 5703.800366987136, 5263.6578622389425, 5339.119045357473, 5426.945730542802, 5429.53848922846, 5653.349864765604], "value": 4698.871458627723, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.0464107244383, 393.3391901605303, 396.6727449853871, 400.0279321249363, 400.0977795072112, 5335.626506144571, 5500.339959204896, 5530.4193059728705, 5531.308586426701, 5535.723213839312, 5315.627906046579, 5392.649477783942, 5406.648567843097, 5429.294191755076, 5440.619156659035, 4305.827766889329, 4318.417013703157, 4332.913341733163, 4332.913341733163, 4342.413774140482, 4279.465066866642, 4321.783910804463, 4330.285502892019, 4349.195398851207, 4349.478062632488, 4286.742795432268, 4299.849505267316, 4310.719803212781, 4313.762743049131, 4318.762468064255, 4273.205253793414, 4318.9784051079705, 4321.114171594815, 4324.481062272547, 4327.7186982846015, 3888.6121351001407, 3917.4319723640197, 3961.6632586230203, 3986.242613903349, 3986.382110772835, 5306.548943339821, 5306.734663266821, 5355.437679043722, 5382.2464854920345, 5405.945940540623, 5133.7122763553225, 5139.922901156486, 5145.434002259748, 5158.097332966716, 5161.5354618084175, 5704.11586204139, 5784.3926387729525, 5790.7973220937065, 5798.710064496759, 5830.883382332372, 4432.113577284524, 4443.688941774077, 4446.599806017474, 4457.487388950248, 4465.173942820588, 5879.206307148565, 6069.391611223029, 6080.331163572004, 6090.8781824363705, 6168.907466388007, 4319.092990472036, 4324.243257429937, 4332.501762297376, 4340.175366680321, 4344.1971581793205, 4381.956180438155, 4387.5393083726385, 4404.66964977628, 4406.801693923781, 4416.432166580882, 4882.218844984785, 4932.260160975882, 4957.3059771632, 4973.950260497421, 4983.875403114878, 5756.769729210785, 5776.364599894008, 5779.24869766936, 5795.623284486495, 5830.912536311958, 1599.8160211575585, 1629.372691513752, 1631.0, 1635.893666911647, 1644.5477493689332, 1149.1496292743477, 1170.4089434835353, 1171.5782318365552, 1186.0630102219322, 1203.205884116479, 4844.612431005511, 4882.0, 4898.730569818623, 4911.3369695090705, 4912.164931961575, 5879.676617785977, 5957.761689532457, 5975.55183361241, 5975.701214939236, 5982.670953097621, 4803.711777293303, 4833.154198015333, 4841.370621819141, 4859.17780832188, 4864.464908860023, 3099.3336432667083, 3133.2480204750696, 3138.419392412411, 3139.9215019624235, 3143.9214019649235, 5357.330333708286, 5396.244525766396, 5425.213344065089, 5457.290552228185, 5478.260434841325, 6038.0, 6073.331933487313, 6073.8437854561, 6088.878222435526, 6091.451769340781, 5464.590155738336, 5464.863378415572, 5465.863353416196, 5476.808311709071, 5479.589030822624, 5699.831534535493, 5859.970700146472, 5903.114532820111, 5909.0, 5926.288845338587, 5615.831525054255, 5816.76732930678, 5828.154917537018, 5841.903790990782, 5857.50211232033, 5454.154606036071, 5457.454254574511, 5474.288342515448, 5513.531349835149, 5518.964569486686, 4123.814428350672, 4125.0, 4156.210320039304, 4159.958400415957, 4166.41670166183, 5932.644041357532, 5977.282726072899, 6034.517238620988, 6042.788502402394, 6046.0, 5783.913241301299, 5787.594868359174, 5802.303723553201, 5808.5062769665055, 5839.912401314069, 5708.714564271853, 5780.421957804186, 5795.275590551181, 5808.332041815245, 5814.30228372581, 5695.914561281501, 5705.144228365612, 5719.056355701263, 5738.311402631711, 5768.394318596487, 5849.61977471463, 5864.914990726729, 5880.705964701833, 5888.4700376966275, 5905.40945905406, 5585.3297604287745, 5625.943740562542, 5674.4892959633835, 5676.971615141898, 5710.314762228559], "value": 4417.63592437541, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.2823632839813, 755.9773206803794, 757.3978686943879, 771.6141929035482, 782.4874707066872, 11737.765244695102, 12337.0, 13558.322083895815, 14276.143431394124, 14283.357248923798, 14321.78517322241, 14872.33074511647, 15016.0, 15158.317875695593, 15182.620434489143, 845.3152946113637, 866.1944391715733, 870.0516437083578, 870.5473153959937, 874.33113668044, 857.6012154348227, 861.027039445429, 861.6467248428146, 862.6204470033197, 863.0808189278398, 910.2217603948628, 911.1935936696005, 913.5158366065963, 914.6890057380489, 917.1699611851285, 902.2421166220406, 902.5351943748974, 902.6705252582825, 902.9638814447414, 904.7692838326218, 662.407145604686, 662.7382184037326, 662.8707402056601, 665.0987911380107, 665.4011389749217, 12414.937925310405, 12422.627321180378, 12942.22346659194, 14580.854191458056, 14742.262886855722, 14859.405623775036, 15065.849341506664, 15392.153431561259, 15412.152331621757, 15433.614159645986, 12122.0, 12289.877101229053, 12429.689257768538, 12447.626571202878, 12456.190347627466, 2926.8097573657856, 2931.8973835915854, 2931.985340073286, 2938.7942844000927, 2950.2771820904018, 63082.0, 63255.051174231965, 63543.6822815883, 64138.35861641371, 65108.0, 10615.203859710553, 10647.094996925349, 10715.0, 10828.675139745821, 10923.071538919123, 17676.469705908843, 17681.204345804214, 17694.0, 17695.823041769418, 17720.0, 6087.239095113111, 6104.0, 6356.4279214870885, 6363.236411630634, 6367.299597044322, 3027.197792584967, 3097.0399176255432, 3098.5042393216977, 3099.411111888734, 3105.192649910994, 3560.145565064366, 3632.4551317302617, 3632.9636703632627, 3938.4683067786054, 4069.595989383658, 779.0, 798.6685525506966, 809.3282575462352, 811.5455345006815, 812.975610731679, 559.6781850436015, 584.3367777572486, 585.4847733994058, 585.733491261475, 590.9172715819789, 9323.25413966881, 9579.629546351738, 9627.518624068769, 9632.807343853225, 10018.549165287579, 605.9575829691968, 610.9083637454329, 614.6772944204239, 622.2377587455331, 623.5915475363644, 4313.390398808739, 4406.823727050946, 4425.845095421645, 4439.4006809080365, 4550.0, 56253.43746562482, 57713.13430298549, 59307.70346148328, 63499.36500635027, 63770.0, 48576.0, 48669.0, 49539.0, 50489.74755126201, 50890.0, 46361.5363846364, 46365.53634463612, 46575.5342446578, 46670.0, 47475.525244747114, 9964.451955142536, 10158.898411015794, 10161.796764064826, 10413.635522756971, 10786.244962852525, 24962.875185623954, 25179.622305665063, 25300.873495632404, 25456.490870182864, 25578.744212557634, 39216.0, 40911.38632920568, 41571.0, 42648.14703705971, 43094.13811723811, 13900.096493727875, 14024.08843425215, 14140.78788818148, 14260.928695356457, 14306.0, 15747.921260394083, 16073.276702548179, 16082.195890205208, 16489.91755041217, 16567.50297491077, 13902.930485347508, 14414.42342306296, 14567.198804065878, 14623.415063397344, 14735.0, 14441.0, 14458.783118253445, 14551.85448145505, 16166.595835104217, 16311.26599303058, 14883.553493395215, 15047.623809404415, 15175.468858589897, 15567.221638917783, 15801.762973555637, 8362.247397734232, 8409.453385529921, 8658.610362533575, 9077.818443630958, 9547.486837469409, 10695.839562406414, 10760.838587421038, 11227.438628068727, 11359.772804543698, 11433.1996760226], "value": 6703.609087723611, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1558.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 115.0, 111.0, 111.0, 112.0, 113.0, 111.0, 110.0, 110.0, 113.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 123.0, 129.0, 187.0, 125.0, 125.0, 129.0, 125.0, 151.0, 125.0], "value": 136.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 167.0, 163.0, 168.0, 169.0, 176.0, 162.0, 163.0, 164.0], "value": 165.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 110.0, 77.0, 76.0, 75.0, 79.0, 104.0, 75.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 110.0, 83.0, 82.0, 84.0, 99.0, 83.0, 83.0, 102.0], "value": 89.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 115.0, 114.0, 115.0, 114.0, 116.0, 118.0, 115.0], "value": 114.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 153.0, 150.0, 151.0, 151.0, 151.0, 151.0, 152.0, 151.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 94.0, 94.0, 94.0, 94.0, 94.0, 99.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 56.0, 60.0, 59.0, 56.0, 56.0, 55.0, 58.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 56.0, 55.0, 56.0, 58.0, 56.0, 56.0, 57.0], "value": 56.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 83.0, 82.0, 90.0, 81.0, 83.0, 85.0, 82.0, 83.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 135.0, 142.0, 136.0, 137.0, 133.0, 141.0, 138.0, 219.0, 144.0], "value": 146.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 187.0, 194.0, 199.0, 196.0, 195.0, 199.0, 198.0, 200.0, 195.0], "value": 195.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 73.0, 82.0, 75.0, 78.0, 75.0, 73.0, 72.0, 77.0], "value": 75.5, "unit": "score"}]}]} 22:16:20 INFO - Return code: 0 22:16:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:16:20 INFO - # TBPL SUCCESS # 22:16:20 INFO - Running post-action listener: _resource_record_post_action 22:16:20 INFO - [mozharness: 2017-05-18 05:16:20.499844Z] Finished run-tests step (success) 22:16:20 INFO - Running post-run listener: _resource_record_post_run 22:16:20 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 421466112; Read time: 4; Write time: 526120 22:16:20 INFO - TinderboxPrint: CPU usage
13.4% 22:16:20 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 22:16:20 INFO - TinderboxPrint: I/O write bytes / time
421,466,112 / 526,120 22:16:20 INFO - TinderboxPrint: CPU idle
8,296.0 (86.6%) 22:16:20 INFO - TinderboxPrint: CPU user
1,220.0 (12.7%) 22:16:20 INFO - TinderboxPrint: Swap in / out
0 / 0 22:16:20 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 103055360; Read time: 0; Write time: 152760 22:16:20 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 318410752; Read time: 0; Write time: 373360 22:16:21 INFO - Running post-run listener: _upload_blobber_files 22:16:21 INFO - Blob upload gear active. 22:16:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:16:21 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 22:16:21 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'] 22:16:21 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 22:16:21 INFO - (blobuploader) - INFO - Open directory for files ... 22:16:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 22:16:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:16:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:16:22 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 22:16:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:16:22 INFO - (blobuploader) - INFO - Done attempting. 22:16:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:16:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:16:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:16:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:16:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:16:23 INFO - (blobuploader) - INFO - Done attempting. 22:16:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:16:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:16:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:16:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:16:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:16:24 INFO - (blobuploader) - INFO - Done attempting. 22:16:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:16:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:16:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:16:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:16:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:16:27 INFO - (blobuploader) - INFO - Done attempting. 22:16:27 INFO - (blobuploader) - INFO - Iteration through files over. 22:16:27 INFO - Return code: 0 22:16:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:16:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:16:27 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9c41a5d27b0ec61718909eb6286364d0903b4934047c184cae88dd2fc320a0b646ba0fcb6bda1201662cde547a0d5d6f091b71be0b40aebf9581bbfd2d270b3", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3393c2bd26d4ae01b44ddc2ea80d83566c16db6f4af9d409ff0c9f2ed0ba29cc86cd9b64eb0a5217e420ae949bcf72b770ea80ed514c06ed774ef19d7278c7e5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1dc079666b4792cbf2c896d6ee80fa1981b3daf91506a1d4ecf3d9668c49728ac523e9ab27c5a7aa42fa40ad5714a105d68c40cbd3cf7ec4b5f941d05f9a3dc7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0c84c2d9ba67aa78b98fc912d83fb9c651077cd4c8a03f3b46aed8b35abf5d5d46fd65c916856143012f8536ba239c6a83a4e876f07f579a0277785666add3d"} 22:16:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:16:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:16:27 INFO - Contents: 22:16:27 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9c41a5d27b0ec61718909eb6286364d0903b4934047c184cae88dd2fc320a0b646ba0fcb6bda1201662cde547a0d5d6f091b71be0b40aebf9581bbfd2d270b3", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3393c2bd26d4ae01b44ddc2ea80d83566c16db6f4af9d409ff0c9f2ed0ba29cc86cd9b64eb0a5217e420ae949bcf72b770ea80ed514c06ed774ef19d7278c7e5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1dc079666b4792cbf2c896d6ee80fa1981b3daf91506a1d4ecf3d9668c49728ac523e9ab27c5a7aa42fa40ad5714a105d68c40cbd3cf7ec4b5f941d05f9a3dc7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0c84c2d9ba67aa78b98fc912d83fb9c651077cd4c8a03f3b46aed8b35abf5d5d46fd65c916856143012f8536ba239c6a83a4e876f07f579a0277785666add3d"} 22:16:27 INFO - Running post-run listener: copy_logs_to_upload_dir 22:16:27 INFO - Copying logs to upload dir... 22:16:27 INFO - mkdir: /builds/slave/test/build/upload/logs 22:16:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.904183 ========= master_lag: -0.12 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-05-17 22:16:27.526772) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-17 22:16:27.534820) ========= 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=ba164b0a7b0ec7655860e956000001c1-1495076262.570638-979291685 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/e9c41a5d27b0ec61718909eb6286364d0903b4934047c184cae88dd2fc320a0b646ba0fcb6bda1201662cde547a0d5d6f091b71be0b40aebf9581bbfd2d270b3", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3393c2bd26d4ae01b44ddc2ea80d83566c16db6f4af9d409ff0c9f2ed0ba29cc86cd9b64eb0a5217e420ae949bcf72b770ea80ed514c06ed774ef19d7278c7e5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1dc079666b4792cbf2c896d6ee80fa1981b3daf91506a1d4ecf3d9668c49728ac523e9ab27c5a7aa42fa40ad5714a105d68c40cbd3cf7ec4b5f941d05f9a3dc7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0c84c2d9ba67aa78b98fc912d83fb9c651077cd4c8a03f3b46aed8b35abf5d5d46fd65c916856143012f8536ba239c6a83a4e876f07f579a0277785666add3d"} build_url:https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011233 build_url: 'https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9c41a5d27b0ec61718909eb6286364d0903b4934047c184cae88dd2fc320a0b646ba0fcb6bda1201662cde547a0d5d6f091b71be0b40aebf9581bbfd2d270b3", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3393c2bd26d4ae01b44ddc2ea80d83566c16db6f4af9d409ff0c9f2ed0ba29cc86cd9b64eb0a5217e420ae949bcf72b770ea80ed514c06ed774ef19d7278c7e5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1dc079666b4792cbf2c896d6ee80fa1981b3daf91506a1d4ecf3d9668c49728ac523e9ab27c5a7aa42fa40ad5714a105d68c40cbd3cf7ec4b5f941d05f9a3dc7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0c84c2d9ba67aa78b98fc912d83fb9c651077cd4c8a03f3b46aed8b35abf5d5d46fd65c916856143012f8536ba239c6a83a4e876f07f579a0277785666add3d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-17 22:16:27.561590) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 22:16:27.561883) ========= 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=ba164b0a7b0ec7655860e956000001c1-1495076262.570638-979291685 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004632 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 22:16:27.640721) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-17 22:16:27.641002) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-17 22:16:27.641285) ========= ========= Total master_lag: 0.03 =========