builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-071 starttime: 1495234581.8 results: success (0) revision: 8d60d0f825110cfb646ac31dc16dc011708bcf34 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-19 15:56:21.799671) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-19 15:56:21.805242) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-19 15:56:21.805526) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-19 15:56:21.846779) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 15:56:21.847048) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1495231765.859750-2097675444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-19 15:56:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.5M=0s 2017-05-19 15:56:23 (42.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.143560 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 15:56:22.002770) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 15:56:22.003039) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1495231765.859750-2097675444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014207 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 15:56:22.054913) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 15:56:22.055191) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8d60d0f825110cfb646ac31dc16dc011708bcf34 --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 8d60d0f825110cfb646ac31dc16dc011708bcf34 --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=dbb0bb31bf4a4c7db9ba1648000001b6-1495231765.859750-2097675444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-19 15:56:23,880 truncating revision to first 12 chars 2017-05-19 15:56:23,881 Setting DEBUG logging. 2017-05-19 15:56:23,881 attempt 1/10 2017-05-19 15:56:23,881 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8d60d0f82511?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-19 15:56:24,198 unpacking tar archive at: mozilla-central-8d60d0f82511/testing/mozharness/ program finished with exit code 0 elapsedTime=0.611518 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 15:56:22.685813) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-19 15:56:22.686117) ========= script_repo_revision: 8d60d0f825110cfb646ac31dc16dc011708bcf34 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-19 15:56:22.686529) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-19 15:56:22.686812) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-19 15:56:22.696550) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-05-19 15:56:22.696912) ========= /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=dbb0bb31bf4a4c7db9ba1648000001b6-1495231765.859750-2097675444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:56:24 INFO - MultiFileLogger online at 20170519 15:56:24 in /builds/slave/test 15:56:24 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 15:56:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:56:24 INFO - {'append_to_log': False, 15:56:24 INFO - 'base_work_dir': '/builds/slave/test', 15:56:24 INFO - 'blob_upload_branch': 'Firefox', 15:56:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:56:24 INFO - 'branch': 'Firefox', 15:56:24 INFO - 'buildbot_json_path': 'buildprops.json', 15:56:24 INFO - 'config_files': ('talos/linux_config.py',), 15:56:24 INFO - 'default_actions': ('clobber', 15:56:24 INFO - 'read-buildbot-config', 15:56:24 INFO - 'download-and-extract', 15:56:24 INFO - 'populate-webroot', 15:56:24 INFO - 'create-virtualenv', 15:56:24 INFO - 'install', 15:56:24 INFO - 'run-tests'), 15:56:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:56:24 INFO - 'download_minidump_stackwalk': True, 15:56:24 INFO - 'download_symbols': 'ondemand', 15:56:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:56:24 INFO - 'tooltool.py': '/tools/tooltool.py', 15:56:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:56:24 INFO - '/tools/misc-python/virtualenv.py')}, 15:56:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:56:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:56:24 INFO - 'gecko_profile': False, 15:56:24 INFO - 'gecko_profile_interval': 0, 15:56:24 INFO - 'installer_path': 'installer.exe', 15:56:24 INFO - 'log_level': 'info', 15:56:24 INFO - 'log_name': 'talos', 15:56:24 INFO - 'log_to_console': True, 15:56:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:56:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:56:24 INFO - 'opt_config_files': (), 15:56:24 INFO - 'pip_index': False, 15:56:24 INFO - 'suite': 'dromaeojs-e10s', 15:56:24 INFO - 'system_bits': '32', 15:56:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:56:24 INFO - 'title': 'talos-linux64-ix-071', 15:56:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:56:24 INFO - 'use_talos_json': True, 15:56:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:56:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:56:24 INFO - 'work_dir': 'build'} 15:56:24 INFO - [mozharness: 2017-05-19 22:56:24.618014Z] Running clobber step. 15:56:24 INFO - Running pre-action listener: _resource_record_pre_action 15:56:24 INFO - Running main action method: clobber 15:56:24 INFO - rmtree: /builds/slave/test/build 15:56:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:56:26 INFO - Running post-action listener: _resource_record_post_action 15:56:26 INFO - [mozharness: 2017-05-19 22:56:26.166672Z] Finished clobber step (success) 15:56:26 INFO - [mozharness: 2017-05-19 22:56:26.166771Z] Running read-buildbot-config step. 15:56:26 INFO - Running pre-action listener: _resource_record_pre_action 15:56:26 INFO - Running main action method: read_buildbot_config 15:56:26 INFO - Using buildbot properties: 15:56:26 INFO - { 15:56:26 INFO - "project": "", 15:56:26 INFO - "product": "firefox", 15:56:26 INFO - "who": "kwierso@gmail.com", 15:56:26 INFO - "installer_path": "public/build/target.tar.bz2", 15:56:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 15:56:26 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 15:56:26 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 15:56:26 INFO - "stage_platform": "linux64-stylosequential", 15:56:26 INFO - "basedir": "/builds/slave/test", 15:56:26 INFO - "buildnumber": 8, 15:56:26 INFO - "platform": "ubuntu64_hw_styloseq", 15:56:26 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:56:26 INFO - "slavebuilddir": "test", 15:56:26 INFO - "taskId": "FSSuGp2jSp-xxLzXy4numg", 15:56:26 INFO - "branch": "mozilla-central", 15:56:26 INFO - "script_repo_revision": "production", 15:56:26 INFO - "revision": "8d60d0f825110cfb646ac31dc16dc011708bcf34", 15:56:26 INFO - "slavename": "talos-linux64-ix-071", 15:56:26 INFO - "repo_path": "mozilla-central" 15:56:26 INFO - } 15:56:26 INFO - Finding installer, test and symbols from parent task. 15:56:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FSSuGp2jSp-xxLzXy4numg'}, attempt #1 15:56:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FSSuGp2jSp-xxLzXy4numg'}, attempt #1 15:56:27 INFO - Task dependencies: VxRF-SilS6eKtL-GPfrkug 15:56:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VxRF-SilS6eKtL-GPfrkug'}, attempt #1 15:56:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/VxRF-SilS6eKtL-GPfrkug/artifacts/public/build/target.tar.bz2 15:56:27 INFO - Set test_url: https://queue.taskcluster.net/v1/task/VxRF-SilS6eKtL-GPfrkug/artifacts/public/build/test_packages.json 15:56:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/VxRF-SilS6eKtL-GPfrkug/artifacts/public/build/target.crashreporter-symbols.zip 15:56:27 INFO - Running post-action listener: _resource_record_post_action 15:56:27 INFO - [mozharness: 2017-05-19 22:56:27.520827Z] Finished read-buildbot-config step (success) 15:56:27 INFO - [mozharness: 2017-05-19 22:56:27.521047Z] Running download-and-extract step. 15:56:27 INFO - Running pre-action listener: _resource_record_pre_action 15:56:27 INFO - Running main action method: download_and_extract 15:56:27 INFO - mkdir: /builds/slave/test/build/tests 15:56:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:27 INFO - trying https://queue.taskcluster.net/v1/task/VxRF-SilS6eKtL-GPfrkug/artifacts/public/build/target.test_packages.json 15:56:27 INFO - Downloading https://queue.taskcluster.net/v1/task/VxRF-SilS6eKtL-GPfrkug/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:56:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VxRF-SilS6eKtL-GPfrkug/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:56:28 INFO - Downloaded 986 bytes. 15:56:28 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:56:28 INFO - Using the following test package requirements: 15:56:28 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:56:28 INFO - u'common': [u'target.common.tests.zip'], 15:56:28 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:56:28 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:56:28 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:56:28 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:56:28 INFO - u'mozbase': [u'target.common.tests.zip'], 15:56:28 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:56:28 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:56:28 INFO - u'web-platform': [u'target.common.tests.zip', 15:56:28 INFO - u'target.web-platform.tests.zip'], 15:56:28 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:56:28 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:56:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VxRF-SilS6eKtL-GPfrkug/artifacts/public/build/target.common.tests.zip 15:56:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VxRF-SilS6eKtL-GPfrkug/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:56:28 INFO - Fetch https://queue.taskcluster.net/v1/task/VxRF-SilS6eKtL-GPfrkug/artifacts/public/build/target.common.tests.zip into memory 15:56:29 INFO - Content-Length response header: 63520766 15:56:29 INFO - Bytes received: 63520766 15:56:40 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:56:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VxRF-SilS6eKtL-GPfrkug/artifacts/public/build/target.common.tests.zip 15:56:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VxRF-SilS6eKtL-GPfrkug/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:56:40 INFO - Fetch https://queue.taskcluster.net/v1/task/VxRF-SilS6eKtL-GPfrkug/artifacts/public/build/target.common.tests.zip into memory 15:56:41 INFO - Content-Length response header: 63520766 15:56:41 INFO - Bytes received: 63520766 15:56:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VxRF-SilS6eKtL-GPfrkug/artifacts/public/build/target.talos.tests.zip 15:56:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VxRF-SilS6eKtL-GPfrkug/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:56:53 INFO - Fetch https://queue.taskcluster.net/v1/task/VxRF-SilS6eKtL-GPfrkug/artifacts/public/build/target.talos.tests.zip into memory 15:56:53 INFO - Content-Length response header: 14410000 15:56:53 INFO - Bytes received: 14410000 15:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:54 INFO - trying https://queue.taskcluster.net/v1/task/VxRF-SilS6eKtL-GPfrkug/artifacts/public/build/target.tar.bz2 15:56:54 INFO - Downloading https://queue.taskcluster.net/v1/task/VxRF-SilS6eKtL-GPfrkug/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:56:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VxRF-SilS6eKtL-GPfrkug/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:56:55 INFO - Downloaded 56456713 bytes. 15:56:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VxRF-SilS6eKtL-GPfrkug/artifacts/public/build/target.tar.bz2 15:56:55 INFO - mkdir: /builds/slave/test/properties 15:56:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:56:55 INFO - Writing to file /builds/slave/test/properties/build_url 15:56:55 INFO - Contents: 15:56:55 INFO - build_url:https://queue.taskcluster.net/v1/task/VxRF-SilS6eKtL-GPfrkug/artifacts/public/build/target.tar.bz2 15:56:55 INFO - Running post-action listener: _resource_record_post_action 15:56:55 INFO - Running post-action listener: set_extra_try_arguments 15:56:55 INFO - [mozharness: 2017-05-19 22:56:55.203286Z] Finished download-and-extract step (success) 15:56:55 INFO - [mozharness: 2017-05-19 22:56:55.203383Z] Running populate-webroot step. 15:56:55 INFO - Running pre-action listener: _resource_record_pre_action 15:56:55 INFO - Running main action method: populate_webroot 15:56:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:56:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:56:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:56:55 INFO - '--tppagecycles', 15:56:55 INFO - '7'], 15:56:55 INFO - 'tests': ['tsvgm']}}, 15:56:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:56:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:56:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:56:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:56:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:56:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:56:55 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:56:55 INFO - 'talos_options': ['--disable-e10s'], 15:56:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:56:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:56:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:56:55 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:56:55 INFO - 'talos_options': ['--disable-e10s'], 15:56:55 INFO - 'tests': ['damp', 'tps']}, 15:56:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:56:55 INFO - 'tests': ['damp', 'tps']}, 15:56:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:56:55 INFO - 'tests': ['dromaeo_dom']}, 15:56:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:56:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:56:55 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 15:56:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:56:55 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:56:55 INFO - 'tests': ['ts_paint', 'tp5o']}, 15:56:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:56:55 INFO - 'tests': ['a11yr', 15:56:55 INFO - 'ts_paint', 15:56:55 INFO - 'tpaint', 15:56:55 INFO - 'sessionrestore', 15:56:55 INFO - 'sessionrestore_no_auto_restore', 15:56:55 INFO - 'tabpaint']}, 15:56:55 INFO - 'other-e10s': {'tests': ['a11yr', 15:56:55 INFO - 'ts_paint', 15:56:55 INFO - 'tpaint', 15:56:55 INFO - 'sessionrestore', 15:56:55 INFO - 'sessionrestore_no_auto_restore', 15:56:55 INFO - 'tabpaint']}, 15:56:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:56:55 INFO - 'ts_paint', 15:56:55 INFO - 'tpaint', 15:56:55 INFO - 'sessionrestore', 15:56:55 INFO - 'sessionrestore_no_auto_restore', 15:56:55 INFO - 'tabpaint']}, 15:56:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:56:55 INFO - 'ts_paint', 15:56:55 INFO - 'tpaint', 15:56:55 INFO - 'sessionrestore', 15:56:55 INFO - 'sessionrestore_no_auto_restore', 15:56:55 INFO - 'tabpaint']}, 15:56:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:56:55 INFO - 'tests': ['a11yr', 15:56:55 INFO - 'ts_paint', 15:56:55 INFO - 'tpaint', 15:56:55 INFO - 'sessionrestore', 15:56:55 INFO - 'sessionrestore_no_auto_restore', 15:56:55 INFO - 'tabpaint']}, 15:56:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:56:55 INFO - 'tests': ['a11yr', 15:56:55 INFO - 'ts_paint', 15:56:55 INFO - 'tpaint', 15:56:55 INFO - 'sessionrestore', 15:56:55 INFO - 'sessionrestore_no_auto_restore', 15:56:55 INFO - 'tabpaint']}, 15:56:55 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 15:56:55 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 15:56:55 INFO - 'bloom_basic_ref']}, 15:56:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:56:55 INFO - 'tests': ['tsvgx', 15:56:55 INFO - 'tsvgr_opacity', 15:56:55 INFO - 'tart', 15:56:55 INFO - 'tscrollx', 15:56:55 INFO - 'cart', 15:56:55 INFO - 'tsvg_static']}, 15:56:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:56:55 INFO - 'tsvgr_opacity', 15:56:55 INFO - 'tart', 15:56:55 INFO - 'tscrollx', 15:56:55 INFO - 'cart', 15:56:55 INFO - 'tsvg_static']}, 15:56:55 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:56:55 INFO - 'talos_options': ['--disable-e10s'], 15:56:55 INFO - 'tests': ['tp5o']}, 15:56:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:56:55 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:56:55 INFO - 'talos_options': ['--disable-e10s', 15:56:55 INFO - '--xperf_path', 15:56:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:56:55 INFO - 'tests': ['tp5n']}, 15:56:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:56:55 INFO - 'talos_options': ['--xperf_path', 15:56:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:56:55 INFO - 'tests': ['tp5n']}}, 15:56:55 INFO - 'talos.zip': {'path': '', 15:56:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:56:55 INFO - Running post-action listener: _resource_record_post_action 15:56:55 INFO - [mozharness: 2017-05-19 22:56:55.217368Z] Finished populate-webroot step (success) 15:56:55 INFO - [mozharness: 2017-05-19 22:56:55.217461Z] Running create-virtualenv step. 15:56:55 INFO - Running pre-action listener: _resource_record_pre_action 15:56:55 INFO - Running main action method: create_virtualenv 15:56:55 INFO - Creating virtualenv /builds/slave/test/build/venv 15:56:55 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 15:56:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:56:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:56:55 INFO - Using real prefix '/usr' 15:56:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:56:55 INFO - Installing distribute.............................................................................................................................................................................................done. 15:56:57 INFO - Installing pip.................done. 15:56:57 INFO - Return code: 0 15:56:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:56:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:56:57 INFO - Reading from file tmpfile_stdout 15:56:57 INFO - Output received: 15:56:57 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) 15:56:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:57 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 0x26411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b45c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b17a0>, '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 0x29b26a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b2b30>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495231765.859750-2097675444', '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 15:56:57 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 15:56:57 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 15:56:57 INFO - Using env: {'DISPLAY': ':0', 15:56:57 INFO - 'HOME': '/home/cltbld', 15:56:57 INFO - 'LANG': 'en_US.UTF-8', 15:56:57 INFO - 'LANGUAGE': 'en_US:en', 15:56:57 INFO - 'LOGNAME': 'cltbld', 15:56:57 INFO - 'MAIL': '/var/mail/cltbld', 15:56:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:57 INFO - 'MOZ_NO_REMOTE': '1', 15:56:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:57 INFO - 'NO_EM_RESTART': '1', 15:56:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:57 INFO - 'PWD': '/builds/slave/test', 15:56:58 INFO - 'SHELL': '/bin/bash', 15:56:58 INFO - 'SHLVL': '1', 15:56:58 INFO - 'TERM': 'linux', 15:56:58 INFO - 'TMOUT': '86400', 15:56:58 INFO - 'USER': 'cltbld', 15:56:58 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495231765.859750-2097675444', 15:56:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:58 INFO - '_': '/tools/buildbot/bin/python'} 15:56:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:58 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 15:56:58 INFO - Cleaning up... 15:56:58 INFO - Return code: 0 15:56:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:56:58 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')]} 15:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:58 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')]} 15:56:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:58 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 0x26411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b45c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b17a0>, '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 0x29b26a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b2b30>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495231765.859750-2097675444', '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 15:56:58 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 15:56:58 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 15:56:58 INFO - Using env: {'DISPLAY': ':0', 15:56:58 INFO - 'HOME': '/home/cltbld', 15:56:58 INFO - 'LANG': 'en_US.UTF-8', 15:56:58 INFO - 'LANGUAGE': 'en_US:en', 15:56:58 INFO - 'LOGNAME': 'cltbld', 15:56:58 INFO - 'MAIL': '/var/mail/cltbld', 15:56:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:58 INFO - 'MOZ_NO_REMOTE': '1', 15:56:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:58 INFO - 'NO_EM_RESTART': '1', 15:56:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:58 INFO - 'PWD': '/builds/slave/test', 15:56:58 INFO - 'SHELL': '/bin/bash', 15:56:58 INFO - 'SHLVL': '1', 15:56:58 INFO - 'TERM': 'linux', 15:56:58 INFO - 'TMOUT': '86400', 15:56:58 INFO - 'USER': 'cltbld', 15:56:58 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495231765.859750-2097675444', 15:56:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:58 INFO - '_': '/tools/buildbot/bin/python'} 15:56:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:58 INFO - Downloading/unpacking psutil>=3.1.1 15:56:58 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 15:56:58 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 15:56:58 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 15:56:58 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 15:56:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:56:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:56:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:56:59 INFO - Installing collected packages: psutil 15:56:59 INFO - Running setup.py install for psutil 15:56:59 INFO - building 'psutil._psutil_linux' extension 15:56:59 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 15:56:59 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 15:56:59 INFO - building 'psutil._psutil_posix' extension 15:56:59 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 15:57:00 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 15:57:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:57:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:57:00 INFO - Successfully installed psutil 15:57:00 INFO - Cleaning up... 15:57:00 INFO - Return code: 0 15:57:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:57: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')]} 15:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:57: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')]} 15:57:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:57:00 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 0x26411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b45c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b17a0>, '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 0x29b26a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b2b30>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495231765.859750-2097675444', '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 15:57:00 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 15:57:00 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 15:57:00 INFO - Using env: {'DISPLAY': ':0', 15:57:00 INFO - 'HOME': '/home/cltbld', 15:57:00 INFO - 'LANG': 'en_US.UTF-8', 15:57:00 INFO - 'LANGUAGE': 'en_US:en', 15:57:00 INFO - 'LOGNAME': 'cltbld', 15:57:00 INFO - 'MAIL': '/var/mail/cltbld', 15:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:00 INFO - 'MOZ_NO_REMOTE': '1', 15:57:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:57:00 INFO - 'NO_EM_RESTART': '1', 15:57:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:00 INFO - 'PWD': '/builds/slave/test', 15:57:00 INFO - 'SHELL': '/bin/bash', 15:57:00 INFO - 'SHLVL': '1', 15:57:00 INFO - 'TERM': 'linux', 15:57:00 INFO - 'TMOUT': '86400', 15:57:00 INFO - 'USER': 'cltbld', 15:57:00 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495231765.859750-2097675444', 15:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:00 INFO - '_': '/tools/buildbot/bin/python'} 15:57:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:57:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:57:00 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 15:57:00 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 15:57:00 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 15:57:00 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 15:57:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:57:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:57:01 INFO - Installing collected packages: mozsystemmonitor 15:57:01 INFO - Running setup.py install for mozsystemmonitor 15:57:01 INFO - Successfully installed mozsystemmonitor 15:57:01 INFO - Cleaning up... 15:57:01 INFO - Return code: 0 15:57:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:57:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:57:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b45c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b17a0>, '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 0x29b26a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b2b30>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495231765.859750-2097675444', '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 15:57:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:57:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:57:01 INFO - Using env: {'DISPLAY': ':0', 15:57:01 INFO - 'HOME': '/home/cltbld', 15:57:01 INFO - 'LANG': 'en_US.UTF-8', 15:57:01 INFO - 'LANGUAGE': 'en_US:en', 15:57:01 INFO - 'LOGNAME': 'cltbld', 15:57:01 INFO - 'MAIL': '/var/mail/cltbld', 15:57:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:01 INFO - 'MOZ_NO_REMOTE': '1', 15:57:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:57:01 INFO - 'NO_EM_RESTART': '1', 15:57:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:57:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:01 INFO - 'PWD': '/builds/slave/test', 15:57:01 INFO - 'SHELL': '/bin/bash', 15:57:01 INFO - 'SHLVL': '1', 15:57:01 INFO - 'TERM': 'linux', 15:57:01 INFO - 'TMOUT': '86400', 15:57:01 INFO - 'USER': 'cltbld', 15:57:01 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495231765.859750-2097675444', 15:57:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:01 INFO - '_': '/tools/buildbot/bin/python'} 15:57:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:57:01 INFO - Downloading/unpacking jsonschema==2.5.1 15:57:01 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 15:57:01 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 15:57:01 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 15:57:01 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 15:57:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:57:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:57:02 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 15:57:02 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 15:57:02 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 15:57:02 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 15:57:03 INFO - Downloading functools32-3.2.3-2.tar.gz 15:57:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:57:03 INFO - warning: no files found matching '*.txt' 15:57:03 INFO - no previously-included directories found matching 'build' 15:57:03 INFO - no previously-included directories found matching 'dist' 15:57:03 INFO - no previously-included directories found matching '.git*' 15:57:03 INFO - Installing collected packages: jsonschema, functools32 15:57:03 INFO - Running setup.py install for functools32 15:57:03 INFO - warning: no files found matching '*.txt' 15:57:03 INFO - no previously-included directories found matching 'build' 15:57:03 INFO - no previously-included directories found matching 'dist' 15:57:03 INFO - no previously-included directories found matching '.git*' 15:57:03 INFO - Successfully installed jsonschema functools32 15:57:03 INFO - Cleaning up... 15:57:03 INFO - Return code: 0 15:57:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:57:03 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')]} 15:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:57:03 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')]} 15:57:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:57:03 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 0x26411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b45c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b17a0>, '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 0x29b26a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b2b30>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495231765.859750-2097675444', '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 15:57:03 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 15:57:03 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 15:57:03 INFO - Using env: {'DISPLAY': ':0', 15:57:03 INFO - 'HOME': '/home/cltbld', 15:57:03 INFO - 'LANG': 'en_US.UTF-8', 15:57:03 INFO - 'LANGUAGE': 'en_US:en', 15:57:03 INFO - 'LOGNAME': 'cltbld', 15:57:03 INFO - 'MAIL': '/var/mail/cltbld', 15:57:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:03 INFO - 'MOZ_NO_REMOTE': '1', 15:57:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:57:03 INFO - 'NO_EM_RESTART': '1', 15:57:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:57:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:03 INFO - 'PWD': '/builds/slave/test', 15:57:03 INFO - 'SHELL': '/bin/bash', 15:57:03 INFO - 'SHLVL': '1', 15:57:03 INFO - 'TERM': 'linux', 15:57:03 INFO - 'TMOUT': '86400', 15:57:03 INFO - 'USER': 'cltbld', 15:57:03 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495231765.859750-2097675444', 15:57:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:03 INFO - '_': '/tools/buildbot/bin/python'} 15:57:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:57:03 INFO - Cleaning up... 15:57:03 INFO - Return code: 0 15:57:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:57:03 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')]} 15:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:57:03 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')]} 15:57:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:57:03 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 0x26411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b45c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b17a0>, '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 0x29b26a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b2b30>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495231765.859750-2097675444', '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 15:57:03 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 15:57:03 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 15:57:03 INFO - Using env: {'DISPLAY': ':0', 15:57:03 INFO - 'HOME': '/home/cltbld', 15:57:03 INFO - 'LANG': 'en_US.UTF-8', 15:57:03 INFO - 'LANGUAGE': 'en_US:en', 15:57:03 INFO - 'LOGNAME': 'cltbld', 15:57:03 INFO - 'MAIL': '/var/mail/cltbld', 15:57:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:03 INFO - 'MOZ_NO_REMOTE': '1', 15:57:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:57:03 INFO - 'NO_EM_RESTART': '1', 15:57:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:57:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:03 INFO - 'PWD': '/builds/slave/test', 15:57:03 INFO - 'SHELL': '/bin/bash', 15:57:03 INFO - 'SHLVL': '1', 15:57:03 INFO - 'TERM': 'linux', 15:57:03 INFO - 'TMOUT': '86400', 15:57:03 INFO - 'USER': 'cltbld', 15:57:03 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495231765.859750-2097675444', 15:57:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:03 INFO - '_': '/tools/buildbot/bin/python'} 15:57:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:57:03 INFO - Downloading/unpacking blobuploader==1.2.4 15:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:57:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:57:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:57:04 INFO - Downloading blobuploader-1.2.4.tar.gz 15:57:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:57:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:57:04 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 15:57:04 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 15:57:04 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 15:57:04 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 15:57:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:57:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:57: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 15:57: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 15:57: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 15:57: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 15:57:05 INFO - Downloading docopt-0.6.1.tar.gz 15:57:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:57:05 INFO - Installing collected packages: blobuploader, requests, docopt 15:57:05 INFO - Running setup.py install for blobuploader 15:57:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:57:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:57:05 INFO - Running setup.py install for requests 15:57:05 INFO - Running setup.py install for docopt 15:57:06 INFO - Successfully installed blobuploader requests docopt 15:57:06 INFO - Cleaning up... 15:57:06 INFO - Return code: 0 15:57:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:57: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')]} 15:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:57: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')]} 15:57:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:57:06 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 0x26411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b45c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b17a0>, '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 0x29b26a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b2b30>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495231765.859750-2097675444', '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 15:57:06 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 15:57:06 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 15:57:06 INFO - Using env: {'DISPLAY': ':0', 15:57:06 INFO - 'HOME': '/home/cltbld', 15:57:06 INFO - 'LANG': 'en_US.UTF-8', 15:57:06 INFO - 'LANGUAGE': 'en_US:en', 15:57:06 INFO - 'LOGNAME': 'cltbld', 15:57:06 INFO - 'MAIL': '/var/mail/cltbld', 15:57:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:06 INFO - 'MOZ_NO_REMOTE': '1', 15:57:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:57:06 INFO - 'NO_EM_RESTART': '1', 15:57:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:57:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:06 INFO - 'PWD': '/builds/slave/test', 15:57:06 INFO - 'SHELL': '/bin/bash', 15:57:06 INFO - 'SHLVL': '1', 15:57:06 INFO - 'TERM': 'linux', 15:57:06 INFO - 'TMOUT': '86400', 15:57:06 INFO - 'USER': 'cltbld', 15:57:06 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495231765.859750-2097675444', 15:57:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:06 INFO - '_': '/tools/buildbot/bin/python'} 15:57:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:57:06 INFO - Running setup.py (path:/tmp/pip-jzmI38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:57:06 INFO - Running setup.py (path:/tmp/pip-Wl_PyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:57:06 INFO - Running setup.py (path:/tmp/pip-vXrD41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:57:06 INFO - Running setup.py (path:/tmp/pip-t2lWWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:57:06 INFO - Running setup.py (path:/tmp/pip-Y8UBSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:57:06 INFO - Running setup.py (path:/tmp/pip-ps1bFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:57:06 INFO - Running setup.py (path:/tmp/pip-8cO82d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:57:06 INFO - Running setup.py (path:/tmp/pip-ejjwQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:57:06 INFO - Running setup.py (path:/tmp/pip-9N_7D3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:57:06 INFO - Running setup.py (path:/tmp/pip-QWOuAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:57:07 INFO - Running setup.py (path:/tmp/pip-cwi2CK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:57:07 INFO - Running setup.py (path:/tmp/pip-7R8Glm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:57:07 INFO - Running setup.py (path:/tmp/pip-Wa5FMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:57:07 INFO - Running setup.py (path:/tmp/pip-se757V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:57:07 INFO - Running setup.py (path:/tmp/pip-ftGK8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:57:07 INFO - Running setup.py (path:/tmp/pip-bwdFUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:57:07 INFO - Running setup.py (path:/tmp/pip-Vi2pUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:57:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:57:07 INFO - Running setup.py install for manifestparser 15:57:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:57:07 INFO - Running setup.py install for mozcrash 15:57:07 INFO - Running setup.py install for mozdebug 15:57:07 INFO - Running setup.py install for mozdevice 15:57:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:57:07 INFO - Running setup.py install for mozfile 15:57:08 INFO - Running setup.py install for mozhttpd 15:57:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:57:08 INFO - Running setup.py install for mozinfo 15:57:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:57:08 INFO - Running setup.py install for mozInstall 15:57:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:57:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:57:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:57:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:57:08 INFO - Running setup.py install for mozleak 15:57:08 INFO - Running setup.py install for mozlog 15:57:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:57:08 INFO - Running setup.py install for moznetwork 15:57:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:57:08 INFO - Running setup.py install for mozprocess 15:57:08 INFO - Running setup.py install for mozprofile 15:57:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:57:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:57:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:57:08 INFO - Running setup.py install for mozrunner 15:57:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:57:08 INFO - Running setup.py install for mozscreenshot 15:57:09 INFO - Running setup.py install for moztest 15:57:09 INFO - Running setup.py install for mozversion 15:57:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:57:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:57:09 INFO - Cleaning up... 15:57:09 INFO - Return code: 0 15:57:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:57:09 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')]} 15:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:57:09 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')]} 15:57:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:57:09 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 0x26411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b45c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b17a0>, '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 0x29b26a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b2b30>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495231765.859750-2097675444', '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 15:57:09 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 15:57:09 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 15:57:09 INFO - Using env: {'DISPLAY': ':0', 15:57:09 INFO - 'HOME': '/home/cltbld', 15:57:09 INFO - 'LANG': 'en_US.UTF-8', 15:57:09 INFO - 'LANGUAGE': 'en_US:en', 15:57:09 INFO - 'LOGNAME': 'cltbld', 15:57:09 INFO - 'MAIL': '/var/mail/cltbld', 15:57:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:09 INFO - 'MOZ_NO_REMOTE': '1', 15:57:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:57:09 INFO - 'NO_EM_RESTART': '1', 15:57:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:57:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:09 INFO - 'PWD': '/builds/slave/test', 15:57:09 INFO - 'SHELL': '/bin/bash', 15:57:09 INFO - 'SHLVL': '1', 15:57:09 INFO - 'TERM': 'linux', 15:57:09 INFO - 'TMOUT': '86400', 15:57:09 INFO - 'USER': 'cltbld', 15:57:09 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495231765.859750-2097675444', 15:57:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:09 INFO - '_': '/tools/buildbot/bin/python'} 15:57:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:57:09 INFO - Running setup.py (path:/tmp/pip-hwG7tD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:57:09 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)) 15:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:57:09 INFO - Running setup.py (path:/tmp/pip-eUIMBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:57:09 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)) 15:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:57:09 INFO - Running setup.py (path:/tmp/pip-t73DoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:57:09 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)) 15:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:57:09 INFO - Running setup.py (path:/tmp/pip-f1yEx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:57:09 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)) 15:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:57:09 INFO - Running setup.py (path:/tmp/pip-TuxuRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:57:09 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)) 15:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:57:09 INFO - Running setup.py (path:/tmp/pip-55tWrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:57:09 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)) 15:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:57:09 INFO - Running setup.py (path:/tmp/pip-2AW3yN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:57:10 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)) 15:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:57:10 INFO - Running setup.py (path:/tmp/pip-C8rQKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:57:10 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)) 15:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:57:10 INFO - Running setup.py (path:/tmp/pip-SA6lRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:57:10 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)) 15:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:57:10 INFO - Running setup.py (path:/tmp/pip-Y9H3hH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:57:10 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)) 15:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:57:10 INFO - Running setup.py (path:/tmp/pip-t1bgdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:57:10 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)) 15:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:57:10 INFO - Running setup.py (path:/tmp/pip-vcblyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:57:10 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)) 15:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:57:10 INFO - Running setup.py (path:/tmp/pip-vAxV62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:57:10 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)) 15:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:57:10 INFO - Running setup.py (path:/tmp/pip-4XNm0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:57:10 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)) 15:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:57:10 INFO - Running setup.py (path:/tmp/pip-BAHEQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:57:10 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)) 15:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:57:10 INFO - Running setup.py (path:/tmp/pip-tEM6Vd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:57:10 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)) 15:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:57:10 INFO - Running setup.py (path:/tmp/pip-4VJnFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:57:10 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)) 15:57:10 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)) 15:57:10 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)) 15:57:10 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)) 15:57:10 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)) 15:57:10 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)) 15:57:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:57: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 15:57: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 15:57: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 15:57: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 15:57:11 INFO - Downloading blessings-1.6.tar.gz 15:57:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:57:11 INFO - Installing collected packages: blessings 15:57:11 INFO - Running setup.py install for blessings 15:57:11 INFO - Successfully installed blessings 15:57:11 INFO - Cleaning up... 15:57:12 INFO - Return code: 0 15:57:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:57:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:57:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:57:12 INFO - Reading from file tmpfile_stdout 15:57:12 INFO - Current package versions: 15:57:12 INFO - argparse == 1.2.1 15:57:12 INFO - blessings == 1.6 15:57:12 INFO - blobuploader == 1.2.4 15:57:12 INFO - docopt == 0.6.1 15:57:12 INFO - functools32 == 3.2.3-2 15:57:12 INFO - jsonschema == 2.5.1 15:57:12 INFO - manifestparser == 1.1 15:57:12 INFO - mozInstall == 1.12 15:57:12 INFO - mozcrash == 1.0 15:57:12 INFO - mozdebug == 0.1 15:57:12 INFO - mozdevice == 0.50 15:57:12 INFO - mozfile == 1.2 15:57:12 INFO - mozhttpd == 0.7 15:57:12 INFO - mozinfo == 0.9 15:57:12 INFO - mozleak == 0.1 15:57:12 INFO - mozlog == 3.4 15:57:12 INFO - moznetwork == 0.27 15:57:12 INFO - mozprocess == 0.25 15:57:12 INFO - mozprofile == 0.28 15:57:12 INFO - mozrunner == 6.13 15:57:12 INFO - mozscreenshot == 0.1 15:57:12 INFO - mozsystemmonitor == 0.3 15:57:12 INFO - moztest == 0.8 15:57:12 INFO - mozversion == 1.4 15:57:12 INFO - psutil == 3.1.1 15:57:12 INFO - requests == 1.2.3 15:57:12 INFO - wsgiref == 0.1.2 15:57:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:57: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')]} 15:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:57: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')]} 15:57:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:57:12 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 0x26411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b45c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b17a0>, '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 0x29b26a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b2b30>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495231765.859750-2097675444', '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 15:57:12 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 15:57:12 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 15:57:12 INFO - Using env: {'DISPLAY': ':0', 15:57:12 INFO - 'HOME': '/home/cltbld', 15:57:12 INFO - 'LANG': 'en_US.UTF-8', 15:57:12 INFO - 'LANGUAGE': 'en_US:en', 15:57:12 INFO - 'LOGNAME': 'cltbld', 15:57:12 INFO - 'MAIL': '/var/mail/cltbld', 15:57:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:12 INFO - 'MOZ_NO_REMOTE': '1', 15:57:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:57:12 INFO - 'NO_EM_RESTART': '1', 15:57:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:57:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:12 INFO - 'PWD': '/builds/slave/test', 15:57:12 INFO - 'SHELL': '/bin/bash', 15:57:12 INFO - 'SHLVL': '1', 15:57:12 INFO - 'TERM': 'linux', 15:57:12 INFO - 'TMOUT': '86400', 15:57:12 INFO - 'USER': 'cltbld', 15:57:12 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495231765.859750-2097675444', 15:57:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:12 INFO - '_': '/tools/buildbot/bin/python'} 15:57:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:57:12 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)) 15:57:12 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)) 15:57:12 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)) 15:57:12 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)) 15:57:12 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)) 15:57:12 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)) 15:57:12 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)) 15:57:12 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)) 15:57:12 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)) 15:57:12 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)) 15:57:12 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)) 15:57:12 INFO - Cleaning up... 15:57:12 INFO - Return code: 0 15:57:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:57: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')]} 15:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:57: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')]} 15:57:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:57:12 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 0x26411f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b45c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b17a0>, '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 0x29b26a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b2b30>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495231765.859750-2097675444', '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 15:57:12 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 15:57:12 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 15:57:12 INFO - Using env: {'DISPLAY': ':0', 15:57:12 INFO - 'HOME': '/home/cltbld', 15:57:12 INFO - 'LANG': 'en_US.UTF-8', 15:57:12 INFO - 'LANGUAGE': 'en_US:en', 15:57:12 INFO - 'LOGNAME': 'cltbld', 15:57:12 INFO - 'MAIL': '/var/mail/cltbld', 15:57:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:12 INFO - 'MOZ_NO_REMOTE': '1', 15:57:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:57:12 INFO - 'NO_EM_RESTART': '1', 15:57:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:57:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:12 INFO - 'PWD': '/builds/slave/test', 15:57:12 INFO - 'SHELL': '/bin/bash', 15:57:12 INFO - 'SHLVL': '1', 15:57:12 INFO - 'TERM': 'linux', 15:57:12 INFO - 'TMOUT': '86400', 15:57:12 INFO - 'USER': 'cltbld', 15:57:12 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495231765.859750-2097675444', 15:57:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:12 INFO - '_': '/tools/buildbot/bin/python'} 15:57:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:57:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:57:12 INFO - Cleaning up... 15:57:12 INFO - Return code: 0 15:57:12 INFO - Running post-action listener: _resource_record_post_action 15:57:12 INFO - Running post-action listener: _start_resource_monitoring 15:57:12 INFO - Starting resource monitoring. 15:57:12 INFO - [mozharness: 2017-05-19 22:57:12.762012Z] Finished create-virtualenv step (success) 15:57:12 INFO - [mozharness: 2017-05-19 22:57:12.762529Z] Running install step. 15:57:12 INFO - Running pre-action listener: _resource_record_pre_action 15:57:12 INFO - Running main action method: install 15:57:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:57:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:57:12 INFO - Reading from file tmpfile_stdout 15:57:12 INFO - Detecting whether we're running mozinstall >=1.0... 15:57:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:57:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:57:13 INFO - Reading from file tmpfile_stdout 15:57:13 INFO - Output received: 15:57:13 INFO - Usage: mozinstall [options] installer 15:57:13 INFO - Options: 15:57:13 INFO - -h, --help show this help message and exit 15:57:13 INFO - -d DEST, --destination=DEST 15:57:13 INFO - Directory to install application into. [default: 15:57:13 INFO - "/builds/slave/test"] 15:57:13 INFO - --app=APP Application being installed. [default: firefox] 15:57:13 INFO - mkdir: /builds/slave/test/build/application 15:57:13 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'] 15:57:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:57:29 INFO - Reading from file tmpfile_stdout 15:57:29 INFO - Output received: 15:57:29 INFO - /builds/slave/test/build/application/firefox/firefox 15:57:29 INFO - Running post-action listener: _resource_record_post_action 15:57:29 INFO - [mozharness: 2017-05-19 22:57:29.210187Z] Finished install step (success) 15:57:29 INFO - [mozharness: 2017-05-19 22:57:29.210462Z] Running run-tests step. 15:57:29 INFO - Running pre-action listener: _resource_record_pre_action 15:57:29 INFO - Running main action method: run_tests 15:57:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:57:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:57:29 INFO - Python 2.7.3 15:57:29 INFO - Return code: 0 15:57:29 INFO - grabbing minidump binary from tooltool 15:57:29 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')]} 15:57:29 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 0x29b17a0>, '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 0x29b26a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b2b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:57:29 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 15:57:29 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 15:57:29 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 15:57:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:57:29 INFO - Return code: 0 15:57:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:57:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:57:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:57:29 INFO - ENV: RUST_BACKTRACE is now 1 15:57:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:57:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:57:29 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/VxRF-SilS6eKtL-GPfrkug/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-071', '--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 15:57:29 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/VxRF-SilS6eKtL-GPfrkug/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-071 --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 15:57:29 INFO - Using env: {'DISPLAY': ':0', 15:57:29 INFO - 'HOME': '/home/cltbld', 15:57:29 INFO - 'LANG': 'en_US.UTF-8', 15:57:29 INFO - 'LANGUAGE': 'en_US:en', 15:57:29 INFO - 'LOGNAME': 'cltbld', 15:57:29 INFO - 'MAIL': '/var/mail/cltbld', 15:57:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:57:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:57:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:29 INFO - 'MOZ_NO_REMOTE': '1', 15:57:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:57:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:57:29 INFO - 'NO_EM_RESTART': '1', 15:57:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:57:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:29 INFO - 'PWD': '/builds/slave/test', 15:57:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:57:29 INFO - 'RUST_BACKTRACE': '1', 15:57:29 INFO - 'SHELL': '/bin/bash', 15:57:29 INFO - 'SHLVL': '1', 15:57:29 INFO - 'TERM': 'linux', 15:57:29 INFO - 'TMOUT': '86400', 15:57:29 INFO - 'USER': 'cltbld', 15:57:29 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495231765.859750-2097675444', 15:57:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:29 INFO - '_': '/tools/buildbot/bin/python'} 15:57:29 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/VxRF-SilS6eKtL-GPfrkug/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-071', '--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 15:57:29 INFO - mozversion application_buildid: 20170519221428 15:57:29 INFO - mozversion application_changeset: 8d60d0f825110cfb646ac31dc16dc011708bcf34 15:57:29 INFO - mozversion application_display_name: Nightly 15:57:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:57:29 INFO - mozversion application_name: Firefox 15:57:29 INFO - mozversion application_remotingname: firefox 15:57:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:57:29 INFO - mozversion application_vendor: Mozilla 15:57:29 INFO - mozversion application_version: 55.0a1 15:57:29 INFO - mozversion platform_buildid: 20170519221428 15:57:29 INFO - mozversion platform_changeset: 8d60d0f825110cfb646ac31dc16dc011708bcf34 15:57:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:57:29 INFO - mozversion platform_version: 55.0a1 15:57:29 INFO - using testdate: 1495234649 15:57:29 INFO - actual date: 1495234649 15:57:29 INFO - starting webserver on 'localhost:59261' 15:57:29 INFO - SUITE-START | Running 2 tests 15:57:29 INFO - TEST-START | dromaeo_css 15:57:29 INFO - operating with platform_type : linux_ 15:57:29 INFO - Initialising browser for dromaeo_css test... 15:57:29 INFO - TEST-INFO | started process 4949 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOAetrG/profile http://localhost:59261/getInfo.html) 15:57:30 INFO - PID 4949 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2963: String.localeCompare is deprecated; use String.prototype.localeCompare instead 15:57:33 INFO - PID 4949 | __metrics Screen width/height:1600/1200 15:57:33 INFO - PID 4949 | colorDepth:24 15:57:33 INFO - PID 4949 | Browser inner width/height: 1024/695 15:57:33 INFO - PID 4949 | __metrics 15:57:35 INFO - TEST-INFO | 4949: exit 0 15:57:35 INFO - Browser initialized. 15:57:35 INFO - Running cycle 1/1 for dromaeo_css test... 15:57:35 INFO - TEST-INFO | started process 5129 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOAetrG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:57:47 INFO - PID 5129 | RSS: Main: 169533440 15:57:47 INFO - PID 5129 | 16:00:53 INFO - PID 5129 | Cycle 1(1): loaded http://localhost:59261/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59261/tests/dromaeo/cssquery-ext.html) 16:00:54 INFO - PID 5129 | RSS: Main: 173551616 16:00:54 INFO - PID 5129 | 16:03:56 INFO - PID 5129 | Cycle 1(1): loaded http://localhost:59261/tests/dromaeo/cssquery-ext.html (next: http://localhost:59261/tests/dromaeo/cssquery-jquery.html) 16:03:57 INFO - PID 5129 | RSS: Main: 172453888 16:03:57 INFO - PID 5129 | 16:06:59 INFO - PID 5129 | Cycle 1(1): loaded http://localhost:59261/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59261/tests/dromaeo/cssquery-mootools.html) 16:06:59 INFO - PID 5129 | RSS: Main: 176218112 16:06:59 INFO - PID 5129 | 16:10:01 INFO - PID 5129 | Cycle 1(1): loaded http://localhost:59261/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59261/tests/dromaeo/cssquery-prototype.html) 16:10:02 INFO - PID 5129 | RSS: Main: 172224512 16:10:02 INFO - PID 5129 | 16:13:05 INFO - PID 5129 | Cycle 1(1): loaded http://localhost:59261/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59261/tests/dromaeo/cssquery-yui.html) 16:13:05 INFO - PID 5129 | RSS: Main: 172072960 16:13:05 INFO - PID 5129 | 16:16:07 INFO - PID 5129 | Cycle 1(1): loaded http://localhost:59261/tests/dromaeo/cssquery-yui.html (next: http://localhost:59261/tests/dromaeo/cssquery-dojo.html) 16:16:08 INFO - PID 5129 | RSS: Main: 179531776 16:16:08 INFO - PID 5129 | 16:16:08 INFO - PID 5129 | __start_tp_report 16:16:08 INFO - PID 5129 | _x_x_mozilla_page_load 16:16:08 INFO - PID 5129 | _x_x_mozilla_page_load_details 16:16:08 INFO - PID 5129 | |i|pagename|runs| 16:16:08 INFO - PID 5129 | |0;dojo.html;2725.0462338181637;2743.561030235163;2752.683441404238;2780.8331500109994;2784.818986765861;5256.369235691713;5373.462653734625;5385.67685938844;5394.217838413428;5404.810831620894;5343.145096784515;5390.029794636964;5412.188171774236;5426.593005524592;5457.481539253775;4728.40894888139;4758.6913598760275;4829.396325459317;4832.3959505061775;4857.708537487744;4755.548222918817;4796.400449943757;4861.222204447272;4876.683015603992;4908.558229759321;4782.880427989293;4830.29960655703;4851.854444366657;4855.951440485585;4867.1482490564185;4720.291956206596;4753.215719406294;4792.209285467894;4808.61531077513;4824.782884770194;4754.477007529169;4779.784909679072;4784.5933095686905;4787.784549695272;4820.8071677132875;5343.145096784535;5347.304850369427;5355.7857685692525;5385.703786291752;5395.163749618815;5636.070048442002;5719.227904232917;5776.97111514444;5853.29760428747;5859.1504231886565;5867.8533036674;5891.145783861359;5920.082387229986;5938.554608404387;5939.67331796751;5416.404195538487;5427.945720542744;5474.343078830566;5474.91787623186;5478;5881.852953676107;5972.611780234271;5984.162217289583;6041.426064523863;6078.057901025348;5715.142728590745;5754.88490230193;5764.855878602984;5789.855253618609;5796.3913789052385;5593;5758.107493338455;5766.481016708516;5844.620099693507;5854.5901786875365;5692.430756924275;5776.740046697909;5809.767609295665;5832.941670583325;5869.413058694096;5597.552195824324;5684.118961560965;5785.566082543826;5790.7973220937065;5805.274340707411;4887.120318342732;4893.779779909913;4943.678660887031;4950.8762280943265;4964.404271487372;4165.958340416557;4174.979125104416;4175.5824417558;4180.268453020709;4217.894552636148;4865.197242455026;4923.90152196954;4925.11347957364;4939.2097264438235;4971.627127965345;5809.419058094241;5818.040023396092;5826.41735826414;5829.009068458372;5831;4930.802767889244;4933.309336692866;4934.432540257844;4936.259561065869;4937.901241975141;5168.508991645787;5177.068127737043;5183.585313174937;5183.714895680774;5186.196139598368;5323.787048518171;5432.456754324536;5443.401225865231;5448.237246785374;5459.07195776711;5808.709564521672;5823.388544202967;5835.095560188178;5840.2991641003355;5896.7936122235515;5382.138857782736;5391.191321301836;5400.918986215132;5417;5418.376886658085;5576.665400076008;5672.602917795714;5679.801206957736;5748.137779333133;5750.568707347049;5891.823245302648;5894.970525147347;5912.260967379078;5916.822495325147;5952.107183922446;5575.414581469049;5703.657780533182;5725.112607545837;5726.0838265877255;5731.3122425307565;5634.85912852182;5645.435456454486;5696.430356964271;5742.425757424224;5747.453991870766;5565.777368905198;5598.524125449219;5598.888022239451;5610.326760788732;5626.971865140812;5722.9126465972995;5731.455511726546;5742.684152371659;5748.310202775694;5799.449052340021;5576.191452239322;5579.972100139474;5582.972085139549;5584.581156413204;5588.245586845724 16:16:08 INFO - PID 5129 | |1;ext.html;674.6896427643284;725.702461990584;749.8013026547966;1156.283104475225;1204.31354128147;32575.51136732951;33983.83008084962;33986.980390588295;34064.31871362571;34136.31727365451;32732.509012364775;33216.50175247367;33251.66748332516;33259.168520786996;33281.16797080074;6439.162908821847;6555.50833687473;6631.104800851896;6786.898196527056;6792.083068785725;6806.795796126099;6924.030635710979;6935.063766391549;6936.861262774742;6941.548799328053;6882.03651488792;6934.9306506935045;6950.582965022115;6953.721851125974;6962.060121883557;6893;6926.653667316614;6931.133608298963;6948.965255173743;6971.930280697229;6836.4530837532875;6844.4182244509275;6867.828304292383;6875.621840798754;6897.034415181878;31030.37939241225;31550.526742098886;31573.894913677912;31664.841675791704;31874.521882171786;2805.2846524136417;2826.646669166354;2835.432913417325;2838.8296702197727;2842.04791394883;24035;24063;24284.27147185587;24350.878245608837;24352.878235608707;2786.066667666334;2819.760320372771;2822.1251412062325;2831.5186418308936;2835.6455443069617;145371;146008;147913;149361;149670.25164874215;37564.81217593895;37686.62313376886;37707.62292377041;37741;37856.43215351772;39237.41143882844;39332.606673932896;39361.40957885634;42860.78569607132;43411;11798.88201117995;11849.348285844362;11895.762084758257;11896.583619573274;11918.404079795975;9158.45049297031;9309.72070837876;9351.532423378803;9385.38994965325;9407.717768466957;12310.81533776994;12412.503499859904;12474.064445166649;12546.81179782304;12688.619341419771;5377.085895397791;5448.564114870801;5540.501354878081;5556.166575013699;5578.721063946787;812.3947658993969;891.9598618062203;910.1490106750209;912.7489940266347;913.7806926337764;20268.495113747176;20959.47601309949;21070.47323816917;21302;21379.67930481044;976.511744127936;979.8089372572423;982.3074732313702;986.6891929042472;998.9960090109539;10703.571857125784;11025.83461248082;11092.778144437227;11170.664880053611;11282.379469129113;170646;173569;174006;174214;174389.12805436144;38700.8064959679;38762.80618596946;38772.22455550873;39020;39045.609543904764;1169.7998288805313;1217.2392254840724;1224.675461002835;1225.724212052299;1240.49759847262;19354;19783.60432791365;19905.800941990976;20643;20989.265375711777;28702.712972870006;28779.856100719364;28802.42395152043;28834;28898.422031559672;145342;145784;145966.27016864848;145987;146211;28178;28510.714892850807;28530.429391412472;28567.857160714062;29621.407571848013;35274;35727.46408803922;35845.82077089598;35924;36078.45882311715;25793;27135.72864271332;27354.53268094376;27367;28786.424271514872;26443;26939.865300673373;27543.724562754116;27630.447391051664;28497.43005139844;29909.252268692588;29912.55131173078;29934.550981735727;29982.700172998862;29984.850075750353;25989.220323390327;26464.06078176501;26666.600000999613;26728.331791705365;27318.726812732413;20392;22316.77683223212;22335.994880230104;22407.663885041413;22556.436089097246 16:16:08 INFO - PID 5129 | |2;jquery.html;398.2970057847899;401.97990100495;412.40407611002104;420.4702075385014;429.6262251840899;16953.406630767924;17580.824191758096;17598.296068157273;18595.814041859576;19098.809011909878;18776.43670689878;19145.32991345303;19173.904130479365;19431.902840485815;19443;5402.567794576444;5479.397266300703;5604.131359639263;5627.7186140693;5639.8590035249035;5549.944500555003;5560.193771903072;5583.441655834405;5600.103983362663;5603.719814009283;5382.946170538303;5568.248286481334;5597.7201139943045;5602.887942241153;5607.130894711327;5446.455354464561;5546.972265138648;5564.610477266593;5606.327240731118;5606.523445507157;5059.2916991621205;5081.568066714333;5095.617828662828;5096.490350964911;5099.69401835891;22080.337589872328;22298.442538936655;22320.441988950242;22728.43178920524;22893.313200604007;1627.3815949939067;1634.6403791165924;1682.0832646207846;1683.6464342488093;1687.6793409252202;14259.429622815074;14383;14676.412943482248;14864.108153510715;14886.255687215596;2042.4179108954024;2090.9790902090936;2128.159377046058;2133.0934352900113;2133.349328454821;85935.57032214862;90467.54766226193;90600.5469972646;90890.5455472725;92334;10347.223958203165;10464.267501274837;10641.255112142231;10704.1436685065;10822.404767737693;14761.704765904622;14776.63058423548;14796.18872414238;14802.185879776716;14843.257837108102;6954.47841411886;7037.2962703730245;7236.674349654279;7242.45681573884;7269.34575888162;6396.968015159894;6429.6142231466265;6539.08452816606;6570.375814297634;6589.571677840925;6754.527183097234;6918.238993710688;6936.861262774716;6956.200036995709;6996.545224560387;2051.712760213571;2059.2998380550684;2060.412782357021;2075.460380301133;2212.4358288636295;826.5206180415345;865.9393842431095;882.3558802074393;885.822835432916;904.1275169461501;16826.579335516464;16936.322547098225;16989.575260618585;17403.56491087733;17730;846.331398195431;862.5083702289635;873.4453621950107;874.2219424712011;888.3515034025069;9093.933901124718;9194.931140493336;9670.226381889432;9677.564509596945;9682.080202380763;327943;332469;333912;334905;366666;76176;77369.61315193388;78183.60908195423;80251.59874200591;80901;1069.79139067881;1098.7308109513222;1106.734383747911;1122.9887701122884;1128.4865386249237;17144.485665430057;17725.556861078578;18175.18211680504;18334.807353110566;18368.724469132707;36150.63849361578;36638.267234655694;37395.43906841454;37521.43717844289;37577;46940.53059469361;47166.52833471621;47205.52794472011;47410.52589474061;49840.50159498359;7500.699972001059;7654.425918056057;8271.710490132817;8500.234978851933;8519.446235994641;12834.55079072228;13059.21644701321;13063.673408164872;13123.081384303006;13144.27706476153;11399;11475.540978361107;11514.654560363202;11950.521979121086;12202.877971220174;10849.294795838561;10932.453377330943;10967.670969870916;10991;11126.888731112585;10715.196360272856;10731.195160362848;10835.945820270848;11057.170712196777;11112.055475284691;7845.529268243924;7953;7977;8084;8123.512589244664;11358.955388030234;11650.184487085822;11718.472668730099;11729.648110556696;11757.294562325946 16:16:08 INFO - PID 5129 | |3;mootools.html;1219.640206139189;1269.8158766978788;1278.6611547939792;1283.0761851466946;1289.5615490733148;9478.66824661137;9812.165965892898;9849.65526206583;9894.604215831376;10145.492725363722;9923.404595724243;10089.747756306097;10096.949515252432;10122.848157277629;10127.746806329846;2229.554089182166;2303.216906251874;2303.9884800576056;2306.331163962457;2306.688597039395;2156.1267686586957;2203.3500117465387;2212.889355532225;2222.20000799712;2234.8659080455222;2167.642339014061;2198.3624748822904;2210.734711834582;2213.1479380438486;2213.214308920334;2064.236232593935;2115.4499830044147;2142.721446211998;2159.0392275437434;2166.1876796201423;2045.202371075282;2132.5415035767383;2150.473134082144;2153.2140768619497;2194.7805219477923;9642;9705.757356066084;9725.173360264385;9730.221582273472;9736.026397360278;5275.736213189325;5427.023135835548;5454.754536045887;5461.371942226615;5500.1749737539685;2928.912132636024;3030.196997795586;3102.9689703102904;3110.673379295164;3114.034649258737;1061.4480470155554;1090.6530434912877;1091.6179337231986;1097.7255686078481;1125.302312566206;13091.869081309256;13149.342532873414;13168.736625267537;13176.802347964789;13207.735845283136;4468.151051300242;4642.257238841769;4731.33761273422;4785.856424307276;4816.927746083811;10124.190064794799;10221.693349199535;10227.744306392251;10233.795324093626;10272.897271027343;5354.250404943311;5412.945870541323;5420.674759514442;5424.267723857229;5429.4299098594865;4910.189818679949;5080.212567052113;5081.060003899291;5084.567811736044;5085.516875896784;3555.7510974232073;3676.7058635309113;3698.6486283802997;3707.1658876752513;3751.7748935063437;1014.9391036537831;1031.2265800649513;1034.5086084110137;1047.0367262118868;1050.7968376209199;656.6257233377024;678.8201126701429;684.7261095561815;705.8588282343552;709.5104377979178;5038.345015148007;5073.720945348041;5158.819441319536;5340.30576025122;5356.384015838151;539.9244105825188;546.4262524349497;547.5345955937421;551.7612958907279;553.1647212708758;2929.7363237308746;3537.3049390481306;3714.9442758358646;3742.1018955450495;3773.8301776420126;12758.80861787074;12811.423485942969;12880.420381082873;13018.349082545836;13052.869471305165;12683.112182147346;12707.364631768374;12770.169938953939;12814.167079139826;12822.42299096543;6347.270063942613;6518.348165183444;6691.899621505681;6737.764178253836;6747.932520674927;5646.898854723289;5778.653280803165;5787.305523337226;5791.565632577658;5923.7926672566255;10868.456577170951;11050.834237486284;11060.889391106308;11177.105831533296;11255.943720281346;11284.887151128383;11300.830487542858;11381.715457113307;11382.317060976367;11538.826917596074;8006.719764808204;8136.430449868452;8136.877946830684;8182;8217.465864718773;9077.591508382271;9163.908360916306;9202.677906273248;9209.953950230207;9210.447373157363;7934.920650793649;8138.267555919995;8191.631376587949;8275.62759675804;8356.164383561838;7881.13307536182;7963.880541791762;8014.278714915686;8051.798705032421;8133.430659853753;7020;7102.254263302486;7115.252898445796;7132.536385134949;7134.357907788324;4822.517748225149;4902.70583764961;4913.533214344631;4926.3842019747535;4956.355673762388;4651.488336283074;4676.830792301925;4730.219513780187;4810.39870016248;4825.831095911626 16:16:08 INFO - PID 5129 | |4;prototype.html;370.3297032371408;372.3167986744324;375.5212104566677;377.87958702447276;382.7301752264655;5508.889822203553;5516;5541.168824676301;5581.832545023651;5688.744006519706;5370.549951513089;5493.725313734307;5495.477929596692;5501.697406642633;5517.613767036309;3968.8610898618554;4081.5918408159246;4092.529359123694;4099.549049604541;4133.772642504654;4091.1408604193157;4091.3658382950543;4097.16008218316;4101.897452563695;4102.384642303648;4066.654334381581;4079.2861249281405;4079.6328330450256;4092.4270602115726;4097.282975479294;4022.235775202702;4023.5372932112596;4049.1699201663882;4084.448599439082;4087.0191154123095;3483.094395457174;3503.8948831535095;3521.2429327694667;3528.100334414708;3549.0949807798847;5258.973705131488;5315.627906046579;5335.573154147659;5345.118055520835;5359.159645387912;4721.480637129913;4753.691010084333;4775.522447755231;4795.448523419816;4811.374521312242;5691.886162276773;5750;5762.9135562966585;5783.8554036149435;5806.274215723035;3949.2299001694682;3956.485656864618;3957.8416863325433;3960.4257382679352;3971.6226958439192;6070.54881271754;6074.301455332649;6118.816435506942;6141.508679305645;6216;4078.1232035112594;4079.102597428561;4079.347304431277;4082.408050832613;4092.3043082676018;4114.629683328515;4118.691098167649;4121.402396652468;4134.359174327984;4143.440635514227;4718.95281047192;4792.209285467929;4810.7835147418455;4815.590674792682;4825.276208568743;5780.468175933381;5784.8264552062665;5797;5803.361630220672;5821.126830975388;1403.2212122272238;1406.5780265920182;1413.8303403591635;1419.496078891999;1420.1904914199015;907.4691305586174;939.2579861909015;941.2799208605286;961.7547525380983;963.426761077158;5074.90430837189;5077;5091.694498330112;5100.719460429712;5102.872428189325;6041.24484439445;6075.908861367083;6080.7871724490315;6094.695265236721;6095.786647467317;4812.278158276286;5031.427686342665;5052;5075.111855425286;5109.642325037212;3216.244182617083;3230.660780618048;3238.4008958342783;3248.4964830451318;3249.6100467943525;5461.962227176903;5608.887822243614;5635.943640563624;5646;5667.1499275108235;6182.979808331665;6247.563060496021;6249.875002499924;6266;6297.527685423612;5491.313585801775;5588.608797384144;5642.435756424325;5646.774129034792;5665.801696940587;6090;6093.2078829751845;6095.689426773265;6101.542384321105;6105.877882442237;5765.423457654201;5929.851753706192;6000.129981152621;6000.97983342824;6002.579819412599;5614.652483404036;5633.901389229061;5640.2621797690135;5644.729935764421;5647.20939068539;4073.287174744467;4083.6937229707296;4089.280628382093;4093.713440059167;4118.773467459198;5981.880362392815;6085.330613632408;6124.448799608057;6126.203593532812;6127.632342059313;5890.352061273342;5896.70516474166;5904.734286957011;5908.113782932594;5914.112883067574;5667.943320566907;5801.738921748447;5879.559033072451;5893.292804863272;5901.911471327848;5739.598228123991;5755.740991655469;5769.913451298318;5777.3933736957015;5799.623024503394;5807.390224026585;5926.377730338425;5961.642301461926;5964.105384192406;5966.582339236212;5708.457696518824;5739.532001239507;5757.8560535986935;5763.7118144093465;5780.421957804354 16:16:08 INFO - PID 5129 | |5;yui.html;700.1283402164299;720.83060480787;746.3133916796546;755.8903958925955;768.9077310722712;12522.81215781764;12698.174618649782;12737.363131843416;14556.344964476584;14605.342759575818;15218.6956260875;15579.376824926989;15895.205239738025;15964.361425542993;15998.360065597391;876.408424313589;906.3791302957462;911.1116661255289;911.257325279898;912.6805618033701;899.2985471332371;900.9144131307515;909.7998440343114;910.1853840812502;915.3272344826547;950.0546955779009;950.8193443245762;952.8523078922778;953.1278879824987;954.6181527389031;948.4356807699407;949.7340744591526;955.6177528988391;958.8034452937165;960.0207788056179;696.4289282788116;699.5313140196081;700.4991431126768;701.0990876723437;702.6135625406006;13041.804372934414;13084.280364579945;13201.669958251025;14042.85957140436;14742;15780.210989450481;16002.279897404645;16015.119168445732;16228.675426491403;16459.177041147894;12856.485740570366;12884.677883052906;12920.353982300847;13002.479900803957;13126.803097953538;3021.7582593392476;3029.4395536825537;3047.740942019931;3064.2033071401597;3079.8768049278;60908;61440.07839882405;61454.69272653653;69501.65249173772;69647.65176174138;11712;12503.874961250453;12545.498180072878;12553.309567973849;12620.621381358575;20568.485787855425;22602.773972260067;22755.203567875044;22759.658605120938;22838.42903927382;5616.326040875121;5772.047612144033;5776.1624564437925;5785.884282314414;6018.759249630053;2756.490049340878;2824.7881408894004;2827.886884524596;2833.362493439001;2844.146755973241;3311.420501412243;3349.464085746269;3364.0412482442384;3373.8144402058124;3460.1176699941857;740.2560426771169;751.0499218488616;752.4619896773833;757.4016526943652;760.6234913717745;512.7948820471842;528.0653243758526;529.7245432375144;529.9496547828028;530.6365139879196;8856.60473504618;9221.354505184572;9591.232701383873;9661.806763864683;9749.122578967927;507.52546369144966;510.9591232701449;519.7707421947068;531.4180971835833;541.2611784913564;4284.3359279311135;4284.957150428519;4311.288637374861;4398.516163222043;4414.404055452473;62027.37972620216;62956.68521657363;63265;65390;65649.34350656527;55942.440575593726;56168.87662246814;56291.71854140785;57430.7128464355;58408.41591584115;49866.75066624644;51644.48355516472;52160.73919630454;52777.2083418749;53393.46606533963;8557.57212139403;8798.032216456313;8920.553972301488;9087.818243634958;9150.039245879354;26619.467610648066;26896.59655105136;26925.73074269232;26953.86523067372;26994.190174294803;32438;32567;33161.17097072592;33519.83240083784;33561.32877342488;11387.601433949772;11577.131715121568;11651.766964660828;11686.883131168579;11724.824127637921;11082.16883733707;11126.721831954266;11139.88601139912;11239.55041798319;11367.886321137014;11337.376444295312;11374;11478.942605287255;11560.884391155982;11603.535858565563;11274.661760147208;11420.371879546705;11432;11571.537138514703;11578.884211157781;11313;11348.602798901999;11588.76822463529;11614.419279035845;11828.881711182778;7796;7859.449838511249;7898.960505197438;8160.428769986044;8224.136465671258;8537.615807288563;8615.612297446756;8634.697785577726;8647.783805404915;8933.15135062168 16:16:08 INFO - PID 5129 | __end_tp_report 16:16:08 INFO - PID 5129 | __start_cc_report 16:16:08 INFO - PID 5129 | _x_x_mozilla_cycle_collect,274 16:16:08 INFO - PID 5129 | __end_cc_report 16:16:08 INFO - PID 5129 | __startTimestamp1495235768076__endTimestamp 16:16:08 INFO - PID 5129 | 16:16:08 INFO - PID 5129 | ------- Summary: start ------- 16:16:08 INFO - PID 5129 | Number of tests: 6 16:16:08 INFO - PID 5129 | 16:16:08 INFO - PID 5129 | [#0] dojo.html Cycles:165 Average:5323.39 Median:5474.34 stddev:633.67 (11.6%) stddev-sans-first:601.94 16:16:08 INFO - PID 5129 | Values: 2725.0 2743.6 2752.7 2780.8 2784.8 5256.4 5373.5 5385.7 5394.2 5404.8 5343.1 5390.0 5412.2 5426.6 5457.5 4728.4 4758.7 4829.4 4832.4 4857.7 4755.5 4796.4 4861.2 4876.7 4908.6 4782.9 4830.3 4851.9 4856.0 4867.1 4720.3 4753.2 4792.2 4808.6 4824.8 4754.5 4779.8 4784.6 4787.8 4820.8 5343.1 5347.3 5355.8 5385.7 5395.2 5636.1 5719.2 5777.0 5853.3 5859.2 5867.9 5891.1 5920.1 5938.6 5939.7 5416.4 5427.9 5474.3 5474.9 5478.0 5881.9 5972.6 5984.2 6041.4 6078.1 5715.1 5754.9 5764.9 5789.9 5796.4 5593.0 5758.1 5766.5 5844.6 5854.6 5692.4 5776.7 5809.8 5832.9 5869.4 5597.6 5684.1 5785.6 5790.8 5805.3 4887.1 4893.8 4943.7 4950.9 4964.4 4166.0 4175.0 4175.6 4180.3 4217.9 4865.2 4923.9 4925.1 4939.2 4971.6 5809.4 5818.0 5826.4 5829.0 5831.0 4930.8 4933.3 4934.4 4936.3 4937.9 5168.5 5177.1 5183.6 5183.7 5186.2 5323.8 5432.5 5443.4 5448.2 5459.1 5808.7 5823.4 5835.1 5840.3 5896.8 5382.1 5391.2 5400.9 5417.0 5418.4 5576.7 5672.6 5679.8 5748.1 5750.6 5891.8 5895.0 5912.3 5916.8 5952.1 5575.4 5703.7 5725.1 5726.1 5731.3 5634.9 5645.4 5696.4 5742.4 5747.5 5565.8 5598.5 5598.9 5610.3 5627.0 5722.9 5731.5 5742.7 5748.3 5799.4 5576.2 5580.0 5583.0 5584.6 5588.2 16:16:08 INFO - PID 5129 | 16:16:08 INFO - PID 5129 | [#1] ext.html Cycles:180 Average:29688.29 Median:29259.91 stddev:40247.67 (137.6%) stddev-sans-first:40301.61 16:16:08 INFO - PID 5129 | Values: 674.7 725.7 749.8 1156.3 1204.3 32575.5 33983.8 33987.0 34064.3 34136.3 32732.5 33216.5 33251.7 33259.2 33281.2 6439.2 6555.5 6631.1 6786.9 6792.1 6806.8 6924.0 6935.1 6936.9 6941.5 6882.0 6934.9 6950.6 6953.7 6962.1 6893.0 6926.7 6931.1 6949.0 6971.9 6836.5 6844.4 6867.8 6875.6 6897.0 31030.4 31550.5 31573.9 31664.8 31874.5 2805.3 2826.6 2835.4 2838.8 2842.0 24035.0 24063.0 24284.3 24350.9 24352.9 2786.1 2819.8 2822.1 2831.5 2835.6 145371.0 146008.0 147913.0 149361.0 149670.3 37564.8 37686.6 37707.6 37741.0 37856.4 39237.4 39332.6 39361.4 42860.8 43411.0 11798.9 11849.3 11895.8 11896.6 11918.4 9158.5 9309.7 9351.5 9385.4 9407.7 12310.8 12412.5 12474.1 12546.8 12688.6 5377.1 5448.6 5540.5 5556.2 5578.7 812.4 892.0 910.1 912.7 913.8 20268.5 20959.5 21070.5 21302.0 21379.7 976.5 979.8 982.3 986.7 999.0 10703.6 11025.8 11092.8 11170.7 11282.4 170646.0 173569.0 174006.0 174214.0 174389.1 38700.8 38762.8 38772.2 39020.0 39045.6 1169.8 1217.2 1224.7 1225.7 1240.5 19354.0 19783.6 19905.8 20643.0 20989.3 28702.7 28779.9 28802.4 28834.0 28898.4 145342.0 145784.0 145966.3 145987.0 146211.0 28178.0 28510.7 28530.4 28567.9 29621.4 35274.0 35727.5 35845.8 35924.0 36078.5 25793.0 27135.7 27354.5 27367.0 28786.4 26443.0 26939.9 27543.7 27630.4 28497.4 29909.3 29912.6 29934.6 29982.7 29984.9 25989.2 26464.1 26666.6 26728.3 27318.7 20392.0 22316.8 22336.0 22407.7 22556.4 16:16:08 INFO - PID 5129 | 16:16:08 INFO - PID 5129 | [#2] jquery.html Cycles:180 Average:24115.15 Median:201652.13 stddev:56875.92 (28.2%) stddev-sans-first:57007.59 16:16:08 INFO - PID 5129 | Values: 398.3 402.0 412.4 420.5 429.6 16953.4 17580.8 17598.3 18595.8 19098.8 18776.4 19145.3 19173.9 19431.9 19443.0 5402.6 5479.4 5604.1 5627.7 5639.9 5549.9 5560.2 5583.4 5600.1 5603.7 5382.9 5568.2 5597.7 5602.9 5607.1 5446.5 5547.0 5564.6 5606.3 5606.5 5059.3 5081.6 5095.6 5096.5 5099.7 22080.3 22298.4 22320.4 22728.4 22893.3 1627.4 1634.6 1682.1 1683.6 1687.7 14259.4 14383.0 14676.4 14864.1 14886.3 2042.4 2091.0 2128.2 2133.1 2133.3 85935.6 90467.5 90600.5 90890.5 92334.0 10347.2 10464.3 10641.3 10704.1 10822.4 14761.7 14776.6 14796.2 14802.2 14843.3 6954.5 7037.3 7236.7 7242.5 7269.3 6397.0 6429.6 6539.1 6570.4 6589.6 6754.5 6918.2 6936.9 6956.2 6996.5 2051.7 2059.3 2060.4 2075.5 2212.4 826.5 865.9 882.4 885.8 904.1 16826.6 16936.3 16989.6 17403.6 17730.0 846.3 862.5 873.4 874.2 888.4 9093.9 9194.9 9670.2 9677.6 9682.1 327943.0 332469.0 333912.0 334905.0 366666.0 76176.0 77369.6 78183.6 80251.6 80901.0 1069.8 1098.7 1106.7 1123.0 1128.5 17144.5 17725.6 18175.2 18334.8 18368.7 36150.6 36638.3 37395.4 37521.4 37577.0 46940.5 47166.5 47205.5 47410.5 49840.5 7500.7 7654.4 8271.7 8500.2 8519.4 12834.6 13059.2 13063.7 13123.1 13144.3 11399.0 11475.5 11514.7 11950.5 12202.9 10849.3 10932.5 10967.7 10991.0 11126.9 10715.2 10731.2 10835.9 11057.2 11112.1 7845.5 7953.0 7977.0 8084.0 8123.5 11359.0 11650.2 11718.5 11729.6 11757.3 16:16:08 INFO - PID 5129 | 16:16:08 INFO - PID 5129 | [#3] mootools.html Cycles:180 Average:5982.83 Median:4555.20 stddev:3796.42 (83.3%) stddev-sans-first:3790.20 16:16:08 INFO - PID 5129 | Values: 1219.6 1269.8 1278.7 1283.1 1289.6 9478.7 9812.2 9849.7 9894.6 10145.5 9923.4 10089.7 10096.9 10122.8 10127.7 2229.6 2303.2 2304.0 2306.3 2306.7 2156.1 2203.4 2212.9 2222.2 2234.9 2167.6 2198.4 2210.7 2213.1 2213.2 2064.2 2115.4 2142.7 2159.0 2166.2 2045.2 2132.5 2150.5 2153.2 2194.8 9642.0 9705.8 9725.2 9730.2 9736.0 5275.7 5427.0 5454.8 5461.4 5500.2 2928.9 3030.2 3103.0 3110.7 3114.0 1061.4 1090.7 1091.6 1097.7 1125.3 13091.9 13149.3 13168.7 13176.8 13207.7 4468.2 4642.3 4731.3 4785.9 4816.9 10124.2 10221.7 10227.7 10233.8 10272.9 5354.3 5412.9 5420.7 5424.3 5429.4 4910.2 5080.2 5081.1 5084.6 5085.5 3555.8 3676.7 3698.6 3707.2 3751.8 1014.9 1031.2 1034.5 1047.0 1050.8 656.6 678.8 684.7 705.9 709.5 5038.3 5073.7 5158.8 5340.3 5356.4 539.9 546.4 547.5 551.8 553.2 2929.7 3537.3 3714.9 3742.1 3773.8 12758.8 12811.4 12880.4 13018.3 13052.9 12683.1 12707.4 12770.2 12814.2 12822.4 6347.3 6518.3 6691.9 6737.8 6747.9 5646.9 5778.7 5787.3 5791.6 5923.8 10868.5 11050.8 11060.9 11177.1 11255.9 11284.9 11300.8 11381.7 11382.3 11538.8 8006.7 8136.4 8136.9 8182.0 8217.5 9077.6 9163.9 9202.7 9210.0 9210.4 7934.9 8138.3 8191.6 8275.6 8356.2 7881.1 7963.9 8014.3 8051.8 8133.4 7020.0 7102.3 7115.3 7132.5 7134.4 4822.5 4902.7 4913.5 4926.4 4956.4 4651.5 4676.8 4730.2 4810.4 4825.8 16:16:08 INFO - PID 5129 | 16:16:08 INFO - PID 5129 | [#4] prototype.html Cycles:180 Average:4784.56 Median:5505.29 stddev:1449.49 (26.3%) stddev-sans-first:1415.18 16:16:08 INFO - PID 5129 | Values: 370.3 372.3 375.5 377.9 382.7 5508.9 5516.0 5541.2 5581.8 5688.7 5370.5 5493.7 5495.5 5501.7 5517.6 3968.9 4081.6 4092.5 4099.5 4133.8 4091.1 4091.4 4097.2 4101.9 4102.4 4066.7 4079.3 4079.6 4092.4 4097.3 4022.2 4023.5 4049.2 4084.4 4087.0 3483.1 3503.9 3521.2 3528.1 3549.1 5259.0 5315.6 5335.6 5345.1 5359.2 4721.5 4753.7 4775.5 4795.4 4811.4 5691.9 5750.0 5762.9 5783.9 5806.3 3949.2 3956.5 3957.8 3960.4 3971.6 6070.5 6074.3 6118.8 6141.5 6216.0 4078.1 4079.1 4079.3 4082.4 4092.3 4114.6 4118.7 4121.4 4134.4 4143.4 4719.0 4792.2 4810.8 4815.6 4825.3 5780.5 5784.8 5797.0 5803.4 5821.1 1403.2 1406.6 1413.8 1419.5 1420.2 907.5 939.3 941.3 961.8 963.4 5074.9 5077.0 5091.7 5100.7 5102.9 6041.2 6075.9 6080.8 6094.7 6095.8 4812.3 5031.4 5052.0 5075.1 5109.6 3216.2 3230.7 3238.4 3248.5 3249.6 5462.0 5608.9 5635.9 5646.0 5667.1 6183.0 6247.6 6249.9 6266.0 6297.5 5491.3 5588.6 5642.4 5646.8 5665.8 6090.0 6093.2 6095.7 6101.5 6105.9 5765.4 5929.9 6000.1 6001.0 6002.6 5614.7 5633.9 5640.3 5644.7 5647.2 4073.3 4083.7 4089.3 4093.7 4118.8 5981.9 6085.3 6124.4 6126.2 6127.6 5890.4 5896.7 5904.7 5908.1 5914.1 5667.9 5801.7 5879.6 5893.3 5901.9 5739.6 5755.7 5769.9 5777.4 5799.6 5807.4 5926.4 5961.6 5964.1 5966.6 5708.5 5739.5 5757.9 5763.7 5780.4 16:16:08 INFO - PID 5129 | 16:16:08 INFO - PID 5129 | [#5] yui.html Cycles:180 Average:14507.97 Median:25187.14 stddev:17674.99 (70.2%) stddev-sans-first:17694.16 16:16:08 INFO - PID 5129 | Values: 700.1 720.8 746.3 755.9 768.9 12522.8 12698.2 12737.4 14556.3 14605.3 15218.7 15579.4 15895.2 15964.4 15998.4 876.4 906.4 911.1 911.3 912.7 899.3 900.9 909.8 910.2 915.3 950.1 950.8 952.9 953.1 954.6 948.4 949.7 955.6 958.8 960.0 696.4 699.5 700.5 701.1 702.6 13041.8 13084.3 13201.7 14042.9 14742.0 15780.2 16002.3 16015.1 16228.7 16459.2 12856.5 12884.7 12920.4 13002.5 13126.8 3021.8 3029.4 3047.7 3064.2 3079.9 60908.0 61440.1 61454.7 69501.7 69647.7 11712.0 12503.9 12545.5 12553.3 12620.6 20568.5 22602.8 22755.2 22759.7 22838.4 5616.3 5772.0 5776.2 5785.9 6018.8 2756.5 2824.8 2827.9 2833.4 2844.1 3311.4 3349.5 3364.0 3373.8 3460.1 740.3 751.0 752.5 757.4 760.6 512.8 528.1 529.7 529.9 530.6 8856.6 9221.4 9591.2 9661.8 9749.1 507.5 511.0 519.8 531.4 541.3 4284.3 4285.0 4311.3 4398.5 4414.4 62027.4 62956.7 63265.0 65390.0 65649.3 55942.4 56168.9 56291.7 57430.7 58408.4 49866.8 51644.5 52160.7 52777.2 53393.5 8557.6 8798.0 8920.6 9087.8 9150.0 26619.5 26896.6 26925.7 26953.9 26994.2 32438.0 32567.0 33161.2 33519.8 33561.3 11387.6 11577.1 11651.8 11686.9 11724.8 11082.2 11126.7 11139.9 11239.6 11367.9 11337.4 11374.0 11478.9 11560.9 11603.5 11274.7 11420.4 11432.0 11571.5 11578.9 11313.0 11348.6 11588.8 11614.4 11828.9 7796.0 7859.4 7899.0 8160.4 8224.1 8537.6 8615.6 8634.7 8647.8 8933.2 16:16:08 INFO - PID 5129 | -------- Summary: end -------- 16:16:08 INFO - PID 5129 | 16:16:08 INFO - TEST-INFO | 5129: exit 0 16:16:08 INFO - TEST-OK | dromaeo_css | took 1119450ms 16:16:08 INFO - TEST-START | kraken 16:16:08 INFO - operating with platform_type : linux_ 16:16:08 INFO - Initialising browser for kraken test... 16:16:08 INFO - TEST-INFO | started process 5556 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzVAm3R/profile http://localhost:59261/getInfo.html) 16:16:09 INFO - PID 5556 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2963: String.localeCompare is deprecated; use String.prototype.localeCompare instead 16:16:13 INFO - PID 5556 | __metrics Screen width/height:1600/1200 16:16:13 INFO - PID 5556 | colorDepth:24 16:16:13 INFO - PID 5556 | Browser inner width/height: 1024/695 16:16:13 INFO - PID 5556 | __metrics 16:16:15 INFO - TEST-INFO | 5556: exit 0 16:16:15 INFO - Browser initialized. 16:16:15 INFO - Running cycle 1/1 for kraken test... 16:16:15 INFO - TEST-INFO | started process 5736 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzVAm3R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:16:26 INFO - PID 5736 | RSS: Main: 169705472 16:16:26 INFO - PID 5736 | 16:16:29 INFO - PID 5736 | Cycle 1(1): loaded http://localhost:59261/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59261/tests/kraken/driver.html?testName=audio-beat-detection) 16:16:30 INFO - PID 5736 | RSS: Main: 173850624 16:16:30 INFO - PID 5736 | 16:16:33 INFO - PID 5736 | Cycle 1(1): loaded http://localhost:59261/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59261/tests/kraken/driver.html?testName=audio-dft) 16:16:33 INFO - PID 5736 | RSS: Main: 173424640 16:16:33 INFO - PID 5736 | 16:16:36 INFO - PID 5736 | Cycle 1(1): loaded http://localhost:59261/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59261/tests/kraken/driver.html?testName=audio-fft) 16:16:37 INFO - PID 5736 | RSS: Main: 169193472 16:16:37 INFO - PID 5736 | 16:16:39 INFO - PID 5736 | Cycle 1(1): loaded http://localhost:59261/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59261/tests/kraken/driver.html?testName=audio-oscillator) 16:16:40 INFO - PID 5736 | RSS: Main: 169615360 16:16:40 INFO - PID 5736 | 16:16:42 INFO - PID 5736 | Cycle 1(1): loaded http://localhost:59261/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59261/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:16:42 INFO - PID 5736 | RSS: Main: 169959424 16:16:42 INFO - PID 5736 | 16:16:45 INFO - PID 5736 | Cycle 1(1): loaded http://localhost:59261/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59261/tests/kraken/driver.html?testName=imaging-darkroom) 16:16:46 INFO - PID 5736 | RSS: Main: 174264320 16:16:46 INFO - PID 5736 | 16:16:50 INFO - PID 5736 | Cycle 1(1): loaded http://localhost:59261/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59261/tests/kraken/driver.html?testName=imaging-desaturate) 16:16:50 INFO - PID 5736 | RSS: Main: 171560960 16:16:50 INFO - PID 5736 | 16:16:53 INFO - PID 5736 | Cycle 1(1): loaded http://localhost:59261/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59261/tests/kraken/driver.html?testName=json-parse-financial) 16:16:54 INFO - PID 5736 | RSS: Main: 172101632 16:16:54 INFO - PID 5736 | 16:16:56 INFO - PID 5736 | Cycle 1(1): loaded http://localhost:59261/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59261/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:16:56 INFO - PID 5736 | RSS: Main: 172343296 16:16:56 INFO - PID 5736 | 16:16:58 INFO - PID 5736 | Cycle 1(1): loaded http://localhost:59261/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59261/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:16:59 INFO - PID 5736 | RSS: Main: 172912640 16:16:59 INFO - PID 5736 | 16:17:01 INFO - PID 5736 | Cycle 1(1): loaded http://localhost:59261/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59261/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:17:01 INFO - PID 5736 | RSS: Main: 172863488 16:17:01 INFO - PID 5736 | 16:17:04 INFO - PID 5736 | Cycle 1(1): loaded http://localhost:59261/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59261/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:17:05 INFO - PID 5736 | RSS: Main: 172994560 16:17:05 INFO - PID 5736 | 16:17:08 INFO - PID 5736 | Cycle 1(1): loaded http://localhost:59261/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59261/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:17:09 INFO - PID 5736 | RSS: Main: 172863488 16:17:09 INFO - PID 5736 | 16:17:11 INFO - PID 5736 | Cycle 1(1): loaded http://localhost:59261/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59261/tests/kraken/driver.html?testName=ai-astar) 16:17:11 INFO - PID 5736 | RSS: Main: 174268416 16:17:11 INFO - PID 5736 | 16:17:11 INFO - PID 5736 | __start_tp_report 16:17:11 INFO - PID 5736 | _x_x_mozilla_page_load 16:17:11 INFO - PID 5736 | _x_x_mozilla_page_load_details 16:17:11 INFO - PID 5736 | |i|pagename|runs| 16:17:11 INFO - PID 5736 | |0;ai-astar;105;113;113;113;115;113;112;113;113;113 16:17:11 INFO - PID 5736 | |1;audio-beat-detection;149;126;124;173;123;125;127;125;154;125 16:17:11 INFO - PID 5736 | |2;audio-dft;164;163;164;164;164;166;172;169;164;164 16:17:11 INFO - PID 5736 | |3;audio-fft;75;76;75;109;78;76;76;76;101;75 16:17:11 INFO - PID 5736 | |4;audio-oscillator;84;84;118;84;84;83;101;83;84;103 16:17:11 INFO - PID 5736 | |5;imaging-gaussian-blur;114;115;114;113;114;113;114;115;115;114 16:17:11 INFO - PID 5736 | |6;imaging-darkroom;152;150;151;151;152;151;156;155;151;151 16:17:11 INFO - PID 5736 | |7;imaging-desaturate;95;96;94;98;95;95;95;95;94;95 16:17:11 INFO - PID 5736 | |8;json-parse-financial;59;63;55;56;57;56;58;63;56;58 16:17:11 INFO - PID 5736 | |9;json-stringify-tinderbox;56;56;56;57;56;56;62;56;56;56 16:17:11 INFO - PID 5736 | |10;stanford-crypto-aes;83;91;84;93;83;83;91;84;82;81 16:17:11 INFO - PID 5736 | |11;stanford-crypto-ccm;136;143;133;142;141;142;138;138;181;140 16:17:11 INFO - PID 5736 | |12;stanford-crypto-pbkdf2;184;203;199;201;195;199;195;186;203;192 16:17:11 INFO - PID 5736 | |13;stanford-crypto-sha256-iterative;76;78;74;74;74;73;75;75;72;77 16:17:11 INFO - PID 5736 | __end_tp_report 16:17:11 INFO - PID 5736 | __start_cc_report 16:17:11 INFO - PID 5736 | _x_x_mozilla_cycle_collect,763 16:17:11 INFO - PID 5736 | __end_cc_report 16:17:11 INFO - PID 5736 | __startTimestamp1495235831450__endTimestamp 16:17:11 INFO - PID 5736 | 16:17:11 INFO - PID 5736 | ------- Summary: start ------- 16:17:11 INFO - PID 5736 | Number of tests: 14 16:17:11 INFO - PID 5736 | 16:17:11 INFO - PID 5736 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.00 stddev:2.67 (2.4%) stddev-sans-first:0.78 16:17:11 INFO - PID 5736 | Values: 105.0 113.0 113.0 113.0 115.0 113.0 112.0 113.0 113.0 113.0 16:17:11 INFO - PID 5736 | 16:17:11 INFO - PID 5736 | [#1] audio-beat-detection Cycles:10 Average:135.10 Median:126.50 stddev:17.36 (13.7%) stddev-sans-first:17.66 16:17:11 INFO - PID 5736 | Values: 149.0 126.0 124.0 173.0 123.0 125.0 127.0 125.0 154.0 125.0 16:17:11 INFO - PID 5736 | 16:17:11 INFO - PID 5736 | [#2] audio-dft Cycles:10 Average:165.40 Median:164.00 stddev:2.88 (1.8%) stddev-sans-first:3.00 16:17:11 INFO - PID 5736 | Values: 164.0 163.0 164.0 164.0 164.0 166.0 172.0 169.0 164.0 164.0 16:17:11 INFO - PID 5736 | 16:17:11 INFO - PID 5736 | [#3] audio-fft Cycles:10 Average:81.70 Median:76.00 stddev:12.45 (16.4%) stddev-sans-first:12.97 16:17:11 INFO - PID 5736 | Values: 75.0 76.0 75.0 109.0 78.0 76.0 76.0 76.0 101.0 75.0 16:17:11 INFO - PID 5736 | 16:17:11 INFO - PID 5736 | [#4] audio-oscillator Cycles:10 Average:90.80 Median:84.00 stddev:12.23 (14.6%) stddev-sans-first:12.72 16:17:11 INFO - PID 5736 | Values: 84.0 84.0 118.0 84.0 84.0 83.0 101.0 83.0 84.0 103.0 16:17:11 INFO - PID 5736 | 16:17:11 INFO - PID 5736 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 16:17:11 INFO - PID 5736 | Values: 114.0 115.0 114.0 113.0 114.0 113.0 114.0 115.0 115.0 114.0 16:17:11 INFO - PID 5736 | 16:17:11 INFO - PID 5736 | [#6] imaging-darkroom Cycles:10 Average:152.00 Median:151.50 stddev:1.94 (1.3%) stddev-sans-first:2.06 16:17:11 INFO - PID 5736 | Values: 152.0 150.0 151.0 151.0 152.0 151.0 156.0 155.0 151.0 151.0 16:17:11 INFO - PID 5736 | 16:17:11 INFO - PID 5736 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:1.14 (1.2%) stddev-sans-first:1.20 16:17:11 INFO - PID 5736 | Values: 95.0 96.0 94.0 98.0 95.0 95.0 95.0 95.0 94.0 95.0 16:17:11 INFO - PID 5736 | 16:17:11 INFO - PID 5736 | [#8] json-parse-financial Cycles:10 Average:58.10 Median:58.00 stddev:2.85 (4.9%) stddev-sans-first:3.00 16:17:11 INFO - PID 5736 | Values: 59.0 63.0 55.0 56.0 57.0 56.0 58.0 63.0 56.0 58.0 16:17:11 INFO - PID 5736 | 16:17:11 INFO - PID 5736 | [#9] json-stringify-tinderbox Cycles:10 Average:56.70 Median:56.00 stddev:1.89 (3.4%) stddev-sans-first:1.99 16:17:11 INFO - PID 5736 | Values: 56.0 56.0 56.0 57.0 56.0 56.0 62.0 56.0 56.0 56.0 16:17:11 INFO - PID 5736 | 16:17:11 INFO - PID 5736 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:84.00 stddev:4.38 (5.2%) stddev-sans-first:4.55 16:17:11 INFO - PID 5736 | Values: 83.0 91.0 84.0 93.0 83.0 83.0 91.0 84.0 82.0 81.0 16:17:11 INFO - PID 5736 | 16:17:11 INFO - PID 5736 | [#11] stanford-crypto-ccm Cycles:10 Average:143.40 Median:141.50 stddev:13.57 (9.6%) stddev-sans-first:14.12 16:17:11 INFO - PID 5736 | Values: 136.0 143.0 133.0 142.0 141.0 142.0 138.0 138.0 181.0 140.0 16:17:11 INFO - PID 5736 | 16:17:11 INFO - PID 5736 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.70 Median:199.00 stddev:6.68 (3.4%) stddev-sans-first:5.59 16:17:11 INFO - PID 5736 | Values: 184.0 203.0 199.0 201.0 195.0 199.0 195.0 186.0 203.0 192.0 16:17:11 INFO - PID 5736 | 16:17:11 INFO - PID 5736 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.80 Median:75.00 stddev:1.81 (2.4%) stddev-sans-first:1.87 16:17:11 INFO - PID 5736 | Values: 76.0 78.0 74.0 74.0 74.0 73.0 75.0 75.0 72.0 77.0 16:17:11 INFO - PID 5736 | -------- Summary: end -------- 16:17:11 INFO - PID 5736 | 16:17:12 INFO - TEST-INFO | 5736: exit 0 16:17:12 INFO - TEST-OK | kraken | took 63634ms 16:17:12 INFO - SUITE-END | took 1183s 16:17:12 INFO - Completed test suite (00:19:43) 16:17:12 INFO - javascript benchmark 16:17:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6604.572336982266, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2725.0462338181637, 2743.561030235163, 2752.683441404238, 2780.8331500109994, 2784.818986765861, 5256.369235691713, 5373.462653734625, 5385.67685938844, 5394.217838413428, 5404.810831620894, 5343.145096784515, 5390.029794636964, 5412.188171774236, 5426.593005524592, 5457.481539253775, 4728.40894888139, 4758.6913598760275, 4829.396325459317, 4832.3959505061775, 4857.708537487744, 4755.548222918817, 4796.400449943757, 4861.222204447272, 4876.683015603992, 4908.558229759321, 4782.880427989293, 4830.29960655703, 4851.854444366657, 4855.951440485585, 4867.1482490564185, 4720.291956206596, 4753.215719406294, 4792.209285467894, 4808.61531077513, 4824.782884770194, 4754.477007529169, 4779.784909679072, 4784.5933095686905, 4787.784549695272, 4820.8071677132875, 5343.145096784535, 5347.304850369427, 5355.7857685692525, 5385.703786291752, 5395.163749618815, 5636.070048442002, 5719.227904232917, 5776.97111514444, 5853.29760428747, 5859.1504231886565, 5867.8533036674, 5891.145783861359, 5920.082387229986, 5938.554608404387, 5939.67331796751, 5416.404195538487, 5427.945720542744, 5474.343078830566, 5474.91787623186, 5478.0, 5881.852953676107, 5972.611780234271, 5984.162217289583, 6041.426064523863, 6078.057901025348, 5715.142728590745, 5754.88490230193, 5764.855878602984, 5789.855253618609, 5796.3913789052385, 5593.0, 5758.107493338455, 5766.481016708516, 5844.620099693507, 5854.5901786875365, 5692.430756924275, 5776.740046697909, 5809.767609295665, 5832.941670583325, 5869.413058694096, 5597.552195824324, 5684.118961560965, 5785.566082543826, 5790.7973220937065, 5805.274340707411, 4887.120318342732, 4893.779779909913, 4943.678660887031, 4950.8762280943265, 4964.404271487372, 4165.958340416557, 4174.979125104416, 4175.5824417558, 4180.268453020709, 4217.894552636148, 4865.197242455026, 4923.90152196954, 4925.11347957364, 4939.2097264438235, 4971.627127965345, 5809.419058094241, 5818.040023396092, 5826.41735826414, 5829.009068458372, 5831.0, 4930.802767889244, 4933.309336692866, 4934.432540257844, 4936.259561065869, 4937.901241975141, 5168.508991645787, 5177.068127737043, 5183.585313174937, 5183.714895680774, 5186.196139598368, 5323.787048518171, 5432.456754324536, 5443.401225865231, 5448.237246785374, 5459.07195776711, 5808.709564521672, 5823.388544202967, 5835.095560188178, 5840.2991641003355, 5896.7936122235515, 5382.138857782736, 5391.191321301836, 5400.918986215132, 5417.0, 5418.376886658085, 5576.665400076008, 5672.602917795714, 5679.801206957736, 5748.137779333133, 5750.568707347049, 5891.823245302648, 5894.970525147347, 5912.260967379078, 5916.822495325147, 5952.107183922446, 5575.414581469049, 5703.657780533182, 5725.112607545837, 5726.0838265877255, 5731.3122425307565, 5634.85912852182, 5645.435456454486, 5696.430356964271, 5742.425757424224, 5747.453991870766, 5565.777368905198, 5598.524125449219, 5598.888022239451, 5610.326760788732, 5626.971865140812, 5722.9126465972995, 5731.455511726546, 5742.684152371659, 5748.310202775694, 5799.449052340021, 5576.191452239322, 5579.972100139474, 5582.972085139549, 5584.581156413204, 5588.245586845724], "value": 5276.278587334867, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [674.6896427643284, 725.702461990584, 749.8013026547966, 1156.283104475225, 1204.31354128147, 32575.51136732951, 33983.83008084962, 33986.980390588295, 34064.31871362571, 34136.31727365451, 32732.509012364775, 33216.50175247367, 33251.66748332516, 33259.168520786996, 33281.16797080074, 6439.162908821847, 6555.50833687473, 6631.104800851896, 6786.898196527056, 6792.083068785725, 6806.795796126099, 6924.030635710979, 6935.063766391549, 6936.861262774742, 6941.548799328053, 6882.03651488792, 6934.9306506935045, 6950.582965022115, 6953.721851125974, 6962.060121883557, 6893.0, 6926.653667316614, 6931.133608298963, 6948.965255173743, 6971.930280697229, 6836.4530837532875, 6844.4182244509275, 6867.828304292383, 6875.621840798754, 6897.034415181878, 31030.37939241225, 31550.526742098886, 31573.894913677912, 31664.841675791704, 31874.521882171786, 2805.2846524136417, 2826.646669166354, 2835.432913417325, 2838.8296702197727, 2842.04791394883, 24035.0, 24063.0, 24284.27147185587, 24350.878245608837, 24352.878235608707, 2786.066667666334, 2819.760320372771, 2822.1251412062325, 2831.5186418308936, 2835.6455443069617, 145371.0, 146008.0, 147913.0, 149361.0, 149670.25164874215, 37564.81217593895, 37686.62313376886, 37707.62292377041, 37741.0, 37856.43215351772, 39237.41143882844, 39332.606673932896, 39361.40957885634, 42860.78569607132, 43411.0, 11798.88201117995, 11849.348285844362, 11895.762084758257, 11896.583619573274, 11918.404079795975, 9158.45049297031, 9309.72070837876, 9351.532423378803, 9385.38994965325, 9407.717768466957, 12310.81533776994, 12412.503499859904, 12474.064445166649, 12546.81179782304, 12688.619341419771, 5377.085895397791, 5448.564114870801, 5540.501354878081, 5556.166575013699, 5578.721063946787, 812.3947658993969, 891.9598618062203, 910.1490106750209, 912.7489940266347, 913.7806926337764, 20268.495113747176, 20959.47601309949, 21070.47323816917, 21302.0, 21379.67930481044, 976.511744127936, 979.8089372572423, 982.3074732313702, 986.6891929042472, 998.9960090109539, 10703.571857125784, 11025.83461248082, 11092.778144437227, 11170.664880053611, 11282.379469129113, 170646.0, 173569.0, 174006.0, 174214.0, 174389.12805436144, 38700.8064959679, 38762.80618596946, 38772.22455550873, 39020.0, 39045.609543904764, 1169.7998288805313, 1217.2392254840724, 1224.675461002835, 1225.724212052299, 1240.49759847262, 19354.0, 19783.60432791365, 19905.800941990976, 20643.0, 20989.265375711777, 28702.712972870006, 28779.856100719364, 28802.42395152043, 28834.0, 28898.422031559672, 145342.0, 145784.0, 145966.27016864848, 145987.0, 146211.0, 28178.0, 28510.714892850807, 28530.429391412472, 28567.857160714062, 29621.407571848013, 35274.0, 35727.46408803922, 35845.82077089598, 35924.0, 36078.45882311715, 25793.0, 27135.72864271332, 27354.53268094376, 27367.0, 28786.424271514872, 26443.0, 26939.865300673373, 27543.724562754116, 27630.447391051664, 28497.43005139844, 29909.252268692588, 29912.55131173078, 29934.550981735727, 29982.700172998862, 29984.850075750353, 25989.220323390327, 26464.06078176501, 26666.600000999613, 26728.331791705365, 27318.726812732413, 20392.0, 22316.77683223212, 22335.994880230104, 22407.663885041413, 22556.436089097246], "value": 14203.367045531353, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.2970057847899, 401.97990100495, 412.40407611002104, 420.4702075385014, 429.6262251840899, 16953.406630767924, 17580.824191758096, 17598.296068157273, 18595.814041859576, 19098.809011909878, 18776.43670689878, 19145.32991345303, 19173.904130479365, 19431.902840485815, 19443.0, 5402.567794576444, 5479.397266300703, 5604.131359639263, 5627.7186140693, 5639.8590035249035, 5549.944500555003, 5560.193771903072, 5583.441655834405, 5600.103983362663, 5603.719814009283, 5382.946170538303, 5568.248286481334, 5597.7201139943045, 5602.887942241153, 5607.130894711327, 5446.455354464561, 5546.972265138648, 5564.610477266593, 5606.327240731118, 5606.523445507157, 5059.2916991621205, 5081.568066714333, 5095.617828662828, 5096.490350964911, 5099.69401835891, 22080.337589872328, 22298.442538936655, 22320.441988950242, 22728.43178920524, 22893.313200604007, 1627.3815949939067, 1634.6403791165924, 1682.0832646207846, 1683.6464342488093, 1687.6793409252202, 14259.429622815074, 14383.0, 14676.412943482248, 14864.108153510715, 14886.255687215596, 2042.4179108954024, 2090.9790902090936, 2128.159377046058, 2133.0934352900113, 2133.349328454821, 85935.57032214862, 90467.54766226193, 90600.5469972646, 90890.5455472725, 92334.0, 10347.223958203165, 10464.267501274837, 10641.255112142231, 10704.1436685065, 10822.404767737693, 14761.704765904622, 14776.63058423548, 14796.18872414238, 14802.185879776716, 14843.257837108102, 6954.47841411886, 7037.2962703730245, 7236.674349654279, 7242.45681573884, 7269.34575888162, 6396.968015159894, 6429.6142231466265, 6539.08452816606, 6570.375814297634, 6589.571677840925, 6754.527183097234, 6918.238993710688, 6936.861262774716, 6956.200036995709, 6996.545224560387, 2051.712760213571, 2059.2998380550684, 2060.412782357021, 2075.460380301133, 2212.4358288636295, 826.5206180415345, 865.9393842431095, 882.3558802074393, 885.822835432916, 904.1275169461501, 16826.579335516464, 16936.322547098225, 16989.575260618585, 17403.56491087733, 17730.0, 846.331398195431, 862.5083702289635, 873.4453621950107, 874.2219424712011, 888.3515034025069, 9093.933901124718, 9194.931140493336, 9670.226381889432, 9677.564509596945, 9682.080202380763, 327943.0, 332469.0, 333912.0, 334905.0, 366666.0, 76176.0, 77369.61315193388, 78183.60908195423, 80251.59874200591, 80901.0, 1069.79139067881, 1098.7308109513222, 1106.734383747911, 1122.9887701122884, 1128.4865386249237, 17144.485665430057, 17725.556861078578, 18175.18211680504, 18334.807353110566, 18368.724469132707, 36150.63849361578, 36638.267234655694, 37395.43906841454, 37521.43717844289, 37577.0, 46940.53059469361, 47166.52833471621, 47205.52794472011, 47410.52589474061, 49840.50159498359, 7500.699972001059, 7654.425918056057, 8271.710490132817, 8500.234978851933, 8519.446235994641, 12834.55079072228, 13059.21644701321, 13063.673408164872, 13123.081384303006, 13144.27706476153, 11399.0, 11475.540978361107, 11514.654560363202, 11950.521979121086, 12202.877971220174, 10849.294795838561, 10932.453377330943, 10967.670969870916, 10991.0, 11126.888731112585, 10715.196360272856, 10731.195160362848, 10835.945820270848, 11057.170712196777, 11112.055475284691, 7845.529268243924, 7953.0, 7977.0, 8084.0, 8123.512589244664, 11358.955388030234, 11650.184487085822, 11718.472668730099, 11729.648110556696, 11757.294562325946], "value": 8844.324211508889, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1219.640206139189, 1269.8158766978788, 1278.6611547939792, 1283.0761851466946, 1289.5615490733148, 9478.66824661137, 9812.165965892898, 9849.65526206583, 9894.604215831376, 10145.492725363722, 9923.404595724243, 10089.747756306097, 10096.949515252432, 10122.848157277629, 10127.746806329846, 2229.554089182166, 2303.216906251874, 2303.9884800576056, 2306.331163962457, 2306.688597039395, 2156.1267686586957, 2203.3500117465387, 2212.889355532225, 2222.20000799712, 2234.8659080455222, 2167.642339014061, 2198.3624748822904, 2210.734711834582, 2213.1479380438486, 2213.214308920334, 2064.236232593935, 2115.4499830044147, 2142.721446211998, 2159.0392275437434, 2166.1876796201423, 2045.202371075282, 2132.5415035767383, 2150.473134082144, 2153.2140768619497, 2194.7805219477923, 9642.0, 9705.757356066084, 9725.173360264385, 9730.221582273472, 9736.026397360278, 5275.736213189325, 5427.023135835548, 5454.754536045887, 5461.371942226615, 5500.1749737539685, 2928.912132636024, 3030.196997795586, 3102.9689703102904, 3110.673379295164, 3114.034649258737, 1061.4480470155554, 1090.6530434912877, 1091.6179337231986, 1097.7255686078481, 1125.302312566206, 13091.869081309256, 13149.342532873414, 13168.736625267537, 13176.802347964789, 13207.735845283136, 4468.151051300242, 4642.257238841769, 4731.33761273422, 4785.856424307276, 4816.927746083811, 10124.190064794799, 10221.693349199535, 10227.744306392251, 10233.795324093626, 10272.897271027343, 5354.250404943311, 5412.945870541323, 5420.674759514442, 5424.267723857229, 5429.4299098594865, 4910.189818679949, 5080.212567052113, 5081.060003899291, 5084.567811736044, 5085.516875896784, 3555.7510974232073, 3676.7058635309113, 3698.6486283802997, 3707.1658876752513, 3751.7748935063437, 1014.9391036537831, 1031.2265800649513, 1034.5086084110137, 1047.0367262118868, 1050.7968376209199, 656.6257233377024, 678.8201126701429, 684.7261095561815, 705.8588282343552, 709.5104377979178, 5038.345015148007, 5073.720945348041, 5158.819441319536, 5340.30576025122, 5356.384015838151, 539.9244105825188, 546.4262524349497, 547.5345955937421, 551.7612958907279, 553.1647212708758, 2929.7363237308746, 3537.3049390481306, 3714.9442758358646, 3742.1018955450495, 3773.8301776420126, 12758.80861787074, 12811.423485942969, 12880.420381082873, 13018.349082545836, 13052.869471305165, 12683.112182147346, 12707.364631768374, 12770.169938953939, 12814.167079139826, 12822.42299096543, 6347.270063942613, 6518.348165183444, 6691.899621505681, 6737.764178253836, 6747.932520674927, 5646.898854723289, 5778.653280803165, 5787.305523337226, 5791.565632577658, 5923.7926672566255, 10868.456577170951, 11050.834237486284, 11060.889391106308, 11177.105831533296, 11255.943720281346, 11284.887151128383, 11300.830487542858, 11381.715457113307, 11382.317060976367, 11538.826917596074, 8006.719764808204, 8136.430449868452, 8136.877946830684, 8182.0, 8217.465864718773, 9077.591508382271, 9163.908360916306, 9202.677906273248, 9209.953950230207, 9210.447373157363, 7934.920650793649, 8138.267555919995, 8191.631376587949, 8275.62759675804, 8356.164383561838, 7881.13307536182, 7963.880541791762, 8014.278714915686, 8051.798705032421, 8133.430659853753, 7020.0, 7102.254263302486, 7115.252898445796, 7132.536385134949, 7134.357907788324, 4822.517748225149, 4902.70583764961, 4913.533214344631, 4926.3842019747535, 4956.355673762388, 4651.488336283074, 4676.830792301925, 4730.219513780187, 4810.39870016248, 4825.831095911626], "value": 4499.337363332069, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.3297032371408, 372.3167986744324, 375.5212104566677, 377.87958702447276, 382.7301752264655, 5508.889822203553, 5516.0, 5541.168824676301, 5581.832545023651, 5688.744006519706, 5370.549951513089, 5493.725313734307, 5495.477929596692, 5501.697406642633, 5517.613767036309, 3968.8610898618554, 4081.5918408159246, 4092.529359123694, 4099.549049604541, 4133.772642504654, 4091.1408604193157, 4091.3658382950543, 4097.16008218316, 4101.897452563695, 4102.384642303648, 4066.654334381581, 4079.2861249281405, 4079.6328330450256, 4092.4270602115726, 4097.282975479294, 4022.235775202702, 4023.5372932112596, 4049.1699201663882, 4084.448599439082, 4087.0191154123095, 3483.094395457174, 3503.8948831535095, 3521.2429327694667, 3528.100334414708, 3549.0949807798847, 5258.973705131488, 5315.627906046579, 5335.573154147659, 5345.118055520835, 5359.159645387912, 4721.480637129913, 4753.691010084333, 4775.522447755231, 4795.448523419816, 4811.374521312242, 5691.886162276773, 5750.0, 5762.9135562966585, 5783.8554036149435, 5806.274215723035, 3949.2299001694682, 3956.485656864618, 3957.8416863325433, 3960.4257382679352, 3971.6226958439192, 6070.54881271754, 6074.301455332649, 6118.816435506942, 6141.508679305645, 6216.0, 4078.1232035112594, 4079.102597428561, 4079.347304431277, 4082.408050832613, 4092.3043082676018, 4114.629683328515, 4118.691098167649, 4121.402396652468, 4134.359174327984, 4143.440635514227, 4718.95281047192, 4792.209285467929, 4810.7835147418455, 4815.590674792682, 4825.276208568743, 5780.468175933381, 5784.8264552062665, 5797.0, 5803.361630220672, 5821.126830975388, 1403.2212122272238, 1406.5780265920182, 1413.8303403591635, 1419.496078891999, 1420.1904914199015, 907.4691305586174, 939.2579861909015, 941.2799208605286, 961.7547525380983, 963.426761077158, 5074.90430837189, 5077.0, 5091.694498330112, 5100.719460429712, 5102.872428189325, 6041.24484439445, 6075.908861367083, 6080.7871724490315, 6094.695265236721, 6095.786647467317, 4812.278158276286, 5031.427686342665, 5052.0, 5075.111855425286, 5109.642325037212, 3216.244182617083, 3230.660780618048, 3238.4008958342783, 3248.4964830451318, 3249.6100467943525, 5461.962227176903, 5608.887822243614, 5635.943640563624, 5646.0, 5667.1499275108235, 6182.979808331665, 6247.563060496021, 6249.875002499924, 6266.0, 6297.527685423612, 5491.313585801775, 5588.608797384144, 5642.435756424325, 5646.774129034792, 5665.801696940587, 6090.0, 6093.2078829751845, 6095.689426773265, 6101.542384321105, 6105.877882442237, 5765.423457654201, 5929.851753706192, 6000.129981152621, 6000.97983342824, 6002.579819412599, 5614.652483404036, 5633.901389229061, 5640.2621797690135, 5644.729935764421, 5647.20939068539, 4073.287174744467, 4083.6937229707296, 4089.280628382093, 4093.713440059167, 4118.773467459198, 5981.880362392815, 6085.330613632408, 6124.448799608057, 6126.203593532812, 6127.632342059313, 5890.352061273342, 5896.70516474166, 5904.734286957011, 5908.113782932594, 5914.112883067574, 5667.943320566907, 5801.738921748447, 5879.559033072451, 5893.292804863272, 5901.911471327848, 5739.598228123991, 5755.740991655469, 5769.913451298318, 5777.3933736957015, 5799.623024503394, 5807.390224026585, 5926.377730338425, 5961.642301461926, 5964.105384192406, 5966.582339236212, 5708.457696518824, 5739.532001239507, 5757.8560535986935, 5763.7118144093465, 5780.421957804354], "value": 4332.492163598586, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.1283402164299, 720.83060480787, 746.3133916796546, 755.8903958925955, 768.9077310722712, 12522.81215781764, 12698.174618649782, 12737.363131843416, 14556.344964476584, 14605.342759575818, 15218.6956260875, 15579.376824926989, 15895.205239738025, 15964.361425542993, 15998.360065597391, 876.408424313589, 906.3791302957462, 911.1116661255289, 911.257325279898, 912.6805618033701, 899.2985471332371, 900.9144131307515, 909.7998440343114, 910.1853840812502, 915.3272344826547, 950.0546955779009, 950.8193443245762, 952.8523078922778, 953.1278879824987, 954.6181527389031, 948.4356807699407, 949.7340744591526, 955.6177528988391, 958.8034452937165, 960.0207788056179, 696.4289282788116, 699.5313140196081, 700.4991431126768, 701.0990876723437, 702.6135625406006, 13041.804372934414, 13084.280364579945, 13201.669958251025, 14042.85957140436, 14742.0, 15780.210989450481, 16002.279897404645, 16015.119168445732, 16228.675426491403, 16459.177041147894, 12856.485740570366, 12884.677883052906, 12920.353982300847, 13002.479900803957, 13126.803097953538, 3021.7582593392476, 3029.4395536825537, 3047.740942019931, 3064.2033071401597, 3079.8768049278, 60908.0, 61440.07839882405, 61454.69272653653, 69501.65249173772, 69647.65176174138, 11712.0, 12503.874961250453, 12545.498180072878, 12553.309567973849, 12620.621381358575, 20568.485787855425, 22602.773972260067, 22755.203567875044, 22759.658605120938, 22838.42903927382, 5616.326040875121, 5772.047612144033, 5776.1624564437925, 5785.884282314414, 6018.759249630053, 2756.490049340878, 2824.7881408894004, 2827.886884524596, 2833.362493439001, 2844.146755973241, 3311.420501412243, 3349.464085746269, 3364.0412482442384, 3373.8144402058124, 3460.1176699941857, 740.2560426771169, 751.0499218488616, 752.4619896773833, 757.4016526943652, 760.6234913717745, 512.7948820471842, 528.0653243758526, 529.7245432375144, 529.9496547828028, 530.6365139879196, 8856.60473504618, 9221.354505184572, 9591.232701383873, 9661.806763864683, 9749.122578967927, 507.52546369144966, 510.9591232701449, 519.7707421947068, 531.4180971835833, 541.2611784913564, 4284.3359279311135, 4284.957150428519, 4311.288637374861, 4398.516163222043, 4414.404055452473, 62027.37972620216, 62956.68521657363, 63265.0, 65390.0, 65649.34350656527, 55942.440575593726, 56168.87662246814, 56291.71854140785, 57430.7128464355, 58408.41591584115, 49866.75066624644, 51644.48355516472, 52160.73919630454, 52777.2083418749, 53393.46606533963, 8557.57212139403, 8798.032216456313, 8920.553972301488, 9087.818243634958, 9150.039245879354, 26619.467610648066, 26896.59655105136, 26925.73074269232, 26953.86523067372, 26994.190174294803, 32438.0, 32567.0, 33161.17097072592, 33519.83240083784, 33561.32877342488, 11387.601433949772, 11577.131715121568, 11651.766964660828, 11686.883131168579, 11724.824127637921, 11082.16883733707, 11126.721831954266, 11139.88601139912, 11239.55041798319, 11367.886321137014, 11337.376444295312, 11374.0, 11478.942605287255, 11560.884391155982, 11603.535858565563, 11274.661760147208, 11420.371879546705, 11432.0, 11571.537138514703, 11578.884211157781, 11313.0, 11348.602798901999, 11588.76822463529, 11614.419279035845, 11828.881711182778, 7796.0, 7859.449838511249, 7898.960505197438, 8160.428769986044, 8224.136465671258, 8537.615807288563, 8615.612297446756, 8634.697785577726, 8647.783805404915, 8933.15135062168], "value": 6423.420612672953, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1560.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 113.0, 113.0, 115.0, 113.0, 112.0, 113.0, 113.0, 113.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 126.0, 124.0, 173.0, 123.0, 125.0, 127.0, 125.0, 154.0, 125.0], "value": 135.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 164.0, 164.0, 164.0, 166.0, 172.0, 169.0, 164.0, 164.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 109.0, 78.0, 76.0, 76.0, 76.0, 101.0, 75.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 118.0, 84.0, 84.0, 83.0, 101.0, 83.0, 84.0, 103.0], "value": 90.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 113.0, 114.0, 113.0, 114.0, 115.0, 115.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 150.0, 151.0, 151.0, 152.0, 151.0, 156.0, 155.0, 151.0, 151.0], "value": 152.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 94.0, 98.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 63.0, 55.0, 56.0, 57.0, 56.0, 58.0, 63.0, 56.0, 58.0], "value": 58.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 57.0, 56.0, 56.0, 62.0, 56.0, 56.0, 56.0], "value": 56.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 91.0, 84.0, 93.0, 83.0, 83.0, 91.0, 84.0, 82.0, 81.0], "value": 85.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 143.0, 133.0, 142.0, 141.0, 142.0, 138.0, 138.0, 181.0, 140.0], "value": 143.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 203.0, 199.0, 201.0, 195.0, 199.0, 195.0, 186.0, 203.0, 192.0], "value": 195.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 74.0, 74.0, 74.0, 73.0, 75.0, 75.0, 72.0, 77.0], "value": 74.8, "unit": "score"}]}]} 16:17:12 INFO - Return code: 0 16:17:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:17:12 INFO - # TBPL SUCCESS # 16:17:12 INFO - Running post-action listener: _resource_record_post_action 16:17:12 INFO - [mozharness: 2017-05-19 23:17:12.760558Z] Finished run-tests step (success) 16:17:12 INFO - Running post-run listener: _resource_record_post_run 16:17:12 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 417742848; Read time: 16; Write time: 345384 16:17:12 INFO - TinderboxPrint: CPU usage
13.3% 16:17:12 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 16:17:12 INFO - TinderboxPrint: I/O write bytes / time
417,742,848 / 345,384 16:17:12 INFO - TinderboxPrint: CPU idle
8,292.3 (86.7%) 16:17:12 INFO - TinderboxPrint: CPU user
1,218.8 (12.7%) 16:17:12 INFO - TinderboxPrint: Swap in / out
0 / 0 16:17:12 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 24051712; Read time: 0; Write time: 3932 16:17:12 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 318066688; Read time: 0; Write time: 239316 16:17:13 INFO - Running post-run listener: _upload_blobber_files 16:17:13 INFO - Blob upload gear active. 16:17:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:17:13 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 16:17:13 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'] 16:17:13 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 16:17:13 INFO - (blobuploader) - INFO - Open directory for files ... 16:17:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:17:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:17:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:17:14 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:17:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:17:14 INFO - (blobuploader) - INFO - Done attempting. 16:17:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:17:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:17:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:17:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:17:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:17:15 INFO - (blobuploader) - INFO - Done attempting. 16:17:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:17:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:17:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:17:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:17:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:17:18 INFO - (blobuploader) - INFO - Done attempting. 16:17:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:17:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:17:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:17:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:17:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:17:21 INFO - (blobuploader) - INFO - Done attempting. 16:17:21 INFO - (blobuploader) - INFO - Iteration through files over. 16:17:21 INFO - Return code: 0 16:17:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:17:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:17:21 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64cbfd5287f0bc8b0b62ab467a462c2b46bf1adbfa01b90fcca91b580fafd77b97ca7fa16cee296ccd88de5a2602495d499c30f20fa5709ced7b4f50ca201e9e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/389d11c95c751c4a1b485c75afb111fb47bee8337ef67bb145786f8a6a7490f4f4f0f3fee4088f8be251ff8719a6f273d0514f571f71f18a03b0737d3c6f5945", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a54c3cd2304aaa05ea945d531ade5eaf1924c591929d8d0667ec742013872ff10e4827c9cb45f0961784963def00990f758d5d73c95911508c58063293d221b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f02fd4e01ba0afe09d2ca9fe2fc9ec567d79cb3f796ce5151514fd4fe60dd6fdd2a169ef2e0e78a1e85c374a2932376a738805e53056d187ce09b826da94221"} 16:17:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:17:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:17:21 INFO - Contents: 16:17:21 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64cbfd5287f0bc8b0b62ab467a462c2b46bf1adbfa01b90fcca91b580fafd77b97ca7fa16cee296ccd88de5a2602495d499c30f20fa5709ced7b4f50ca201e9e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/389d11c95c751c4a1b485c75afb111fb47bee8337ef67bb145786f8a6a7490f4f4f0f3fee4088f8be251ff8719a6f273d0514f571f71f18a03b0737d3c6f5945", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a54c3cd2304aaa05ea945d531ade5eaf1924c591929d8d0667ec742013872ff10e4827c9cb45f0961784963def00990f758d5d73c95911508c58063293d221b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f02fd4e01ba0afe09d2ca9fe2fc9ec567d79cb3f796ce5151514fd4fe60dd6fdd2a169ef2e0e78a1e85c374a2932376a738805e53056d187ce09b826da94221"} 16:17:21 INFO - Running post-run listener: copy_logs_to_upload_dir 16:17:21 INFO - Copying logs to upload dir... 16:17:21 INFO - mkdir: /builds/slave/test/build/upload/logs 16:17:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.780776 ========= master_lag: 0.20 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-05-19 16:17:19.676641) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-19 16:17:19.680951) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1495231765.859750-2097675444 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/64cbfd5287f0bc8b0b62ab467a462c2b46bf1adbfa01b90fcca91b580fafd77b97ca7fa16cee296ccd88de5a2602495d499c30f20fa5709ced7b4f50ca201e9e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/389d11c95c751c4a1b485c75afb111fb47bee8337ef67bb145786f8a6a7490f4f4f0f3fee4088f8be251ff8719a6f273d0514f571f71f18a03b0737d3c6f5945", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a54c3cd2304aaa05ea945d531ade5eaf1924c591929d8d0667ec742013872ff10e4827c9cb45f0961784963def00990f758d5d73c95911508c58063293d221b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f02fd4e01ba0afe09d2ca9fe2fc9ec567d79cb3f796ce5151514fd4fe60dd6fdd2a169ef2e0e78a1e85c374a2932376a738805e53056d187ce09b826da94221"} build_url:https://queue.taskcluster.net/v1/task/VxRF-SilS6eKtL-GPfrkug/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011215 build_url: 'https://queue.taskcluster.net/v1/task/VxRF-SilS6eKtL-GPfrkug/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64cbfd5287f0bc8b0b62ab467a462c2b46bf1adbfa01b90fcca91b580fafd77b97ca7fa16cee296ccd88de5a2602495d499c30f20fa5709ced7b4f50ca201e9e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/389d11c95c751c4a1b485c75afb111fb47bee8337ef67bb145786f8a6a7490f4f4f0f3fee4088f8be251ff8719a6f273d0514f571f71f18a03b0737d3c6f5945", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a54c3cd2304aaa05ea945d531ade5eaf1924c591929d8d0667ec742013872ff10e4827c9cb45f0961784963def00990f758d5d73c95911508c58063293d221b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f02fd4e01ba0afe09d2ca9fe2fc9ec567d79cb3f796ce5151514fd4fe60dd6fdd2a169ef2e0e78a1e85c374a2932376a738805e53056d187ce09b826da94221"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-19 16:17:19.704279) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 16:17:19.704576) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1495231765.859750-2097675444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 16:17:19.790034) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-19 16:17:19.790315) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-19 16:17:19.791608) ========= ========= Total master_lag: 0.36 =========