builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-040 starttime: 1487823688.4 results: success (0) revision: c7b015c488cfb2afbcff295a9639acd85df332f8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-22 20:21:28.395710) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-22 20:21:28.398487) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-22 20:21:28.398776) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-22 20:21:28.437916) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 20:21:28.438217) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1487821811.660450-639367694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-22 20:21:28-- 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% 46.1M=0s 2017-02-22 20:21:28 (46.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128304 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 20:21:28.584774) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 20:21:28.585498) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1487821811.660450-639367694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018234 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 20:21:28.635920) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 20:21:28.636212) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c7b015c488cfb2afbcff295a9639acd85df332f8 --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 c7b015c488cfb2afbcff295a9639acd85df332f8 --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=9e0dfe3369c33a1556e63f89000001d8-1487821811.660450-639367694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-22 20:21:29,025 truncating revision to first 12 chars 2017-02-22 20:21:29,025 Setting DEBUG logging. 2017-02-22 20:21:29,025 attempt 1/10 2017-02-22 20:21:29,025 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c7b015c488cf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-22 20:21:29,552 unpacking tar archive at: mozilla-central-c7b015c488cf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.822258 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 20:21:29.471191) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-22 20:21:29.471499) ========= script_repo_revision: c7b015c488cfb2afbcff295a9639acd85df332f8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-22 20:21:29.471933) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-22 20:21:29.472239) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-22 20:21:29.487066) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-02-22 20:21:29.487379) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9e0dfe3369c33a1556e63f89000001d8-1487821811.660450-639367694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:21:29 INFO - MultiFileLogger online at 20170222 20:21:29 in /builds/slave/test 20:21:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 20:21:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:21:29 INFO - {'append_to_log': False, 20:21:29 INFO - 'base_work_dir': '/builds/slave/test', 20:21:29 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 20:21:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:21:29 INFO - 'branch': 'Firefox-Non-PGO', 20:21:29 INFO - 'buildbot_json_path': 'buildprops.json', 20:21:29 INFO - 'config_files': ('talos/linux_config.py',), 20:21:29 INFO - 'default_actions': ('clobber', 20:21:29 INFO - 'read-buildbot-config', 20:21:29 INFO - 'download-and-extract', 20:21:29 INFO - 'populate-webroot', 20:21:29 INFO - 'create-virtualenv', 20:21:29 INFO - 'install', 20:21:29 INFO - 'run-tests'), 20:21:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:21:29 INFO - 'download_minidump_stackwalk': True, 20:21:29 INFO - 'download_symbols': 'ondemand', 20:21:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:21:29 INFO - 'tooltool.py': '/tools/tooltool.py', 20:21:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:21:29 INFO - '/tools/misc-python/virtualenv.py')}, 20:21:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:21:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:21:29 INFO - 'gecko_profile': False, 20:21:29 INFO - 'gecko_profile_interval': 0, 20:21:29 INFO - 'installer_path': 'installer.exe', 20:21:29 INFO - 'log_level': 'info', 20:21:29 INFO - 'log_name': 'talos', 20:21:29 INFO - 'log_to_console': True, 20:21:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:21:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:21:29 INFO - 'opt_config_files': (), 20:21:29 INFO - 'pip_index': False, 20:21:29 INFO - 'suite': 'dromaeojs-e10s', 20:21:29 INFO - 'system_bits': '32', 20:21:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:21:29 INFO - 'title': 'talos-linux64-ix-040', 20:21:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:21:29 INFO - 'use_talos_json': True, 20:21:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:21:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:21:29 INFO - 'work_dir': 'build'} 20:21:29 INFO - [mozharness: 2017-02-23 04:21:29.977276Z] Running clobber step. 20:21:29 INFO - Running pre-action listener: _resource_record_pre_action 20:21:29 INFO - Running main action method: clobber 20:21:29 INFO - rmtree: /builds/slave/test/build 20:21:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:21:31 INFO - Running post-action listener: _resource_record_post_action 20:21:31 INFO - [mozharness: 2017-02-23 04:21:31.416522Z] Finished clobber step (success) 20:21:31 INFO - [mozharness: 2017-02-23 04:21:31.416622Z] Running read-buildbot-config step. 20:21:31 INFO - Running pre-action listener: _resource_record_pre_action 20:21:31 INFO - Running main action method: read_buildbot_config 20:21:31 INFO - Using buildbot properties: 20:21:31 INFO - { 20:21:31 INFO - "project": "", 20:21:31 INFO - "product": "firefox", 20:21:31 INFO - "who": "kwierso@gmail.com", 20:21:31 INFO - "installer_path": "public/build/target.tar.bz2", 20:21:31 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 20:21:31 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 20:21:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 20:21:31 INFO - "stage_platform": "linux64", 20:21:31 INFO - "basedir": "/builds/slave/test", 20:21:31 INFO - "buildnumber": 717, 20:21:31 INFO - "platform": "ubuntu64_hw", 20:21:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:21:31 INFO - "slavebuilddir": "test", 20:21:31 INFO - "taskId": "GrqYadKmTFeg40rrWXdsDg", 20:21:31 INFO - "branch": "mozilla-central", 20:21:31 INFO - "script_repo_revision": "production", 20:21:31 INFO - "revision": "c7b015c488cfb2afbcff295a9639acd85df332f8", 20:21:31 INFO - "slavename": "talos-linux64-ix-040", 20:21:31 INFO - "repo_path": "mozilla-central" 20:21:31 INFO - } 20:21:31 INFO - Finding installer, test and symbols from parent task. 20:21:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GrqYadKmTFeg40rrWXdsDg'}, attempt #1 20:21:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GrqYadKmTFeg40rrWXdsDg'}, attempt #1 20:21:32 INFO - Task dependencies: fziZoBLZQf6J64GfmjMy5g 20:21:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fziZoBLZQf6J64GfmjMy5g'}, attempt #1 20:21:32 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/fziZoBLZQf6J64GfmjMy5g/artifacts/public/build/target.tar.bz2 20:21:32 INFO - Set test_url: https://queue.taskcluster.net/v1/task/fziZoBLZQf6J64GfmjMy5g/artifacts/public/build/test_packages.json 20:21:32 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/fziZoBLZQf6J64GfmjMy5g/artifacts/public/build/target.crashreporter-symbols.zip 20:21:32 INFO - Running post-action listener: _resource_record_post_action 20:21:32 INFO - [mozharness: 2017-02-23 04:21:32.872149Z] Finished read-buildbot-config step (success) 20:21:32 INFO - [mozharness: 2017-02-23 04:21:32.872367Z] Running download-and-extract step. 20:21:32 INFO - Running pre-action listener: _resource_record_pre_action 20:21:32 INFO - Running main action method: download_and_extract 20:21:32 INFO - mkdir: /builds/slave/test/build/tests 20:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 20:21:32 INFO - trying https://queue.taskcluster.net/v1/task/fziZoBLZQf6J64GfmjMy5g/artifacts/public/build/target.test_packages.json 20:21:32 INFO - Downloading https://queue.taskcluster.net/v1/task/fziZoBLZQf6J64GfmjMy5g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 20:21:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fziZoBLZQf6J64GfmjMy5g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 20:21:33 INFO - Downloaded 896 bytes. 20:21:33 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 20:21:33 INFO - Using the following test package requirements: 20:21:33 INFO - {u'common': [u'target.common.tests.zip'], 20:21:33 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 20:21:33 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 20:21:33 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 20:21:33 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 20:21:33 INFO - u'mozbase': [u'target.common.tests.zip'], 20:21:33 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 20:21:33 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 20:21:33 INFO - u'web-platform': [u'target.common.tests.zip', 20:21:33 INFO - u'target.web-platform.tests.zip'], 20:21:33 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 20:21:33 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 20:21:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fziZoBLZQf6J64GfmjMy5g/artifacts/public/build/target.common.tests.zip 20:21:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fziZoBLZQf6J64GfmjMy5g/artifacts/public/build/target.common.tests.zip'}, attempt #1 20:21:33 INFO - Fetch https://queue.taskcluster.net/v1/task/fziZoBLZQf6J64GfmjMy5g/artifacts/public/build/target.common.tests.zip into memory 20:21:37 INFO - Expected file size: 57165889 20:21:37 INFO - Obtained file size: 57165889 20:21:46 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 20:21:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fziZoBLZQf6J64GfmjMy5g/artifacts/public/build/target.common.tests.zip 20:21:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fziZoBLZQf6J64GfmjMy5g/artifacts/public/build/target.common.tests.zip'}, attempt #1 20:21:46 INFO - Fetch https://queue.taskcluster.net/v1/task/fziZoBLZQf6J64GfmjMy5g/artifacts/public/build/target.common.tests.zip into memory 20:21:49 INFO - Expected file size: 57165889 20:21:49 INFO - Obtained file size: 57165889 20:21:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fziZoBLZQf6J64GfmjMy5g/artifacts/public/build/target.talos.tests.zip 20:21:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fziZoBLZQf6J64GfmjMy5g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 20:21:59 INFO - Fetch https://queue.taskcluster.net/v1/task/fziZoBLZQf6J64GfmjMy5g/artifacts/public/build/target.talos.tests.zip into memory 20:22:00 INFO - Expected file size: 14404319 20:22:00 INFO - Obtained file size: 14404319 20:22:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 20:22:00 INFO - trying https://queue.taskcluster.net/v1/task/fziZoBLZQf6J64GfmjMy5g/artifacts/public/build/target.tar.bz2 20:22:00 INFO - Downloading https://queue.taskcluster.net/v1/task/fziZoBLZQf6J64GfmjMy5g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 20:22:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fziZoBLZQf6J64GfmjMy5g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 20:22:03 INFO - Downloaded 61547669 bytes. 20:22:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fziZoBLZQf6J64GfmjMy5g/artifacts/public/build/target.tar.bz2 20:22:03 INFO - mkdir: /builds/slave/test/properties 20:22:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:22:03 INFO - Writing to file /builds/slave/test/properties/build_url 20:22:03 INFO - Contents: 20:22:03 INFO - build_url:https://queue.taskcluster.net/v1/task/fziZoBLZQf6J64GfmjMy5g/artifacts/public/build/target.tar.bz2 20:22:03 INFO - Running post-action listener: _resource_record_post_action 20:22:03 INFO - Running post-action listener: set_extra_try_arguments 20:22:03 INFO - [mozharness: 2017-02-23 04:22:03.736545Z] Finished download-and-extract step (success) 20:22:03 INFO - [mozharness: 2017-02-23 04:22:03.736894Z] Running populate-webroot step. 20:22:03 INFO - Running pre-action listener: _resource_record_pre_action 20:22:03 INFO - Running main action method: populate_webroot 20:22:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:22:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:22:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:22:03 INFO - '--tppagecycles', 20:22:03 INFO - '7'], 20:22:03 INFO - 'tests': ['tsvgm']}}, 20:22:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:22:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:22:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:22:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:22:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:22:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:22:03 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 20:22:03 INFO - 'talos_options': ['--disable-e10s'], 20:22:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:22:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:22:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:22:03 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 20:22:03 INFO - 'talos_options': ['--disable-e10s'], 20:22:03 INFO - 'tests': ['damp', 'tps']}, 20:22:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:22:03 INFO - 'tests': ['damp', 'tps']}, 20:22:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:22:03 INFO - 'tests': ['dromaeo_dom']}, 20:22:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:22:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:22:03 INFO - 'tests': ['basic_compositor_video']}, 20:22:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:22:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:22:03 INFO - 'tests': ['a11yr', 20:22:03 INFO - 'ts_paint', 20:22:03 INFO - 'tpaint', 20:22:03 INFO - 'sessionrestore', 20:22:03 INFO - 'sessionrestore_no_auto_restore', 20:22:03 INFO - 'tabpaint']}, 20:22:03 INFO - 'other-e10s': {'tests': ['a11yr', 20:22:03 INFO - 'ts_paint', 20:22:03 INFO - 'tpaint', 20:22:03 INFO - 'sessionrestore', 20:22:03 INFO - 'sessionrestore_no_auto_restore', 20:22:03 INFO - 'tabpaint']}, 20:22:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:22:03 INFO - 'ts_paint', 20:22:03 INFO - 'tpaint', 20:22:03 INFO - 'sessionrestore', 20:22:03 INFO - 'sessionrestore_no_auto_restore', 20:22:03 INFO - 'tabpaint']}, 20:22:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:22:03 INFO - 'ts_paint', 20:22:03 INFO - 'tpaint', 20:22:03 INFO - 'sessionrestore', 20:22:03 INFO - 'sessionrestore_no_auto_restore', 20:22:03 INFO - 'tabpaint']}, 20:22:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:22:03 INFO - 'tests': ['a11yr', 20:22:03 INFO - 'ts_paint', 20:22:03 INFO - 'tpaint', 20:22:03 INFO - 'sessionrestore', 20:22:03 INFO - 'sessionrestore_no_auto_restore', 20:22:03 INFO - 'tabpaint']}, 20:22:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:22:03 INFO - 'tests': ['a11yr', 20:22:03 INFO - 'ts_paint', 20:22:03 INFO - 'tpaint', 20:22:03 INFO - 'sessionrestore', 20:22:03 INFO - 'sessionrestore_no_auto_restore', 20:22:03 INFO - 'tabpaint']}, 20:22:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:22:03 INFO - 'tests': ['tsvgx', 20:22:03 INFO - 'tsvgr_opacity', 20:22:03 INFO - 'tart', 20:22:03 INFO - 'tscrollx', 20:22:03 INFO - 'cart', 20:22:03 INFO - 'tsvg_static']}, 20:22:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:22:03 INFO - 'tsvgr_opacity', 20:22:03 INFO - 'tart', 20:22:03 INFO - 'tscrollx', 20:22:03 INFO - 'cart', 20:22:03 INFO - 'tsvg_static']}, 20:22:03 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 20:22:03 INFO - 'talos_options': ['--disable-e10s'], 20:22:03 INFO - 'tests': ['tp5o']}, 20:22:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:22:03 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 20:22:03 INFO - 'talos_options': ['--disable-e10s', 20:22:03 INFO - '--xperf_path', 20:22:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:22:03 INFO - 'tests': ['tp5n']}, 20:22:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:22:03 INFO - 'talos_options': ['--xperf_path', 20:22:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:22:03 INFO - 'tests': ['tp5n']}}, 20:22:03 INFO - 'talos.zip': {'path': '', 20:22:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:22:03 INFO - Running post-action listener: _resource_record_post_action 20:22:03 INFO - [mozharness: 2017-02-23 04:22:03.767335Z] Finished populate-webroot step (success) 20:22:03 INFO - [mozharness: 2017-02-23 04:22:03.767426Z] Running create-virtualenv step. 20:22:03 INFO - Running pre-action listener: _resource_record_pre_action 20:22:03 INFO - Running main action method: create_virtualenv 20:22:03 INFO - Creating virtualenv /builds/slave/test/build/venv 20:22:03 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 20:22:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:22:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:22:03 INFO - Using real prefix '/usr' 20:22:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:22:04 INFO - Installing distribute.............................................................................................................................................................................................done. 20:22:06 INFO - Installing pip.................done. 20:22:06 INFO - Return code: 0 20:22:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:22:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:22:06 INFO - Reading from file tmpfile_stdout 20:22:06 INFO - Output received: 20:22:06 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) 20:22:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:22:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 20:22:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 20:22:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x29df1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7a290>, '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 0x2c7ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7b040>, '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': '9e0dfe3369c33a1556e63f89000001d8-1487821811.660450-639367694', '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 20:22:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 20:22:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:22:06 INFO - Using env: {'DISPLAY': ':0', 20:22:06 INFO - 'HOME': '/home/cltbld', 20:22:06 INFO - 'LANG': 'en_US.UTF-8', 20:22:06 INFO - 'LANGUAGE': 'en_US:en', 20:22:06 INFO - 'LOGNAME': 'cltbld', 20:22:06 INFO - 'MAIL': '/var/mail/cltbld', 20:22:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:06 INFO - 'MOZ_NO_REMOTE': '1', 20:22:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:06 INFO - 'NO_EM_RESTART': '1', 20:22:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:06 INFO - 'PWD': '/builds/slave/test', 20:22:06 INFO - 'SHELL': '/bin/bash', 20:22:06 INFO - 'SHLVL': '1', 20:22:06 INFO - 'TERM': 'linux', 20:22:06 INFO - 'TMOUT': '86400', 20:22:06 INFO - 'USER': 'cltbld', 20:22:06 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1487821811.660450-639367694', 20:22:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:06 INFO - '_': '/tools/buildbot/bin/python'} 20:22:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:06 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 20:22:06 INFO - Cleaning up... 20:22:06 INFO - Return code: 0 20:22:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:22:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 20:22:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 20:22:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x29df1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7a290>, '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 0x2c7ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7b040>, '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': '9e0dfe3369c33a1556e63f89000001d8-1487821811.660450-639367694', '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 20:22:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 20:22:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:22:06 INFO - Using env: {'DISPLAY': ':0', 20:22:06 INFO - 'HOME': '/home/cltbld', 20:22:06 INFO - 'LANG': 'en_US.UTF-8', 20:22:06 INFO - 'LANGUAGE': 'en_US:en', 20:22:06 INFO - 'LOGNAME': 'cltbld', 20:22:06 INFO - 'MAIL': '/var/mail/cltbld', 20:22:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:06 INFO - 'MOZ_NO_REMOTE': '1', 20:22:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:06 INFO - 'NO_EM_RESTART': '1', 20:22:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:06 INFO - 'PWD': '/builds/slave/test', 20:22:06 INFO - 'SHELL': '/bin/bash', 20:22:06 INFO - 'SHLVL': '1', 20:22:06 INFO - 'TERM': 'linux', 20:22:06 INFO - 'TMOUT': '86400', 20:22:06 INFO - 'USER': 'cltbld', 20:22:06 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1487821811.660450-639367694', 20:22:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:06 INFO - '_': '/tools/buildbot/bin/python'} 20:22:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:07 INFO - Downloading/unpacking psutil>=3.1.1 20:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:22:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:22:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:22:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:22:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:22:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:22:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:22:09 INFO - Installing collected packages: psutil 20:22:09 INFO - Running setup.py install for psutil 20:22:09 INFO - building 'psutil._psutil_linux' extension 20:22:09 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 20:22:09 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 20:22:09 INFO - building 'psutil._psutil_posix' extension 20:22:09 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 20:22:09 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 20:22:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:22:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:22:09 INFO - Successfully installed psutil 20:22:09 INFO - Cleaning up... 20:22:09 INFO - Return code: 0 20:22:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 20:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 20:22:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:09 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x29df1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7a290>, '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 0x2c7ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7b040>, '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': '9e0dfe3369c33a1556e63f89000001d8-1487821811.660450-639367694', '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 20:22:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 20:22:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:22:09 INFO - Using env: {'DISPLAY': ':0', 20:22:09 INFO - 'HOME': '/home/cltbld', 20:22:09 INFO - 'LANG': 'en_US.UTF-8', 20:22:09 INFO - 'LANGUAGE': 'en_US:en', 20:22:09 INFO - 'LOGNAME': 'cltbld', 20:22:09 INFO - 'MAIL': '/var/mail/cltbld', 20:22:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:09 INFO - 'MOZ_NO_REMOTE': '1', 20:22:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:09 INFO - 'NO_EM_RESTART': '1', 20:22:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:09 INFO - 'PWD': '/builds/slave/test', 20:22:09 INFO - 'SHELL': '/bin/bash', 20:22:09 INFO - 'SHLVL': '1', 20:22:09 INFO - 'TERM': 'linux', 20:22:09 INFO - 'TMOUT': '86400', 20:22:09 INFO - 'USER': 'cltbld', 20:22:09 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1487821811.660450-639367694', 20:22:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:09 INFO - '_': '/tools/buildbot/bin/python'} 20:22:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:22:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:22:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:22:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:22:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:22:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:22:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:22:12 INFO - Installing collected packages: mozsystemmonitor 20:22:12 INFO - Running setup.py install for mozsystemmonitor 20:22:12 INFO - Successfully installed mozsystemmonitor 20:22:12 INFO - Cleaning up... 20:22:12 INFO - Return code: 0 20:22:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:22:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 20:22:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 20:22:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22: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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x29df1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7a290>, '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 0x2c7ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7b040>, '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': '9e0dfe3369c33a1556e63f89000001d8-1487821811.660450-639367694', '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 20:22:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 20:22:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:22:12 INFO - Using env: {'DISPLAY': ':0', 20:22:12 INFO - 'HOME': '/home/cltbld', 20:22:12 INFO - 'LANG': 'en_US.UTF-8', 20:22:12 INFO - 'LANGUAGE': 'en_US:en', 20:22:12 INFO - 'LOGNAME': 'cltbld', 20:22:12 INFO - 'MAIL': '/var/mail/cltbld', 20:22:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:12 INFO - 'MOZ_NO_REMOTE': '1', 20:22:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:12 INFO - 'NO_EM_RESTART': '1', 20:22:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:12 INFO - 'PWD': '/builds/slave/test', 20:22:12 INFO - 'SHELL': '/bin/bash', 20:22:12 INFO - 'SHLVL': '1', 20:22:12 INFO - 'TERM': 'linux', 20:22:12 INFO - 'TMOUT': '86400', 20:22:12 INFO - 'USER': 'cltbld', 20:22:12 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1487821811.660450-639367694', 20:22:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:12 INFO - '_': '/tools/buildbot/bin/python'} 20:22:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:12 INFO - Downloading/unpacking jsonschema==2.5.1 20:22:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:22:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:22:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:22:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:22:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:22:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:22:14 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 20:22:14 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 20:22:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:14 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 20:22:14 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 20:22:14 INFO - Downloading functools32-3.2.3-2.tar.gz 20:22:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:22:14 INFO - warning: no files found matching '*.txt' 20:22:14 INFO - no previously-included directories found matching 'build' 20:22:14 INFO - no previously-included directories found matching 'dist' 20:22:14 INFO - no previously-included directories found matching '.git*' 20:22:14 INFO - Installing collected packages: jsonschema, functools32 20:22:14 INFO - Running setup.py install for functools32 20:22:14 INFO - warning: no files found matching '*.txt' 20:22:14 INFO - no previously-included directories found matching 'build' 20:22:14 INFO - no previously-included directories found matching 'dist' 20:22:14 INFO - no previously-included directories found matching '.git*' 20:22:14 INFO - Successfully installed jsonschema functools32 20:22:14 INFO - Cleaning up... 20:22:14 INFO - Return code: 0 20:22:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:22:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 20:22:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 20:22:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:14 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x29df1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7a290>, '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 0x2c7ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7b040>, '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': '9e0dfe3369c33a1556e63f89000001d8-1487821811.660450-639367694', '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 20:22:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 20:22:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:22:14 INFO - Using env: {'DISPLAY': ':0', 20:22:14 INFO - 'HOME': '/home/cltbld', 20:22:14 INFO - 'LANG': 'en_US.UTF-8', 20:22:14 INFO - 'LANGUAGE': 'en_US:en', 20:22:14 INFO - 'LOGNAME': 'cltbld', 20:22:14 INFO - 'MAIL': '/var/mail/cltbld', 20:22:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:14 INFO - 'MOZ_NO_REMOTE': '1', 20:22:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:14 INFO - 'NO_EM_RESTART': '1', 20:22:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:14 INFO - 'PWD': '/builds/slave/test', 20:22:14 INFO - 'SHELL': '/bin/bash', 20:22:14 INFO - 'SHLVL': '1', 20:22:14 INFO - 'TERM': 'linux', 20:22:14 INFO - 'TMOUT': '86400', 20:22:14 INFO - 'USER': 'cltbld', 20:22:14 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1487821811.660450-639367694', 20:22:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:14 INFO - '_': '/tools/buildbot/bin/python'} 20:22:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:22:15 INFO - Cleaning up... 20:22:15 INFO - Return code: 0 20:22:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:22:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 20:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 20:22:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:15 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x29df1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7a290>, '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 0x2c7ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7b040>, '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': '9e0dfe3369c33a1556e63f89000001d8-1487821811.660450-639367694', '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 20:22:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 20:22:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:22:15 INFO - Using env: {'DISPLAY': ':0', 20:22:15 INFO - 'HOME': '/home/cltbld', 20:22:15 INFO - 'LANG': 'en_US.UTF-8', 20:22:15 INFO - 'LANGUAGE': 'en_US:en', 20:22:15 INFO - 'LOGNAME': 'cltbld', 20:22:15 INFO - 'MAIL': '/var/mail/cltbld', 20:22:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:15 INFO - 'MOZ_NO_REMOTE': '1', 20:22:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:15 INFO - 'NO_EM_RESTART': '1', 20:22:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:15 INFO - 'PWD': '/builds/slave/test', 20:22:15 INFO - 'SHELL': '/bin/bash', 20:22:15 INFO - 'SHLVL': '1', 20:22:15 INFO - 'TERM': 'linux', 20:22:15 INFO - 'TMOUT': '86400', 20:22:15 INFO - 'USER': 'cltbld', 20:22:15 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1487821811.660450-639367694', 20:22:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:15 INFO - '_': '/tools/buildbot/bin/python'} 20:22:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:15 INFO - Downloading/unpacking blobuploader==1.2.4 20:22:15 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 20:22:15 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 20:22:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:15 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 20:22:15 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 20:22:17 INFO - Downloading blobuploader-1.2.4.tar.gz 20:22:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:22:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:22:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:22:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:22:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:22:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:22:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:22:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:22:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:22:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:22:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:22:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:22:18 INFO - Downloading docopt-0.6.1.tar.gz 20:22:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:22:18 INFO - Installing collected packages: blobuploader, requests, docopt 20:22:18 INFO - Running setup.py install for blobuploader 20:22:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:22:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:22:18 INFO - Running setup.py install for requests 20:22:18 INFO - Running setup.py install for docopt 20:22:18 INFO - Successfully installed blobuploader requests docopt 20:22:18 INFO - Cleaning up... 20:22:18 INFO - Return code: 0 20:22:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:22:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 20:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 20:22:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:18 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x29df1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7a290>, '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 0x2c7ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7b040>, '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': '9e0dfe3369c33a1556e63f89000001d8-1487821811.660450-639367694', '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 20:22:18 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 20:22:18 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:22:18 INFO - Using env: {'DISPLAY': ':0', 20:22:18 INFO - 'HOME': '/home/cltbld', 20:22:18 INFO - 'LANG': 'en_US.UTF-8', 20:22:18 INFO - 'LANGUAGE': 'en_US:en', 20:22:18 INFO - 'LOGNAME': 'cltbld', 20:22:18 INFO - 'MAIL': '/var/mail/cltbld', 20:22:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:18 INFO - 'MOZ_NO_REMOTE': '1', 20:22:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:18 INFO - 'NO_EM_RESTART': '1', 20:22:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:18 INFO - 'PWD': '/builds/slave/test', 20:22:18 INFO - 'SHELL': '/bin/bash', 20:22:18 INFO - 'SHLVL': '1', 20:22:18 INFO - 'TERM': 'linux', 20:22:18 INFO - 'TMOUT': '86400', 20:22:18 INFO - 'USER': 'cltbld', 20:22:18 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1487821811.660450-639367694', 20:22:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:18 INFO - '_': '/tools/buildbot/bin/python'} 20:22:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:22:18 INFO - Running setup.py (path:/tmp/pip-fnHSK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:22:18 INFO - Running setup.py (path:/tmp/pip-OP3ZXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:22:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:22:19 INFO - Running setup.py (path:/tmp/pip-y_Igpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:22:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:22:19 INFO - Running setup.py (path:/tmp/pip-HDjzO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:22:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:22:19 INFO - Running setup.py (path:/tmp/pip-7LSDom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:22:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:22:19 INFO - Running setup.py (path:/tmp/pip-stXuLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:22:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:22:19 INFO - Running setup.py (path:/tmp/pip-Zv1D0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:22:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:22:19 INFO - Running setup.py (path:/tmp/pip-b2bJq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:22:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:22:19 INFO - Running setup.py (path:/tmp/pip-yYD_pD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:22:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:22:19 INFO - Running setup.py (path:/tmp/pip-_KHPvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:22:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:22:19 INFO - Running setup.py (path:/tmp/pip-lO4JpJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:22:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:22:19 INFO - Running setup.py (path:/tmp/pip-AfFrRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:22:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:22:19 INFO - Running setup.py (path:/tmp/pip-FmTayl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:22:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:22:19 INFO - Running setup.py (path:/tmp/pip-KLHIxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:22:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:22:19 INFO - Running setup.py (path:/tmp/pip-FDpTH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:22:20 INFO - Running setup.py (path:/tmp/pip-be2W26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:22:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:22:20 INFO - Running setup.py (path:/tmp/pip-LawA9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:22:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:22:20 INFO - Running setup.py install for manifestparser 20:22:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:22:20 INFO - Running setup.py install for mozcrash 20:22:20 INFO - Running setup.py install for mozdebug 20:22:20 INFO - Running setup.py install for mozdevice 20:22:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:22:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:22:20 INFO - Running setup.py install for mozfile 20:22:20 INFO - Running setup.py install for mozhttpd 20:22:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:22:20 INFO - Running setup.py install for mozinfo 20:22:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:22:20 INFO - Running setup.py install for mozInstall 20:22:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:22:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:22:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:22:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:22:20 INFO - Running setup.py install for mozleak 20:22:21 INFO - Running setup.py install for mozlog 20:22:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:22:21 INFO - Running setup.py install for moznetwork 20:22:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:22:21 INFO - Running setup.py install for mozprocess 20:22:21 INFO - Running setup.py install for mozprofile 20:22:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:22:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:22:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:22:21 INFO - Running setup.py install for mozrunner 20:22:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:22:21 INFO - Running setup.py install for mozscreenshot 20:22:21 INFO - Running setup.py install for moztest 20:22:21 INFO - Running setup.py install for mozversion 20:22:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:22:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:22:21 INFO - Cleaning up... 20:22:21 INFO - Return code: 0 20:22:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:22:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 20:22:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 20:22:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:22 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x29df1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7a290>, '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 0x2c7ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7b040>, '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': '9e0dfe3369c33a1556e63f89000001d8-1487821811.660450-639367694', '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 20:22:22 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 20:22:22 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:22:22 INFO - Using env: {'DISPLAY': ':0', 20:22:22 INFO - 'HOME': '/home/cltbld', 20:22:22 INFO - 'LANG': 'en_US.UTF-8', 20:22:22 INFO - 'LANGUAGE': 'en_US:en', 20:22:22 INFO - 'LOGNAME': 'cltbld', 20:22:22 INFO - 'MAIL': '/var/mail/cltbld', 20:22:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:22 INFO - 'MOZ_NO_REMOTE': '1', 20:22:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:22 INFO - 'NO_EM_RESTART': '1', 20:22:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:22 INFO - 'PWD': '/builds/slave/test', 20:22:22 INFO - 'SHELL': '/bin/bash', 20:22:22 INFO - 'SHLVL': '1', 20:22:22 INFO - 'TERM': 'linux', 20:22:22 INFO - 'TMOUT': '86400', 20:22:22 INFO - 'USER': 'cltbld', 20:22:22 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1487821811.660450-639367694', 20:22:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:22 INFO - '_': '/tools/buildbot/bin/python'} 20:22:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:22:22 INFO - Running setup.py (path:/tmp/pip-SPlZ9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:22:22 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)) 20:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:22:22 INFO - Running setup.py (path:/tmp/pip-okC602-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:22:22 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)) 20:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:22:22 INFO - Running setup.py (path:/tmp/pip-G4aJqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:22:22 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)) 20:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:22:22 INFO - Running setup.py (path:/tmp/pip-yz2CU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:22:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:22:22 INFO - Running setup.py (path:/tmp/pip-4W9oYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:22:22 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)) 20:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:22:22 INFO - Running setup.py (path:/tmp/pip-FNgfSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:22:22 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)) 20:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:22:22 INFO - Running setup.py (path:/tmp/pip-kIPWAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:22:22 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)) 20:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:22:22 INFO - Running setup.py (path:/tmp/pip-oyxNPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:22:22 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)) 20:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:22:22 INFO - Running setup.py (path:/tmp/pip-vcQ7rj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:22:22 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)) 20:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:22:22 INFO - Running setup.py (path:/tmp/pip-jNA0QF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:22:22 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)) 20:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:22:22 INFO - Running setup.py (path:/tmp/pip-DnSlnp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:22:23 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)) 20:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:22:23 INFO - Running setup.py (path:/tmp/pip-BrzMPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:22:23 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)) 20:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:22:23 INFO - Running setup.py (path:/tmp/pip-jqNbbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:22:23 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)) 20:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:22:23 INFO - Running setup.py (path:/tmp/pip-Tg_AnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:22:23 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)) 20:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:22:23 INFO - Running setup.py (path:/tmp/pip-8wUZ6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:22:23 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)) 20:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:22:23 INFO - Running setup.py (path:/tmp/pip-RTJfBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:22:23 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)) 20:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:22:23 INFO - Running setup.py (path:/tmp/pip-HCcczC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:22:23 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)) 20:22:23 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)) 20:22:23 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)) 20:22:23 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)) 20:22:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:22:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:22:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:22:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:22:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:22:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:22:25 INFO - Downloading blessings-1.6.tar.gz 20:22:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:22:25 INFO - Installing collected packages: blessings 20:22:25 INFO - Running setup.py install for blessings 20:22:25 INFO - Successfully installed blessings 20:22:25 INFO - Cleaning up... 20:22:25 INFO - Return code: 0 20:22:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:22:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:22:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:22:25 INFO - Reading from file tmpfile_stdout 20:22:25 INFO - Current package versions: 20:22:25 INFO - argparse == 1.2.1 20:22:25 INFO - blessings == 1.6 20:22:25 INFO - blobuploader == 1.2.4 20:22:25 INFO - docopt == 0.6.1 20:22:25 INFO - functools32 == 3.2.3-2 20:22:25 INFO - jsonschema == 2.5.1 20:22:25 INFO - manifestparser == 1.1 20:22:25 INFO - mozInstall == 1.12 20:22:25 INFO - mozcrash == 1.0 20:22:25 INFO - mozdebug == 0.1 20:22:25 INFO - mozdevice == 0.49 20:22:25 INFO - mozfile == 1.2 20:22:25 INFO - mozhttpd == 0.7 20:22:25 INFO - mozinfo == 0.9 20:22:25 INFO - mozleak == 0.1 20:22:25 INFO - mozlog == 3.4 20:22:25 INFO - moznetwork == 0.27 20:22:25 INFO - mozprocess == 0.25 20:22:25 INFO - mozprofile == 0.28 20:22:25 INFO - mozrunner == 6.13 20:22:25 INFO - mozscreenshot == 0.1 20:22:25 INFO - mozsystemmonitor == 0.3 20:22:25 INFO - moztest == 0.8 20:22:25 INFO - mozversion == 1.4 20:22:25 INFO - psutil == 3.1.1 20:22:25 INFO - requests == 1.2.3 20:22:25 INFO - wsgiref == 0.1.2 20:22:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:22:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 20:22:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 20:22:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:26 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x29df1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7a290>, '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 0x2c7ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7b040>, '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': '9e0dfe3369c33a1556e63f89000001d8-1487821811.660450-639367694', '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 20:22:26 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 20:22:26 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:22:26 INFO - Using env: {'DISPLAY': ':0', 20:22:26 INFO - 'HOME': '/home/cltbld', 20:22:26 INFO - 'LANG': 'en_US.UTF-8', 20:22:26 INFO - 'LANGUAGE': 'en_US:en', 20:22:26 INFO - 'LOGNAME': 'cltbld', 20:22:26 INFO - 'MAIL': '/var/mail/cltbld', 20:22:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:26 INFO - 'MOZ_NO_REMOTE': '1', 20:22:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:26 INFO - 'NO_EM_RESTART': '1', 20:22:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:26 INFO - 'PWD': '/builds/slave/test', 20:22:26 INFO - 'SHELL': '/bin/bash', 20:22:26 INFO - 'SHLVL': '1', 20:22:26 INFO - 'TERM': 'linux', 20:22:26 INFO - 'TMOUT': '86400', 20:22:26 INFO - 'USER': 'cltbld', 20:22:26 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1487821811.660450-639367694', 20:22:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:26 INFO - '_': '/tools/buildbot/bin/python'} 20:22:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:26 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)) 20:22:26 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)) 20:22:26 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)) 20:22:26 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)) 20:22:26 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)) 20:22:26 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)) 20:22:26 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)) 20:22:26 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)) 20:22:26 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)) 20:22:26 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)) 20:22:26 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)) 20:22:26 INFO - Cleaning up... 20:22:26 INFO - Return code: 0 20:22:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:22:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 20:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 20:22:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:26 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x29df1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7a290>, '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 0x2c7ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7b040>, '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': '9e0dfe3369c33a1556e63f89000001d8-1487821811.660450-639367694', '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 20:22:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:22:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:22:26 INFO - Using env: {'DISPLAY': ':0', 20:22:26 INFO - 'HOME': '/home/cltbld', 20:22:26 INFO - 'LANG': 'en_US.UTF-8', 20:22:26 INFO - 'LANGUAGE': 'en_US:en', 20:22:26 INFO - 'LOGNAME': 'cltbld', 20:22:26 INFO - 'MAIL': '/var/mail/cltbld', 20:22:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:26 INFO - 'MOZ_NO_REMOTE': '1', 20:22:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:26 INFO - 'NO_EM_RESTART': '1', 20:22:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:26 INFO - 'PWD': '/builds/slave/test', 20:22:26 INFO - 'SHELL': '/bin/bash', 20:22:26 INFO - 'SHLVL': '1', 20:22:26 INFO - 'TERM': 'linux', 20:22:26 INFO - 'TMOUT': '86400', 20:22:26 INFO - 'USER': 'cltbld', 20:22:26 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1487821811.660450-639367694', 20:22:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:26 INFO - '_': '/tools/buildbot/bin/python'} 20:22:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:22:26 INFO - Cleaning up... 20:22:26 INFO - Return code: 0 20:22:26 INFO - Running post-action listener: _resource_record_post_action 20:22:26 INFO - Running post-action listener: _start_resource_monitoring 20:22:26 INFO - Starting resource monitoring. 20:22:26 INFO - [mozharness: 2017-02-23 04:22:26.472221Z] Finished create-virtualenv step (success) 20:22:26 INFO - [mozharness: 2017-02-23 04:22:26.472735Z] Running install step. 20:22:26 INFO - Running pre-action listener: _resource_record_pre_action 20:22:26 INFO - Running main action method: install 20:22:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:22:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:22:26 INFO - Reading from file tmpfile_stdout 20:22:26 INFO - Detecting whether we're running mozinstall >=1.0... 20:22:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:22:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:22:26 INFO - Reading from file tmpfile_stdout 20:22:26 INFO - Output received: 20:22:26 INFO - Usage: mozinstall [options] installer 20:22:26 INFO - Options: 20:22:26 INFO - -h, --help show this help message and exit 20:22:26 INFO - -d DEST, --destination=DEST 20:22:26 INFO - Directory to install application into. [default: 20:22:26 INFO - "/builds/slave/test"] 20:22:26 INFO - --app=APP Application being installed. [default: firefox] 20:22:26 INFO - mkdir: /builds/slave/test/build/application 20:22:26 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'] 20:22:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 20:22:42 INFO - Reading from file tmpfile_stdout 20:22:42 INFO - Output received: 20:22:42 INFO - /builds/slave/test/build/application/firefox/firefox 20:22:42 INFO - Running post-action listener: _resource_record_post_action 20:22:42 INFO - [mozharness: 2017-02-23 04:22:42.208124Z] Finished install step (success) 20:22:42 INFO - [mozharness: 2017-02-23 04:22:42.208402Z] Running run-tests step. 20:22:42 INFO - Running pre-action listener: _resource_record_pre_action 20:22:42 INFO - Running main action method: run_tests 20:22:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:22:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:22:42 INFO - Python 2.7.3 20:22:42 INFO - Return code: 0 20:22:42 INFO - grabbing minidump binary from tooltool 20:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 20:22:42 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 0x2c7a290>, '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 0x2c7ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7b040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:22:42 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 20:22:42 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 20:22:42 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 20:22:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:22:42 INFO - Return code: 0 20:22:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:22:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:22:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:22:42 INFO - ENV: RUST_BACKTRACE is now 1 20:22:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:22:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:22:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fziZoBLZQf6J64GfmjMy5g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 20:22:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fziZoBLZQf6J64GfmjMy5g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-040 --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 20:22:42 INFO - Using env: {'DISPLAY': ':0', 20:22:42 INFO - 'HOME': '/home/cltbld', 20:22:42 INFO - 'LANG': 'en_US.UTF-8', 20:22:42 INFO - 'LANGUAGE': 'en_US:en', 20:22:42 INFO - 'LOGNAME': 'cltbld', 20:22:42 INFO - 'MAIL': '/var/mail/cltbld', 20:22:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:22:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:22:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:42 INFO - 'MOZ_NO_REMOTE': '1', 20:22:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:22:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:42 INFO - 'NO_EM_RESTART': '1', 20:22:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:22:42 INFO - 'PWD': '/builds/slave/test', 20:22:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:22:42 INFO - 'RUST_BACKTRACE': '1', 20:22:42 INFO - 'SHELL': '/bin/bash', 20:22:42 INFO - 'SHLVL': '1', 20:22:42 INFO - 'TERM': 'linux', 20:22:42 INFO - 'TMOUT': '86400', 20:22:42 INFO - 'USER': 'cltbld', 20:22:42 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1487821811.660450-639367694', 20:22:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:42 INFO - '_': '/tools/buildbot/bin/python'} 20:22:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fziZoBLZQf6J64GfmjMy5g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 20:22:42 INFO - mozversion application_buildid: 20170221181700 20:22:42 INFO - mozversion application_changeset: c7b015c488cfb2afbcff295a9639acd85df332f8 20:22:42 INFO - mozversion application_display_name: Nightly 20:22:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:22:42 INFO - mozversion application_name: Firefox 20:22:42 INFO - mozversion application_remotingname: firefox 20:22:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:22:42 INFO - mozversion application_vendor: Mozilla 20:22:42 INFO - mozversion application_version: 54.0a1 20:22:42 INFO - mozversion platform_buildid: 20170221181700 20:22:42 INFO - mozversion platform_changeset: c7b015c488cfb2afbcff295a9639acd85df332f8 20:22:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:22:42 INFO - mozversion platform_version: 54.0a1 20:22:42 INFO - using testdate: 1487823762 20:22:42 INFO - actual date: 1487823762 20:22:42 INFO - starting webserver on 'localhost:41702' 20:22:42 INFO - SUITE-START | Running 2 tests 20:22:42 INFO - TEST-START | dromaeo_css 20:22:42 INFO - operating with platform_type : linux_ 20:22:42 INFO - Initialising browser for dromaeo_css test... 20:22:42 INFO - TEST-INFO | started process 10049 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAZzqkB/profile http://localhost:41702/getInfo.html) 20:22:45 INFO - PROCESS | 10049 | Iterating over profile /tmp/tmpAZzqkB/profile 20:22:46 INFO - PROCESS | 10049 | No birth date. Using mtime. 20:22:46 INFO - PROCESS | 10049 | Using date: /tmp/tmpAZzqkB/profile/blocklist.xml = Wed Feb 22 2017 20:22:42 GMT-0800 (PST) 20:22:46 INFO - PROCESS | 10049 | No birth date. Using mtime. 20:22:46 INFO - PROCESS | 10049 | Using date: /tmp/tmpAZzqkB/profile/places.sqlite-shm = Wed Feb 22 2017 20:22:44 GMT-0800 (PST) 20:22:46 INFO - PROCESS | 10049 | No birth date. Using mtime. 20:22:46 INFO - PROCESS | 10049 | Using date: /tmp/tmpAZzqkB/profile/sessionCheckpoints.json = Wed Feb 22 2017 20:22:46 GMT-0800 (PST) 20:22:46 INFO - PROCESS | 10049 | No birth date. Using mtime. 20:22:46 INFO - PROCESS | 10049 | Using date: /tmp/tmpAZzqkB/profile/content-prefs.sqlite = Wed Feb 22 2017 20:22:44 GMT-0800 (PST) 20:22:46 INFO - PROCESS | 10049 | No birth date. Using mtime. 20:22:46 INFO - PROCESS | 10049 | Using date: /tmp/tmpAZzqkB/profile/safebrowsing = Wed Feb 22 2017 20:22:45 GMT-0800 (PST) 20:22:46 INFO - PROCESS | 10049 | No birth date. Using mtime. 20:22:46 INFO - PROCESS | 10049 | Using date: /tmp/tmpAZzqkB/profile/places.sqlite-wal = Wed Feb 22 2017 20:22:46 GMT-0800 (PST) 20:22:46 INFO - PROCESS | 10049 | No birth date. Using mtime. 20:22:46 INFO - PROCESS | 10049 | Using date: /tmp/tmpAZzqkB/profile/extensions.ini = Wed Feb 22 2017 20:22:43 GMT-0800 (PST) 20:22:46 INFO - PROCESS | 10049 | No birth date. Using mtime. 20:22:46 INFO - PROCESS | 10049 | Using date: /tmp/tmpAZzqkB/profile/extensions = Wed Feb 22 2017 20:22:42 GMT-0800 (PST) 20:22:46 INFO - PROCESS | 10049 | No birth date. Using mtime. 20:22:46 INFO - PROCESS | 10049 | Using date: /tmp/tmpAZzqkB/profile/pluginreg.dat = Wed Feb 22 2017 20:22:45 GMT-0800 (PST) 20:22:46 INFO - PROCESS | 10049 | No birth date. Using mtime. 20:22:46 INFO - PROCESS | 10049 | Using date: /tmp/tmpAZzqkB/profile/permissions.sqlite = Wed Feb 22 2017 20:22:43 GMT-0800 (PST) 20:22:46 INFO - PROCESS | 10049 | No birth date. Using mtime. 20:22:46 INFO - PROCESS | 10049 | Using date: /tmp/tmpAZzqkB/profile/gmp = Wed Feb 22 2017 20:22:43 GMT-0800 (PST) 20:22:46 INFO - PROCESS | 10049 | No birth date. Using mtime. 20:22:46 INFO - PROCESS | 10049 | Using date: /tmp/tmpAZzqkB/profile/secmod.db = Wed Feb 22 2017 20:22:42 GMT-0800 (PST) 20:22:46 INFO - PROCESS | 10049 | No birth date. Using mtime. 20:22:46 INFO - PROCESS | 10049 | Using date: /tmp/tmpAZzqkB/profile/prefs.js = Wed Feb 22 2017 20:22:00 GMT-0800 (PST) 20:22:46 INFO - PROCESS | 10049 | No birth date. Using mtime. 20:22:46 INFO - PROCESS | 10049 | Using date: /tmp/tmpAZzqkB/profile/addons.json = Wed Feb 22 2017 20:22:45 GMT-0800 (PST) 20:22:46 INFO - PROCESS | 10049 | No birth date. Using mtime. 20:22:46 INFO - PROCESS | 10049 | Using date: /tmp/tmpAZzqkB/profile/compatibility.ini = Wed Feb 22 2017 20:22:43 GMT-0800 (PST) 20:22:46 INFO - PROCESS | 10049 | No birth date. Using mtime. 20:22:46 INFO - PROCESS | 10049 | Using date: /tmp/tmpAZzqkB/profile/directoryLinks.json = Wed Feb 22 2017 20:22:45 GMT-0800 (PST) 20:22:46 INFO - PROCESS | 10049 | Stat failure 20:22:46 INFO - PROCESS | 10049 | No birth date. Using mtime. 20:22:46 INFO - PROCESS | 10049 | Using date: /tmp/tmpAZzqkB/profile/user.js = Wed Feb 22 2017 20:22:42 GMT-0800 (PST) 20:22:46 INFO - PROCESS | 10049 | No birth date. Using mtime. 20:22:46 INFO - PROCESS | 10049 | Using date: /tmp/tmpAZzqkB/profile/startupCache = Wed Feb 22 2017 20:22:42 GMT-0800 (PST) 20:22:46 INFO - PROCESS | 10049 | No birth date. Using mtime. 20:22:46 INFO - PROCESS | 10049 | Using date: /tmp/tmpAZzqkB/profile/minidumps = Wed Feb 22 2017 20:22:42 GMT-0800 (PST) 20:22:46 INFO - PROCESS | 10049 | No birth date. Using mtime. 20:22:46 INFO - PROCESS | 10049 | Using date: /tmp/tmpAZzqkB/profile/thumbnails = Wed Feb 22 2017 20:22:45 GMT-0800 (PST) 20:22:46 INFO - PROCESS | 10049 | No birth date. Using mtime. 20:22:46 INFO - PROCESS | 10049 | Using date: /tmp/tmpAZzqkB/profile/key3.db = Wed Feb 22 2017 20:22:42 GMT-0800 (PST) 20:22:46 INFO - PROCESS | 10049 | No birth date. Using mtime. 20:22:46 INFO - PROCESS | 10049 | Using date: /tmp/tmpAZzqkB/profile/cert8.db = Wed Feb 22 2017 20:22:42 GMT-0800 (PST) 20:22:46 INFO - PROCESS | 10049 | No birth date. Using mtime. 20:22:46 INFO - PROCESS | 10049 | Using date: /tmp/tmpAZzqkB/profile/places.sqlite = Wed Feb 22 2017 20:22:46 GMT-0800 (PST) 20:22:46 INFO - PROCESS | 10049 | No birth date. Using mtime. 20:22:46 INFO - PROCESS | 10049 | Using date: /tmp/tmpAZzqkB/profile/extensions.json = Wed Feb 22 2017 20:22:45 GMT-0800 (PST) 20:22:46 INFO - PROCESS | 10049 | No birth date. Using mtime. 20:22:46 INFO - PROCESS | 10049 | Using date: /tmp/tmpAZzqkB/profile/crashes = Wed Feb 22 2017 20:22:42 GMT-0800 (PST) 20:22:46 INFO - PROCESS | 10049 | No birth date. Using mtime. 20:22:46 INFO - PROCESS | 10049 | Using date: /tmp/tmpAZzqkB/profile/localstore.rdf = Wed Feb 22 2017 20:22:00 GMT-0800 (PST) 20:22:46 INFO - PROCESS | 10049 | No birth date. Using mtime. 20:22:46 INFO - PROCESS | 10049 | Using date: /tmp/tmpAZzqkB/profile/bookmarkbackups = Wed Feb 22 2017 20:22:45 GMT-0800 (PST) 20:22:46 INFO - PROCESS | 10049 | No birth date. Using mtime. 20:22:46 INFO - PROCESS | 10049 | Using date: /tmp/tmpAZzqkB/profile/cache2 = Wed Feb 22 2017 20:22:42 GMT-0800 (PST) 20:22:46 INFO - PROCESS | 10049 | No birth date. Using mtime. 20:22:46 INFO - PROCESS | 10049 | Using date: /tmp/tmpAZzqkB/profile/.parentlock = Wed Feb 22 2017 20:22:42 GMT-0800 (PST) 20:22:46 INFO - PROCESS | 10049 | No birth date. Using mtime. 20:22:46 INFO - PROCESS | 10049 | Using date: /tmp/tmpAZzqkB/profile/frequencyCap.json = Wed Feb 22 2017 20:22:45 GMT-0800 (PST) 20:22:47 INFO - PROCESS | 10049 | __metrics Screen width/height:1600/1200 20:22:47 INFO - PROCESS | 10049 | colorDepth:24 20:22:47 INFO - PROCESS | 10049 | Browser inner width/height: 1024/697 20:22:47 INFO - PROCESS | 10049 | __metrics 20:22:48 ERROR - PROCESS | 10049 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 20:22:49 INFO - TEST-INFO | 10049: exit 0 20:22:49 INFO - Browser initialized. 20:22:49 INFO - Running cycle 1/1 for dromaeo_css test... 20:22:49 INFO - TEST-INFO | started process 10177 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAZzqkB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:23:01 INFO - PROCESS | 10177 | RSS: Main: 153604096 20:23:01 INFO - PROCESS | 10177 | 20:26:04 INFO - PROCESS | 10177 | Cycle 1(1): loaded http://localhost:41702/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41702/tests/dromaeo/cssquery-ext.html) 20:26:06 INFO - PROCESS | 10177 | RSS: Main: 165089280 20:26:06 INFO - PROCESS | 10177 | 20:27:49 INFO - PROCESS | 10177 | ************************* 20:27:49 INFO - PROCESS | 10177 | A coding exception was thrown and uncaught in a Task. 20:27:49 INFO - PROCESS | 10177 | 20:27:49 ERROR - PROCESS | 10177 | Full message: TypeError: NetworkError when attempting to fetch resource. 20:27:49 INFO - PROCESS | 10177 | Full stack: 20:27:49 INFO - PROCESS | 10177 | ************************* 20:29:09 INFO - PROCESS | 10177 | Cycle 1(1): loaded http://localhost:41702/tests/dromaeo/cssquery-ext.html (next: http://localhost:41702/tests/dromaeo/cssquery-jquery.html) 20:29:09 INFO - PROCESS | 10177 | RSS: Main: 157483008 20:29:09 INFO - PROCESS | 10177 | 20:32:11 INFO - PROCESS | 10177 | Cycle 1(1): loaded http://localhost:41702/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41702/tests/dromaeo/cssquery-mootools.html) 20:32:12 INFO - PROCESS | 10177 | RSS: Main: 165703680 20:32:12 INFO - PROCESS | 10177 | 20:35:14 INFO - PROCESS | 10177 | Cycle 1(1): loaded http://localhost:41702/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41702/tests/dromaeo/cssquery-prototype.html) 20:35:15 INFO - PROCESS | 10177 | RSS: Main: 158511104 20:35:15 INFO - PROCESS | 10177 | 20:38:18 INFO - PROCESS | 10177 | Cycle 1(1): loaded http://localhost:41702/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41702/tests/dromaeo/cssquery-yui.html) 20:38:18 INFO - PROCESS | 10177 | RSS: Main: 165650432 20:38:18 INFO - PROCESS | 10177 | 20:41:21 INFO - PROCESS | 10177 | Cycle 1(1): loaded http://localhost:41702/tests/dromaeo/cssquery-yui.html (next: http://localhost:41702/tests/dromaeo/cssquery-dojo.html) 20:41:21 INFO - PROCESS | 10177 | RSS: Main: 158486528 20:41:21 INFO - PROCESS | 10177 | 20:41:21 INFO - PROCESS | 10177 | __start_tp_report 20:41:21 INFO - PROCESS | 10177 | _x_x_mozilla_page_load 20:41:21 INFO - PROCESS | 10177 | _x_x_mozilla_page_load_details 20:41:21 INFO - PROCESS | 10177 | |i|pagename|runs| 20:41:21 INFO - PROCESS | 10177 | |0;dojo.html;2502.0867383405057;2533.3539947313434;2560.8975640974354;2561.9359516012087;2567.5891857302845;4410.75740834254;4495.505494395614;4541.704789188704;4565.817367305308;4612.538746125386;4440.023194897126;4483.977580112095;4495.393121928539;4535.047639995597;4585.793639286232;4098.549159592442;4106.77412742299;4125.071858831769;4144.626983571478;4245.8089385977555;3850.210706805098;4254;4254.298040823276;4266.296061149907;4280.550542193072;4068.206699693561;4083.6528895043957;4161.4382058422025;4210.115875666113;4226.260404429213;4187.392828039917;4217.219814334358;4227.894302642428;4247.405363249148;4255.17024180285;4209.91580168398;4212.473440819897;4225.873223803291;4247.469066366704;4254.127903779718;4359.12817436514;4419.381286619876;4571.748553829538;4598.333241679971;4624.052069325814;4764.428268607755;4775.832845850413;4781.115493633689;4782.689125206885;4786.282057691339;4751.572358487718;4798.424189097295;4801.615870730368;4804.351412559329;4808.062427826575;4507.954920450819;4508.0533088051225;4508.706934049276;4508.962938524125;4510.616597589242;4837.201861692852;4861.9027619447415;4880.194767863334;4885.755712214375;4893.363862697897;4758.286257061399;4772.0455908817685;4775.164346239394;4775.307580400822;4776.498467660915;4777.546133117348;4780.545848144421;4825.638077144228;4829.855104346875;4841.176999910023;4854.247591623304;4877.780499877514;4880.438749543777;4889.706617602955;4922.384701912261;4874.46380898101;4883.682560633548;4885.60915126789;4887.535684110004;4924.089043526959;4069.8168582413864;4105.548389677133;4113.629773320416;4157.397177409259;4167.124903770182;3633.4186530155575;3638.5633723953297;3668.0646435158865;3670.4861319415304;3689.114612493036;4262.4458820353775;4270.594293542171;4273.273543497551;4282.678799090081;4313.568643135662;4687.320338550891;4710.034442939189;4840.782164802592;4849.975750121297;4923.335349727741;4237.555056719062;4266.274733295348;4288.228118938621;4295.892602684958;4302.139572085595;4402.053558484877;4409.559044095629;4410.3825464435;4418.248897687401;4418.8453404130705;4443.422355093817;4481.686281960231;4534.365188873627;4593.356930029865;4641.303804429228;4861.51384861511;4883.096627123993;4886.584640305614;4915.287283343823;4917.655764096479;4436.356728274318;4472.262076757299;4577.336286238543;4601.12578610063;4633.606143477842;4760.976195119002;4812.51874812516;4819.662623616313;4846.830360937351;4894.902101958012;4656.348111264493;4686.156491831503;4909.140900342354;4914.877128071684;4970.701757894538;4671.509491503343;4707.388039554836;4707.741074240949;4824.734639594856;4836.177849765478;4762.261849413347;4779.928301075417;4781.091592597395;4782.665213435026;4802.327674125695;4668.929966050444;4682.040181762799;4714.9292760609305;4730;4760.16697078003;4668.276417155346;4710.882227944328;4774.665773395829;4818.4217893852965;4824.710517368969;4739.502352253102;4740.502247263988;4742.170120229015;4787.54518320759;4794.448638406628 20:41:21 INFO - PROCESS | 10177 | |1;ext.html;530.9858170893593;540.9161579955107;546.9562435005198;559.5020431815682;561.1050374652428;37424;39595.99999999996;39752;42691.359629605504;42697.35953960693;38649.613503865025;39021.804890975574;39050.31396232449;39103.21793564127;39144.41283380752;7531.698732050711;7674.347680447168;7686.269804368604;7705.8844117338285;9324.393914395543;9346.065393460667;9643.80712385752;9650.03499650033;9663.4201947883;9668.371555848882;9676.709698709015;9688.321817472779;9697.757556061084;9707.077827606367;9711.75720606987;9497.335186536946;9540.809183816285;9592.568334424968;9595.66415175469;9655.855162172538;9402.576884040234;9452.95273523635;9498.287628427826;9504.524773761354;9525.761855953588;32481;32757.344853103044;32806.50790238148;32806.6719332806;32886.506702399485;3305.8512366943546;3415.2315728961034;3419.46998215277;3462.4979377990303;3475.6524347565296;25080;25159;25263.494730105478;25507.617385739228;25533;3328.700416962485;3427.725781937439;3444.3800115979116;3546.6453354664586;3564.091156755037;226728;226977;227522;228900;229061;38442;40018.599814001485;45952.3107153393;46054.76972615116;46083;60330;60760.69619651874;60874.39125608776;61160.69419652873;66797.66601166963;11854.525818967317;12323;12359.75280494403;12382.876171238353;12450.75098498043;8136.0643525995265;8158.755237342889;8225.218604232588;8243.587820608946;8248.216419440143;18785.342513012252;18802.529936751416;18852.434426967215;18857.151428185764;18971.43085707431;6979.651017449107;7023.754168604074;7040.471964602675;7230.98680232476;7417.814554636069;749.6514120933683;768.4735955870246;771.3713323641215;789.0531362365185;797.9042514898133;26272.605910911352;26486.867565662047;27090.864545677145;27203.45593088127;27574.448511029666;913.4336711239074;921.7833809054866;924.3575714878095;936.2509992006504;937.1425145991478;14344.713105737826;14477;14515.274236288355;14578;14724.705505889822;333128;333389;335904;336721;338158;48393.27410088851;48650.5134948646;49229.261561075895;49241;49280;1143.3997151495364;1171.707073231692;1182.1252273317855;1184.7393573413835;1191.8867707567767;25339.87330063338;26075.21774346697;26680.733192668602;26941.46117077608;26993.460130797666;41258.793706031276;41695;41738.37392439055;41991.7900410496;42022.1595568093;281247;281528;282244;282781;283576;29750.702492974793;30555.08334749961;35570.46644300286;36823.44764828583;38802.61197388103;36011;36414.4537831938;39332;39762.40356394714;40566.59433405628;31369.686303136677;31412.214694632818;31728.524072138476;31901.6809831908;32672.34655306928;30949.845250773604;31233.8438307807;31989.520157197196;32583;32968.505472418416;31574.684253158095;31771.682283176873;31987.840060799546;32065.038048858572;32073.83963080263;27557.44885102327;27920.720792791813;28590;28625.570616440353;28880.85559572189;22166.88916555407;22610.321690349316;22727.772722272566;22799.202027928943;22814.42963925915 20:41:21 INFO - PROCESS | 10177 | |2;jquery.html;384.1816929939229;397.30471674569503;397.8468289708462;404.141199950106;420.36734714255044;12421.192622479533;15639.765403518957;16406.835931640693;17858.374956876512;17954.281828726867;17397.652046959083;17740.733888991643;17881.91059044703;17937.910310448464;18228.088595570203;5021.899562008776;5051.217061355486;5185.559227465651;5280.049591073605;5284.339457567804;5168.948310516885;5253.527182553569;5255.500727430888;5268.578513718893;5277.577793776508;5049.697018178903;5077.873053173664;5200.453952335007;5216.087184742655;5219.895602087975;5102.056119617864;5126.615503837208;5165.483451654842;5178.870528236786;5185.818496352609;4564.566366195206;4630.953690463086;4644.2801365788355;4671.8364857229835;4672.766361681936;18049.819501804945;20810.687839682418;21266.043028063774;21457;21494.677579836316;2182.9126834926583;2216.9113235470563;2252.8648281103024;2255.5155570824645;2272.9318120456414;13079.346032698328;13650;13782.93108534451;14266.215358155298;14364.497242596459;1612;1655.2964989879254;1676.5305714399988;1689.2567270400984;1689.3664875671623;73526;73568.26431735668;73742.63128684375;75342.62328688377;76407;10059.497025148714;10230.846537301946;10341.4312212829;10390.220733445021;10483.737906552396;11963.102767292314;14395.496157634432;14401.423943042371;14434.639134021734;14464.927675361556;6199.706108739705;6328.968355158287;6570.638614876132;6610.570312929741;6626;5905;5919.940800592025;6076.878462430726;6143.262808463013;6147.72335244915;3939.054626889526;3946.506686664167;3956.4460975463458;4041.9797901010306;4090.1819636072905;1984.2559040359865;2022.7572691277142;2028.1583142995491;2029.0767700696442;2045.1410407628534;383.20484993638314;759.236966848314;767.4474378447509;793.8253584211465;798.5089170160426;10397.964619834993;11210.49552770111;11397.430128493708;11787.292762434281;11823.940880295544;392.9214157168578;396.3954968672797;399.3670032997731;403.76783349573526;406.83116506649407;5905.527557795366;5977.910331345033;6054.424829641177;6064.120702498113;6128.908066379008;524782;528638;529757;549013;549235;69787.65106174437;91635.54182229046;92794.04044696674;92808;96392.51803740936;426.9594388533084;431.1936678411391;433.94575678040246;433.9761313127745;434.9238883195428;10276.383416995004;10320.845187322046;10358.274920755775;10364.792704146026;10509.159267258754;37615;38949.22101558009;39142.217155657294;39144.217115658095;39799.80100099481;56511.71744141253;57656.42343576678;57760.4223957755;57994;59956;7599.050118735158;7870.527768333918;7888.645010974635;7979;8061.838763224585;9360.625574976924;12036.157468977088;12196.817047744113;12424.440900159334;12731.23612583248;10278.743031424274;10326.380417174994;10406.595109660402;10523.210759193244;11201.159913006393;8072.273495385443;10372.792544148924;10857.83713244286;10931.398773067558;10947.233693641369;10399.48002599882;10601.204909631655;10659.840102398626;10962.342259464138;11034;7710.228977102469;7738.226177382442;7840.3727701784865;7893.565853878092;7965.641546130554;10382.169426446017;10445.634402795866;10521.105706015074;10726.570937162425;10982.890171098186 20:41:21 INFO - PROCESS | 10177 | |3;mootools.html;1336.0914578086904;1351.3851197705046;1351.6688411339223;1352.9188248705073;1357.4230951845466;6986.266442023584;7372.004779354786;7412.4811263211595;7600.239976002411;7772.922270777291;7784.221577842227;7840.294373506384;7956.522608643485;7959.403044771636;7966.800829979254;2033.6034473277716;2101.7477902651704;2103.6739305407687;2105.589410065038;2107.146605624717;2043.83649308055;2093.204582258747;2093.811556959873;2095.7904209578996;2100.0339843671927;2017.6670849309846;2050.8359331253537;2074.315475892959;2074.3569493457003;2078.023329035351;2051.8050785175383;2069.6998935154393;2070.2960993262213;2074.159965214091;2079.12676675795;1737.1053907237783;1789.2127463915965;1985.5234743661417;2011.6781314989678;2054.096197673034;7391.113066432009;7602.201768814305;7609.80975475612;7615.80960475987;7619.352355049828;4524.592786649185;4647.55848194421;4655.6973796703105;4662.207424737769;4666.136764698542;2821.138048887745;2834.2489240351324;2876.2665520292403;2903.11455006223;2915.9562606560708;1053.1416895230439;1064.031731124673;1104.7624760676492;1108.5898217659517;1162.3548930343657;10230.18158547322;10248.385096894135;10296.970302969718;10346.896531034668;10365.63720269787;3843.2121415109837;4054.918901621951;4096.897577560525;4101.610347017028;4127.071408932966;7881.330086942559;7957.920420795834;7961.1242763295995;7971.163027882105;7991.68033278674;4538.160440318552;4593.908121837611;4606;4627.259638457831;4628.583427491542;4060.1136233272077;4083.4079058536345;4140.3375459926265;4166.479190101238;4178.477690288714;3162.6362968258945;3224.193951512122;3320.4853247746637;3327.334533093391;3340.331933613287;966.0580933589694;970.369259981018;976.2336565795816;984.6701355045997;987.896270891546;624.9843753906189;657.9967100164469;660.867826434715;663.171036204744;667.4726965697045;4768.117898188846;4771.761411929389;4788.832390866303;4877.048975449824;5026.472220416877;525.3459442993498;526.4235661950158;529.6319058254553;532.5100907165418;541.4666553444854;3048.9589586113652;3101.5967924169713;3142.842857857098;3163.984180079131;3200.1839530919465;8964.955175224082;9257.166854982948;9290.62837486493;9403;9436;9349.158575728217;9352.251819854395;9364.719058428122;9383.765405864908;9386.85919711205;6815;7020.368166864904;7060.646967651597;7085.999999999897;7089.751858684921;4761.571458568746;4763.761811909321;4816.494268101799;4820.373351464427;4841.273808928548;8225.465344752572;8319.168083191633;8375.07874133857;8441.775942488182;8449.577521124042;8307.460015098999;8405.159484051546;8614.483131011908;8685.174908383693;8695.260902823078;6230.470410015199;6372.267189273293;6377.266614339224;6378.330275321025;6383.872322553616;7230.24082471354;7246.60143692102;7291.489595728248;7343.522671026366;7369.705211791683;6556.377144171296;6632;6652.567583107082;6762.087118239171;6776.898346524707;6391.808245752635;6504.6747662615735;6562.376574225441;6589;6597.967010165111;5567.276254086943;5615.494605485526;5642.379338272869;5662.745176466987;5679.460451257124;4225.218334608107;4243.5332113466875;4335.28467802809;4375.978120109507;4452.0205554777895;4424.668149888836;4458.375827384104;4484.506704262594;4487.932681009853;4558.658100642531 20:41:21 INFO - PROCESS | 10177 | |4;prototype.html;343.14727901165617;366.1925454373107;366.256499306408;369.5288507153381;371.9795411252382;4842.491538388471;4944.456109827916;4968.478309777475;4976.975115124428;5008.373953255843;4772.642051846108;4863.440704318996;4875.488073752258;4879.219324908016;4891.47813574226;3864.574896761354;3868.3423817951016;3877.728559000871;3883.9805800970958;3892.2799282132755;3721.7394782365245;3845.288621605012;3849.1339448624117;3879.495665563473;3883.825227864753;3830.8276127574186;3836.7889766062854;3854.939891529824;3857.0935830079907;3858.498395208619;3846.769193848364;3847.7498962567342;3852.728599562138;3863.150106976461;3872.206197729459;3392.4572068469174;3398.8130652814084;3401.540791993074;3409.8124603146816;3418.8632454701783;4673.883152921204;4800.279958006292;4839.225723884161;4842.685225460369;4851.223804191348;4353.782310884475;4367.10474352757;4375.803088861009;4384.6273066789045;4391.5827996340295;5154.716490593016;5159.2003239497935;5163.122269214243;5180.559652429548;5189.870253243661;3485.1809824691177;3669.2294618130227;3691.741578089535;3693.021349342426;3701.2597480504005;5210.66130701507;5297.496737809902;5353.277307563468;5386.542143917811;5407.513323800877;3761.247750449921;3763.5295588051495;3777.2823163598828;3779.4708740776314;3788.7726736395352;3799.4680744695765;3817.6373244541724;3830.138218900725;3834.3673293906195;3837.13664425502;4247.941482132859;4368.432103826546;4371.628411585051;4400.295952647625;4418.536053714378;5189.636725429259;5190.714510701948;5216.60875434344;5222.2505460670345;5234.842954711365;1271.205496564647;1273.796192609178;1289.9097063205486;1292.018066269623;1292.8707129287184;823.4194892600702;875.5447167472878;881.3478026260649;897.264243320471;900.8468560344758;4355.324924636687;4375.518692943773;4379.37237657403;4383.298672212431;4421.579949904753;5183.248428977777;5242;5269.552088072557;5275.235090911873;5289.682619042793;4198;4433.138082005566;4461.420015397977;4466.553344665507;4484.327350897326;2745.970261152068;2759.351552385188;2773.2650847525424;2777.416742484101;2789.762870156019;4861.319415281863;4871.975640121847;4876.683015603974;4878.487758785347;4902.828401005948;5020.970701006285;5320.14877619579;5336.439673834269;5351.51836334724;5391.892162156735;4834.920983976924;4839.902462424051;4852.344933434012;4858.7570621468785;4864.640649285094;5192.221166825007;5198.844034678966;5206.698325418645;5210.296609957607;5239.318888544465;4889.853304400874;5031.622628302819;5032.421271553671;5147.099257629825;5148.7425628717665;4802.8799280018275;4808.735519546459;4886.120498310338;4972.229304457815;4990.326305948795;3761;3788.753731007476;3790.3935370340614;3793.729100751279;3796.715246356479;5363.329583802025;5365.248865158803;5367.973160134175;5369.436209197978;5413;4897.289892965571;5179.378474583074;5195.9740201298755;5231.659942103751;5265.894682106413;5208.218767184952;5208.609354298367;5210.270562121382;5210.713410762292;5229.21561765723;5136.460671629425;5158.200478925773;5164.612654050886;5165.457626949266;5183.533481986639;4876.95123048765;5151.845444636667;5170.612204084633;5197.142471492161;5237.764300606558;5078.187490001582;5082.110630639697;5103.902660927918;5104.770285337095;5107.897842043064 20:41:21 INFO - PROCESS | 10177 | |5;yui.html;657.8684263147371;660.4320284555282;712.5404114346244;735.5917465806477;756.8297133145041;11722.589709360163;12713.809292860615;12801.975841932646;12803.999999999989;12814.359282035884;12714;12993.2204067756;13015.869841301585;13040.152390094661;13045.804312935314;784.3999340504504;794.566961006253;796.3111908199395;796.6494742313392;809.7287408718087;796.1680044353665;803.7106641609046;804.5494523067072;806.6128258435925;806.7297455352464;819.2381085590429;834.04501845387;835.9707410240643;836.9832603347929;838.053000109875;835.8202986357962;837.7905523619095;837.9790505237387;838.0237023867187;839.7102999465175;607.750822162911;611.8806832667632;613.1507861611656;613.1660941120073;613.5306490534745;12829.422675979604;13050.934745326307;13089.149205301625;13099.86900130996;13811.102278351875;12076.335801530913;12514.249145051326;12522;12642.55751048709;13039.54361597349;10246.69259922196;10320.225983051301;10332.896671033268;10357.326773759756;10925.617603383844;3142.670019647927;3164.0507847645845;3221.4040402525607;3331.1505566080737;3339.4990751387245;51360.486395135944;54292.99999999961;54737.452625473634;62091;62674;9855.507224638739;10266.332688375382;10368.637097701696;10376.636817711344;10827.296225745302;18611.534711632048;18641.533961650795;18742.625147497245;18751.718724219147;19394.418167455;6710.765123220664;6980.581165130007;6985.406240469617;7014.368706816411;7279.398532322881;3456.1705190754037;3605.296967091392;3639.9636003640153;3642.0712718256673;3669.156094098319;2887.7978541501893;3030.530267808493;3045.6040714707387;3048.039867441793;3065.8773649054233;572.530524969521;580.1413907416962;580.5210701171551;590.734169623671;598.332858862374;604.5737754882884;619.2228752915063;622.4771192198575;644.7614382678345;660.0791895306021;8521.53131577769;8753.343499237582;8769.429987050822;8869.068747781519;9110.362274640844;599.5293694449836;607.7068731349991;611.944924956756;616.4236438929615;621.7326549583722;3927.3912543555793;3983.063979964706;4008.3586626139677;4026;4221.746695198298;49358.012839743;49787;50249.49750502521;52740.47259527355;53188;42333.57666423296;48398.75800620974;52313.17792293396;53825.46174538205;54078;45720.77139614281;46804.7659761699;47095.5290447098;47099.5290047102;48500;8878.955605221932;9391.436513809193;9398.248140148635;9430.669926552539;9434.386764860263;32068.839655802505;32143.35713285768;32482.837585811918;33813.49279760756;34165;38695.6130438692;41463.37804932989;41494.79252603718;41615.37576936288;41737.37393939154;10940.846927005994;10961.83557246626;10965.780684386427;11130.610428634958;11353.318800871974;11994.400279986141;12071.215371000857;12099.455524501594;12260;12718.236905785683;10987.725306867073;11138.164637652371;11227.157963152633;11238.100951923663;11522.884771152181;11559.143789194637;11674.88325116772;11988.820167697317;12004.159708820298;12197.939010305246;11761.647150585497;11909.583164589198;12072.3360215189;12402.441890114786;12429.937850310691;8483.787905302417;8692.261157801659;8865.468071915706;9005.279577633642;9222.40054396462;8031.477953932976;8848;8979.32655050887;9198.356115071882;9309.534523273946 20:41:21 INFO - PROCESS | 10177 | __end_tp_report 20:41:21 INFO - PROCESS | 10177 | __start_cc_report 20:41:21 INFO - PROCESS | 10177 | _x_x_mozilla_cycle_collect,387 20:41:21 INFO - PROCESS | 10177 | __end_cc_report 20:41:21 INFO - PROCESS | 10177 | __startTimestamp1487824881988__endTimestamp 20:41:21 INFO - PROCESS | 10177 | 20:41:21 INFO - PROCESS | 10177 | ------- Summary: start ------- 20:41:21 INFO - PROCESS | 10177 | Number of tests: 6 20:41:22 INFO - PROCESS | 10177 | 20:41:22 INFO - PROCESS | 10177 | [#0] dojo.html Cycles:165 Average:4493.43 Median:4624.05 stddev:459.90 (9.9%) stddev-sans-first:433.97 20:41:22 INFO - PROCESS | 10177 | Values: 2502.1 2533.4 2560.9 2561.9 2567.6 4410.8 4495.5 4541.7 4565.8 4612.5 4440.0 4484.0 4495.4 4535.0 4585.8 4098.5 4106.8 4125.1 4144.6 4245.8 3850.2 4254.0 4254.3 4266.3 4280.6 4068.2 4083.7 4161.4 4210.1 4226.3 4187.4 4217.2 4227.9 4247.4 4255.2 4209.9 4212.5 4225.9 4247.5 4254.1 4359.1 4419.4 4571.7 4598.3 4624.1 4764.4 4775.8 4781.1 4782.7 4786.3 4751.6 4798.4 4801.6 4804.4 4808.1 4508.0 4508.1 4508.7 4509.0 4510.6 4837.2 4861.9 4880.2 4885.8 4893.4 4758.3 4772.0 4775.2 4775.3 4776.5 4777.5 4780.5 4825.6 4829.9 4841.2 4854.2 4877.8 4880.4 4889.7 4922.4 4874.5 4883.7 4885.6 4887.5 4924.1 4069.8 4105.5 4113.6 4157.4 4167.1 3633.4 3638.6 3668.1 3670.5 3689.1 4262.4 4270.6 4273.3 4282.7 4313.6 4687.3 4710.0 4840.8 4850.0 4923.3 4237.6 4266.3 4288.2 4295.9 4302.1 4402.1 4409.6 4410.4 4418.2 4418.8 4443.4 4481.7 4534.4 4593.4 4641.3 4861.5 4883.1 4886.6 4915.3 4917.7 4436.4 4472.3 4577.3 4601.1 4633.6 4761.0 4812.5 4819.7 4846.8 4894.9 4656.3 4686.2 4909.1 4914.9 4970.7 4671.5 4707.4 4707.7 4824.7 4836.2 4762.3 4779.9 4781.1 4782.7 4802.3 4668.9 4682.0 4714.9 4730.0 4760.2 4668.3 4710.9 4774.7 4818.4 4824.7 4739.5 4740.5 4742.2 4787.5 4794.4 20:41:22 INFO - PROCESS | 10177 | 20:41:22 INFO - PROCESS | 10177 | [#1] ext.html Cycles:180 Average:43592.29 Median:19558.56 stddev:74783.66 (382.4%) stddev-sans-first:74923.56 20:41:22 INFO - PROCESS | 10177 | Values: 531.0 540.9 547.0 559.5 561.1 37424.0 39596.0 39752.0 42691.4 42697.4 38649.6 39021.8 39050.3 39103.2 39144.4 7531.7 7674.3 7686.3 7705.9 9324.4 9346.1 9643.8 9650.0 9663.4 9668.4 9676.7 9688.3 9697.8 9707.1 9711.8 9497.3 9540.8 9592.6 9595.7 9655.9 9402.6 9453.0 9498.3 9504.5 9525.8 32481.0 32757.3 32806.5 32806.7 32886.5 3305.9 3415.2 3419.5 3462.5 3475.7 25080.0 25159.0 25263.5 25507.6 25533.0 3328.7 3427.7 3444.4 3546.6 3564.1 226728.0 226977.0 227522.0 228900.0 229061.0 38442.0 40018.6 45952.3 46054.8 46083.0 60330.0 60760.7 60874.4 61160.7 66797.7 11854.5 12323.0 12359.8 12382.9 12450.8 8136.1 8158.8 8225.2 8243.6 8248.2 18785.3 18802.5 18852.4 18857.2 18971.4 6979.7 7023.8 7040.5 7231.0 7417.8 749.7 768.5 771.4 789.1 797.9 26272.6 26486.9 27090.9 27203.5 27574.4 913.4 921.8 924.4 936.3 937.1 14344.7 14477.0 14515.3 14578.0 14724.7 333128.0 333389.0 335904.0 336721.0 338158.0 48393.3 48650.5 49229.3 49241.0 49280.0 1143.4 1171.7 1182.1 1184.7 1191.9 25339.9 26075.2 26680.7 26941.5 26993.5 41258.8 41695.0 41738.4 41991.8 42022.2 281247.0 281528.0 282244.0 282781.0 283576.0 29750.7 30555.1 35570.5 36823.4 38802.6 36011.0 36414.5 39332.0 39762.4 40566.6 31369.7 31412.2 31728.5 31901.7 32672.3 30949.8 31233.8 31989.5 32583.0 32968.5 31574.7 31771.7 31987.8 32065.0 32073.8 27557.4 27920.7 28590.0 28625.6 28880.9 22166.9 22610.3 22727.8 22799.2 22814.4 20:41:22 INFO - PROCESS | 10177 | 20:41:22 INFO - PROCESS | 10177 | [#2] jquery.html Cycles:180 Average:28776.97 Median:20098.82 stddev:88280.80 (439.2%) stddev-sans-first:88502.71 20:41:22 INFO - PROCESS | 10177 | Values: 384.2 397.3 397.8 404.1 420.4 12421.2 15639.8 16406.8 17858.4 17954.3 17397.7 17740.7 17881.9 17937.9 18228.1 5021.9 5051.2 5185.6 5280.0 5284.3 5168.9 5253.5 5255.5 5268.6 5277.6 5049.7 5077.9 5200.5 5216.1 5219.9 5102.1 5126.6 5165.5 5178.9 5185.8 4564.6 4631.0 4644.3 4671.8 4672.8 18049.8 20810.7 21266.0 21457.0 21494.7 2182.9 2216.9 2252.9 2255.5 2272.9 13079.3 13650.0 13782.9 14266.2 14364.5 1612.0 1655.3 1676.5 1689.3 1689.4 73526.0 73568.3 73742.6 75342.6 76407.0 10059.5 10230.8 10341.4 10390.2 10483.7 11963.1 14395.5 14401.4 14434.6 14464.9 6199.7 6329.0 6570.6 6610.6 6626.0 5905.0 5919.9 6076.9 6143.3 6147.7 3939.1 3946.5 3956.4 4042.0 4090.2 1984.3 2022.8 2028.2 2029.1 2045.1 383.2 759.2 767.4 793.8 798.5 10398.0 11210.5 11397.4 11787.3 11823.9 392.9 396.4 399.4 403.8 406.8 5905.5 5977.9 6054.4 6064.1 6128.9 524782.0 528638.0 529757.0 549013.0 549235.0 69787.7 91635.5 92794.0 92808.0 96392.5 427.0 431.2 433.9 434.0 434.9 10276.4 10320.8 10358.3 10364.8 10509.2 37615.0 38949.2 39142.2 39144.2 39799.8 56511.7 57656.4 57760.4 57994.0 59956.0 7599.1 7870.5 7888.6 7979.0 8061.8 9360.6 12036.2 12196.8 12424.4 12731.2 10278.7 10326.4 10406.6 10523.2 11201.2 8072.3 10372.8 10857.8 10931.4 10947.2 10399.5 10601.2 10659.8 10962.3 11034.0 7710.2 7738.2 7840.4 7893.6 7965.6 10382.2 10445.6 10521.1 10726.6 10982.9 20:41:22 INFO - PROCESS | 10177 | 20:41:22 INFO - PROCESS | 10177 | [#3] mootools.html Cycles:180 Average:4893.10 Median:4818.43 stddev:2778.79 (57.7%) stddev-sans-first:2773.73 20:41:22 INFO - PROCESS | 10177 | Values: 1336.1 1351.4 1351.7 1352.9 1357.4 6986.3 7372.0 7412.5 7600.2 7772.9 7784.2 7840.3 7956.5 7959.4 7966.8 2033.6 2101.7 2103.7 2105.6 2107.1 2043.8 2093.2 2093.8 2095.8 2100.0 2017.7 2050.8 2074.3 2074.4 2078.0 2051.8 2069.7 2070.3 2074.2 2079.1 1737.1 1789.2 1985.5 2011.7 2054.1 7391.1 7602.2 7609.8 7615.8 7619.4 4524.6 4647.6 4655.7 4662.2 4666.1 2821.1 2834.2 2876.3 2903.1 2916.0 1053.1 1064.0 1104.8 1108.6 1162.4 10230.2 10248.4 10297.0 10346.9 10365.6 3843.2 4054.9 4096.9 4101.6 4127.1 7881.3 7957.9 7961.1 7971.2 7991.7 4538.2 4593.9 4606.0 4627.3 4628.6 4060.1 4083.4 4140.3 4166.5 4178.5 3162.6 3224.2 3320.5 3327.3 3340.3 966.1 970.4 976.2 984.7 987.9 625.0 658.0 660.9 663.2 667.5 4768.1 4771.8 4788.8 4877.0 5026.5 525.3 526.4 529.6 532.5 541.5 3049.0 3101.6 3142.8 3164.0 3200.2 8965.0 9257.2 9290.6 9403.0 9436.0 9349.2 9352.3 9364.7 9383.8 9386.9 6815.0 7020.4 7060.6 7086.0 7089.8 4761.6 4763.8 4816.5 4820.4 4841.3 8225.5 8319.2 8375.1 8441.8 8449.6 8307.5 8405.2 8614.5 8685.2 8695.3 6230.5 6372.3 6377.3 6378.3 6383.9 7230.2 7246.6 7291.5 7343.5 7369.7 6556.4 6632.0 6652.6 6762.1 6776.9 6391.8 6504.7 6562.4 6589.0 6598.0 5567.3 5615.5 5642.4 5662.7 5679.5 4225.2 4243.5 4335.3 4376.0 4452.0 4424.7 4458.4 4484.5 4487.9 4558.7 20:41:22 INFO - PROCESS | 10177 | 20:41:22 INFO - PROCESS | 10177 | [#4] prototype.html Cycles:180 Average:4264.84 Median:4851.78 stddev:1230.55 (25.4%) stddev-sans-first:1198.28 20:41:22 INFO - PROCESS | 10177 | Values: 343.1 366.2 366.3 369.5 372.0 4842.5 4944.5 4968.5 4977.0 5008.4 4772.6 4863.4 4875.5 4879.2 4891.5 3864.6 3868.3 3877.7 3884.0 3892.3 3721.7 3845.3 3849.1 3879.5 3883.8 3830.8 3836.8 3854.9 3857.1 3858.5 3846.8 3847.7 3852.7 3863.2 3872.2 3392.5 3398.8 3401.5 3409.8 3418.9 4673.9 4800.3 4839.2 4842.7 4851.2 4353.8 4367.1 4375.8 4384.6 4391.6 5154.7 5159.2 5163.1 5180.6 5189.9 3485.2 3669.2 3691.7 3693.0 3701.3 5210.7 5297.5 5353.3 5386.5 5407.5 3761.2 3763.5 3777.3 3779.5 3788.8 3799.5 3817.6 3830.1 3834.4 3837.1 4247.9 4368.4 4371.6 4400.3 4418.5 5189.6 5190.7 5216.6 5222.3 5234.8 1271.2 1273.8 1289.9 1292.0 1292.9 823.4 875.5 881.3 897.3 900.8 4355.3 4375.5 4379.4 4383.3 4421.6 5183.2 5242.0 5269.6 5275.2 5289.7 4198.0 4433.1 4461.4 4466.6 4484.3 2746.0 2759.4 2773.3 2777.4 2789.8 4861.3 4872.0 4876.7 4878.5 4902.8 5021.0 5320.1 5336.4 5351.5 5391.9 4834.9 4839.9 4852.3 4858.8 4864.6 5192.2 5198.8 5206.7 5210.3 5239.3 4889.9 5031.6 5032.4 5147.1 5148.7 4802.9 4808.7 4886.1 4972.2 4990.3 3761.0 3788.8 3790.4 3793.7 3796.7 5363.3 5365.2 5368.0 5369.4 5413.0 4897.3 5179.4 5196.0 5231.7 5265.9 5208.2 5208.6 5210.3 5210.7 5229.2 5136.5 5158.2 5164.6 5165.5 5183.5 4877.0 5151.8 5170.6 5197.1 5237.8 5078.2 5082.1 5103.9 5104.8 5107.9 20:41:22 INFO - PROCESS | 10177 | 20:41:22 INFO - PROCESS | 10177 | [#5] yui.html Cycles:180 Average:13661.03 Median:46262.77 stddev:15876.49 (34.3%) stddev-sans-first:15891.00 20:41:22 INFO - PROCESS | 10177 | Values: 657.9 660.4 712.5 735.6 756.8 11722.6 12713.8 12802.0 12804.0 12814.4 12714.0 12993.2 13015.9 13040.2 13045.8 784.4 794.6 796.3 796.6 809.7 796.2 803.7 804.5 806.6 806.7 819.2 834.0 836.0 837.0 838.1 835.8 837.8 838.0 838.0 839.7 607.8 611.9 613.2 613.2 613.5 12829.4 13050.9 13089.1 13099.9 13811.1 12076.3 12514.2 12522.0 12642.6 13039.5 10246.7 10320.2 10332.9 10357.3 10925.6 3142.7 3164.1 3221.4 3331.2 3339.5 51360.5 54293.0 54737.5 62091.0 62674.0 9855.5 10266.3 10368.6 10376.6 10827.3 18611.5 18641.5 18742.6 18751.7 19394.4 6710.8 6980.6 6985.4 7014.4 7279.4 3456.2 3605.3 3640.0 3642.1 3669.2 2887.8 3030.5 3045.6 3048.0 3065.9 572.5 580.1 580.5 590.7 598.3 604.6 619.2 622.5 644.8 660.1 8521.5 8753.3 8769.4 8869.1 9110.4 599.5 607.7 611.9 616.4 621.7 3927.4 3983.1 4008.4 4026.0 4221.7 49358.0 49787.0 50249.5 52740.5 53188.0 42333.6 48398.8 52313.2 53825.5 54078.0 45720.8 46804.8 47095.5 47099.5 48500.0 8879.0 9391.4 9398.2 9430.7 9434.4 32068.8 32143.4 32482.8 33813.5 34165.0 38695.6 41463.4 41494.8 41615.4 41737.4 10940.8 10961.8 10965.8 11130.6 11353.3 11994.4 12071.2 12099.5 12260.0 12718.2 10987.7 11138.2 11227.2 11238.1 11522.9 11559.1 11674.9 11988.8 12004.2 12197.9 11761.6 11909.6 12072.3 12402.4 12429.9 8483.8 8692.3 8865.5 9005.3 9222.4 8031.5 8848.0 8979.3 9198.4 9309.5 20:41:22 INFO - PROCESS | 10177 | -------- Summary: end -------- 20:41:22 INFO - PROCESS | 10177 | 20:41:22 INFO - TEST-INFO | 10177: exit 0 20:41:22 INFO - TEST-OK | dromaeo_css | took 1120364ms 20:41:22 INFO - TEST-START | kraken 20:41:22 INFO - operating with platform_type : linux_ 20:41:22 INFO - Initialising browser for kraken test... 20:41:22 INFO - TEST-INFO | started process 10551 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcKHLxe/profile http://localhost:41702/getInfo.html) 20:41:25 INFO - PROCESS | 10551 | Iterating over profile /tmp/tmpcKHLxe/profile 20:41:26 INFO - PROCESS | 10551 | No birth date. Using mtime. 20:41:26 INFO - PROCESS | 10551 | Using date: /tmp/tmpcKHLxe/profile/blocklist.xml = Wed Feb 22 2017 20:41:23 GMT-0800 (PST) 20:41:26 INFO - PROCESS | 10551 | No birth date. Using mtime. 20:41:26 INFO - PROCESS | 10551 | Using date: /tmp/tmpcKHLxe/profile/places.sqlite-shm = Wed Feb 22 2017 20:41:24 GMT-0800 (PST) 20:41:26 INFO - PROCESS | 10551 | No birth date. Using mtime. 20:41:26 INFO - PROCESS | 10551 | Using date: /tmp/tmpcKHLxe/profile/sessionCheckpoints.json = Wed Feb 22 2017 20:41:26 GMT-0800 (PST) 20:41:26 INFO - PROCESS | 10551 | No birth date. Using mtime. 20:41:26 INFO - PROCESS | 10551 | Using date: /tmp/tmpcKHLxe/profile/content-prefs.sqlite = Wed Feb 22 2017 20:41:25 GMT-0800 (PST) 20:41:26 INFO - PROCESS | 10551 | No birth date. Using mtime. 20:41:26 INFO - PROCESS | 10551 | Using date: /tmp/tmpcKHLxe/profile/safebrowsing = Wed Feb 22 2017 20:41:25 GMT-0800 (PST) 20:41:26 INFO - PROCESS | 10551 | No birth date. Using mtime. 20:41:26 INFO - PROCESS | 10551 | Using date: /tmp/tmpcKHLxe/profile/places.sqlite-wal = Wed Feb 22 2017 20:41:26 GMT-0800 (PST) 20:41:26 INFO - PROCESS | 10551 | No birth date. Using mtime. 20:41:26 INFO - PROCESS | 10551 | Using date: /tmp/tmpcKHLxe/profile/extensions.ini = Wed Feb 22 2017 20:41:23 GMT-0800 (PST) 20:41:26 INFO - PROCESS | 10551 | No birth date. Using mtime. 20:41:26 INFO - PROCESS | 10551 | Using date: /tmp/tmpcKHLxe/profile/extensions = Wed Feb 22 2017 20:41:23 GMT-0800 (PST) 20:41:26 INFO - PROCESS | 10551 | No birth date. Using mtime. 20:41:26 INFO - PROCESS | 10551 | Using date: /tmp/tmpcKHLxe/profile/pluginreg.dat = Wed Feb 22 2017 20:41:25 GMT-0800 (PST) 20:41:26 INFO - PROCESS | 10551 | No birth date. Using mtime. 20:41:26 INFO - PROCESS | 10551 | Using date: /tmp/tmpcKHLxe/profile/permissions.sqlite = Wed Feb 22 2017 20:41:24 GMT-0800 (PST) 20:41:26 INFO - PROCESS | 10551 | No birth date. Using mtime. 20:41:26 INFO - PROCESS | 10551 | Using date: /tmp/tmpcKHLxe/profile/gmp = Wed Feb 22 2017 20:41:23 GMT-0800 (PST) 20:41:26 INFO - PROCESS | 10551 | No birth date. Using mtime. 20:41:26 INFO - PROCESS | 10551 | Using date: /tmp/tmpcKHLxe/profile/secmod.db = Wed Feb 22 2017 20:41:23 GMT-0800 (PST) 20:41:27 INFO - PROCESS | 10551 | No birth date. Using mtime. 20:41:27 INFO - PROCESS | 10551 | Using date: /tmp/tmpcKHLxe/profile/prefs.js = Wed Feb 22 2017 20:22:00 GMT-0800 (PST) 20:41:27 INFO - PROCESS | 10551 | No birth date. Using mtime. 20:41:27 INFO - PROCESS | 10551 | Using date: /tmp/tmpcKHLxe/profile/addons.json = Wed Feb 22 2017 20:41:25 GMT-0800 (PST) 20:41:27 INFO - PROCESS | 10551 | No birth date. Using mtime. 20:41:27 INFO - PROCESS | 10551 | Using date: /tmp/tmpcKHLxe/profile/compatibility.ini = Wed Feb 22 2017 20:41:23 GMT-0800 (PST) 20:41:27 INFO - PROCESS | 10551 | No birth date. Using mtime. 20:41:27 INFO - PROCESS | 10551 | Using date: /tmp/tmpcKHLxe/profile/directoryLinks.json = Wed Feb 22 2017 20:41:25 GMT-0800 (PST) 20:41:27 INFO - PROCESS | 10551 | Stat failure 20:41:27 INFO - PROCESS | 10551 | No birth date. Using mtime. 20:41:27 INFO - PROCESS | 10551 | Using date: /tmp/tmpcKHLxe/profile/user.js = Wed Feb 22 2017 20:41:22 GMT-0800 (PST) 20:41:27 INFO - PROCESS | 10551 | No birth date. Using mtime. 20:41:27 INFO - PROCESS | 10551 | Using date: /tmp/tmpcKHLxe/profile/startupCache = Wed Feb 22 2017 20:41:22 GMT-0800 (PST) 20:41:27 INFO - PROCESS | 10551 | No birth date. Using mtime. 20:41:27 INFO - PROCESS | 10551 | Using date: /tmp/tmpcKHLxe/profile/minidumps = Wed Feb 22 2017 20:41:22 GMT-0800 (PST) 20:41:27 INFO - PROCESS | 10551 | __metrics Screen width/height:1600/1200 20:41:27 INFO - PROCESS | 10551 | colorDepth:24 20:41:27 INFO - PROCESS | 10551 | Browser inner width/height: 1024/697 20:41:27 INFO - PROCESS | 10551 | __metrics 20:41:27 INFO - PROCESS | 10551 | No birth date. Using mtime. 20:41:27 INFO - PROCESS | 10551 | Using date: /tmp/tmpcKHLxe/profile/thumbnails = Wed Feb 22 2017 20:41:25 GMT-0800 (PST) 20:41:27 INFO - PROCESS | 10551 | No birth date. Using mtime. 20:41:27 INFO - PROCESS | 10551 | Using date: /tmp/tmpcKHLxe/profile/key3.db = Wed Feb 22 2017 20:41:23 GMT-0800 (PST) 20:41:27 INFO - PROCESS | 10551 | No birth date. Using mtime. 20:41:27 INFO - PROCESS | 10551 | Using date: /tmp/tmpcKHLxe/profile/cert8.db = Wed Feb 22 2017 20:41:23 GMT-0800 (PST) 20:41:27 INFO - PROCESS | 10551 | No birth date. Using mtime. 20:41:27 INFO - PROCESS | 10551 | Using date: /tmp/tmpcKHLxe/profile/places.sqlite = Wed Feb 22 2017 20:41:27 GMT-0800 (PST) 20:41:27 INFO - PROCESS | 10551 | No birth date. Using mtime. 20:41:27 INFO - PROCESS | 10551 | Using date: /tmp/tmpcKHLxe/profile/extensions.json = Wed Feb 22 2017 20:41:25 GMT-0800 (PST) 20:41:27 INFO - PROCESS | 10551 | No birth date. Using mtime. 20:41:27 INFO - PROCESS | 10551 | Using date: /tmp/tmpcKHLxe/profile/crashes = Wed Feb 22 2017 20:41:22 GMT-0800 (PST) 20:41:27 INFO - PROCESS | 10551 | No birth date. Using mtime. 20:41:27 INFO - PROCESS | 10551 | Using date: /tmp/tmpcKHLxe/profile/localstore.rdf = Wed Feb 22 2017 20:22:00 GMT-0800 (PST) 20:41:27 INFO - PROCESS | 10551 | No birth date. Using mtime. 20:41:27 INFO - PROCESS | 10551 | Using date: /tmp/tmpcKHLxe/profile/bookmarkbackups = Wed Feb 22 2017 20:41:25 GMT-0800 (PST) 20:41:27 INFO - PROCESS | 10551 | No birth date. Using mtime. 20:41:27 INFO - PROCESS | 10551 | Using date: /tmp/tmpcKHLxe/profile/cache2 = Wed Feb 22 2017 20:41:23 GMT-0800 (PST) 20:41:27 INFO - PROCESS | 10551 | No birth date. Using mtime. 20:41:27 INFO - PROCESS | 10551 | Using date: /tmp/tmpcKHLxe/profile/.parentlock = Wed Feb 22 2017 20:41:22 GMT-0800 (PST) 20:41:27 INFO - PROCESS | 10551 | No birth date. Using mtime. 20:41:27 INFO - PROCESS | 10551 | Using date: /tmp/tmpcKHLxe/profile/frequencyCap.json = Wed Feb 22 2017 20:41:25 GMT-0800 (PST) 20:41:28 ERROR - PROCESS | 10551 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 20:41:28 INFO - TEST-INFO | 10551: exit 0 20:41:28 INFO - Browser initialized. 20:41:28 INFO - Running cycle 1/1 for kraken test... 20:41:28 INFO - TEST-INFO | started process 10678 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcKHLxe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:41:40 INFO - PROCESS | 10678 | RSS: Main: 157401088 20:41:40 INFO - PROCESS | 10678 | 20:41:43 INFO - PROCESS | 10678 | Cycle 1(1): loaded http://localhost:41702/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41702/tests/kraken/driver.html?testName=audio-beat-detection) 20:41:44 INFO - PROCESS | 10678 | RSS: Main: 162680832 20:41:44 INFO - PROCESS | 10678 | 20:41:47 INFO - PROCESS | 10678 | Cycle 1(1): loaded http://localhost:41702/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41702/tests/kraken/driver.html?testName=audio-dft) 20:41:48 INFO - PROCESS | 10678 | RSS: Main: 162045952 20:41:48 INFO - PROCESS | 10678 | 20:41:51 INFO - PROCESS | 10678 | Cycle 1(1): loaded http://localhost:41702/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41702/tests/kraken/driver.html?testName=audio-fft) 20:41:51 INFO - PROCESS | 10678 | RSS: Main: 156463104 20:41:51 INFO - PROCESS | 10678 | 20:41:53 INFO - PROCESS | 10678 | Cycle 1(1): loaded http://localhost:41702/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41702/tests/kraken/driver.html?testName=audio-oscillator) 20:41:54 INFO - PROCESS | 10678 | RSS: Main: 156569600 20:41:54 INFO - PROCESS | 10678 | 20:41:56 INFO - PROCESS | 10678 | Cycle 1(1): loaded http://localhost:41702/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41702/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:41:57 INFO - PROCESS | 10678 | RSS: Main: 156934144 20:41:57 INFO - PROCESS | 10678 | 20:42:00 INFO - PROCESS | 10678 | Cycle 1(1): loaded http://localhost:41702/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41702/tests/kraken/driver.html?testName=imaging-darkroom) 20:42:01 INFO - PROCESS | 10678 | RSS: Main: 161951744 20:42:01 INFO - PROCESS | 10678 | 20:42:04 INFO - PROCESS | 10678 | Cycle 1(1): loaded http://localhost:41702/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41702/tests/kraken/driver.html?testName=imaging-desaturate) 20:42:05 INFO - PROCESS | 10678 | RSS: Main: 158523392 20:42:05 INFO - PROCESS | 10678 | 20:42:08 INFO - PROCESS | 10678 | Cycle 1(1): loaded http://localhost:41702/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41702/tests/kraken/driver.html?testName=json-parse-financial) 20:42:08 INFO - PROCESS | 10678 | RSS: Main: 159805440 20:42:08 INFO - PROCESS | 10678 | 20:42:10 INFO - PROCESS | 10678 | Cycle 1(1): loaded http://localhost:41702/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41702/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:42:11 INFO - PROCESS | 10678 | RSS: Main: 159330304 20:42:11 INFO - PROCESS | 10678 | 20:42:13 INFO - PROCESS | 10678 | Cycle 1(1): loaded http://localhost:41702/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41702/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:42:13 INFO - PROCESS | 10678 | RSS: Main: 159281152 20:42:13 INFO - PROCESS | 10678 | 20:42:15 INFO - PROCESS | 10678 | Cycle 1(1): loaded http://localhost:41702/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41702/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:42:16 INFO - PROCESS | 10678 | RSS: Main: 159715328 20:42:16 INFO - PROCESS | 10678 | 20:42:19 INFO - PROCESS | 10678 | Cycle 1(1): loaded http://localhost:41702/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41702/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:42:20 INFO - PROCESS | 10678 | RSS: Main: 160530432 20:42:20 INFO - PROCESS | 10678 | 20:42:23 INFO - PROCESS | 10678 | Cycle 1(1): loaded http://localhost:41702/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41702/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:42:23 INFO - PROCESS | 10678 | RSS: Main: 162951168 20:42:23 INFO - PROCESS | 10678 | 20:42:25 INFO - PROCESS | 10678 | Cycle 1(1): loaded http://localhost:41702/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41702/tests/kraken/driver.html?testName=ai-astar) 20:42:26 INFO - PROCESS | 10678 | RSS: Main: 164360192 20:42:26 INFO - PROCESS | 10678 | 20:42:26 INFO - PROCESS | 10678 | __start_tp_report 20:42:26 INFO - PROCESS | 10678 | _x_x_mozilla_page_load 20:42:26 INFO - PROCESS | 10678 | _x_x_mozilla_page_load_details 20:42:26 INFO - PROCESS | 10678 | |i|pagename|runs| 20:42:26 INFO - PROCESS | 10678 | |0;ai-astar;108;118;117;117;118;116;116;118;116;115 20:42:26 INFO - PROCESS | 10678 | |1;audio-beat-detection;154;126;129;179;134;129;133;131;151;129 20:42:26 INFO - PROCESS | 10678 | |2;audio-dft;166;166;167;172;175;164;165;166;167;167 20:42:26 INFO - PROCESS | 10678 | |3;audio-fft;77;77;78;111;80;78;77;77;91;77 20:42:26 INFO - PROCESS | 10678 | |4;audio-oscillator;84;88;107;89;87;85;104;88;87;107 20:42:26 INFO - PROCESS | 10678 | |5;imaging-gaussian-blur;114;114;114;114;114;119;115;115;117;115 20:42:26 INFO - PROCESS | 10678 | |6;imaging-darkroom;150;151;154;152;151;152;151;153;151;152 20:42:26 INFO - PROCESS | 10678 | |7;imaging-desaturate;96;96;96;96;97;97;96;101;101;101 20:42:26 INFO - PROCESS | 10678 | |8;json-parse-financial;66;67;65;65;66;66;67;67;67;65 20:42:26 INFO - PROCESS | 10678 | |9;json-stringify-tinderbox;66;65;66;69;66;66;67;66;65;67 20:42:26 INFO - PROCESS | 10678 | |10;stanford-crypto-aes;88;87;91;93;100;86;88;87;90;94 20:42:26 INFO - PROCESS | 10678 | |11;stanford-crypto-ccm;137;148;140;157;142;140;148;141;187;151 20:42:26 INFO - PROCESS | 10678 | |12;stanford-crypto-pbkdf2;188;185;185;185;184;200;188;196;189;184 20:42:26 INFO - PROCESS | 10678 | |13;stanford-crypto-sha256-iterative;77;72;71;76;72;72;74;75;70;73 20:42:26 INFO - PROCESS | 10678 | __end_tp_report 20:42:26 INFO - PROCESS | 10678 | __start_cc_report 20:42:26 INFO - PROCESS | 10678 | _x_x_mozilla_cycle_collect,894 20:42:26 INFO - PROCESS | 10678 | __end_cc_report 20:42:26 INFO - PROCESS | 10678 | __startTimestamp1487824946075__endTimestamp 20:42:26 INFO - PROCESS | 10678 | 20:42:26 INFO - PROCESS | 10678 | ------- Summary: start ------- 20:42:26 INFO - PROCESS | 10678 | Number of tests: 14 20:42:26 INFO - PROCESS | 10678 | 20:42:26 INFO - PROCESS | 10678 | [#0] ai-astar Cycles:10 Average:115.90 Median:117.00 stddev:2.96 (2.5%) stddev-sans-first:1.09 20:42:26 INFO - PROCESS | 10678 | Values: 108.0 118.0 117.0 117.0 118.0 116.0 116.0 118.0 116.0 115.0 20:42:26 INFO - PROCESS | 10678 | 20:42:26 INFO - PROCESS | 10678 | [#1] audio-beat-detection Cycles:10 Average:139.50 Median:133.50 stddev:16.87 (12.6%) stddev-sans-first:17.05 20:42:26 INFO - PROCESS | 10678 | Values: 154.0 126.0 129.0 179.0 134.0 129.0 133.0 131.0 151.0 129.0 20:42:26 INFO - PROCESS | 10678 | 20:42:26 INFO - PROCESS | 10678 | [#2] audio-dft Cycles:10 Average:167.50 Median:167.00 stddev:3.37 (2.0%) stddev-sans-first:3.54 20:42:26 INFO - PROCESS | 10678 | Values: 166.0 166.0 167.0 172.0 175.0 164.0 165.0 166.0 167.0 167.0 20:42:26 INFO - PROCESS | 10678 | 20:42:26 INFO - PROCESS | 10678 | [#3] audio-fft Cycles:10 Average:82.30 Median:77.50 stddev:10.97 (14.1%) stddev-sans-first:11.46 20:42:26 INFO - PROCESS | 10678 | Values: 77.0 77.0 78.0 111.0 80.0 78.0 77.0 77.0 91.0 77.0 20:42:26 INFO - PROCESS | 10678 | 20:42:26 INFO - PROCESS | 10678 | [#4] audio-oscillator Cycles:10 Average:92.60 Median:87.00 stddev:9.40 (10.8%) stddev-sans-first:9.44 20:42:26 INFO - PROCESS | 10678 | Values: 84.0 88.0 107.0 89.0 87.0 85.0 104.0 88.0 87.0 107.0 20:42:26 INFO - PROCESS | 10678 | 20:42:26 INFO - PROCESS | 10678 | [#5] imaging-gaussian-blur Cycles:10 Average:115.10 Median:115.00 stddev:1.66 (1.4%) stddev-sans-first:1.72 20:42:26 INFO - PROCESS | 10678 | Values: 114.0 114.0 114.0 114.0 114.0 119.0 115.0 115.0 117.0 115.0 20:42:26 INFO - PROCESS | 10678 | 20:42:26 INFO - PROCESS | 10678 | [#6] imaging-darkroom Cycles:10 Average:151.70 Median:152.00 stddev:1.16 (0.8%) stddev-sans-first:1.05 20:42:26 INFO - PROCESS | 10678 | Values: 150.0 151.0 154.0 152.0 151.0 152.0 151.0 153.0 151.0 152.0 20:42:26 INFO - PROCESS | 10678 | 20:42:26 INFO - PROCESS | 10678 | [#7] imaging-desaturate Cycles:10 Average:97.70 Median:96.00 stddev:2.31 (2.4%) stddev-sans-first:2.37 20:42:26 INFO - PROCESS | 10678 | Values: 96.0 96.0 96.0 96.0 97.0 97.0 96.0 101.0 101.0 101.0 20:42:26 INFO - PROCESS | 10678 | 20:42:26 INFO - PROCESS | 10678 | [#8] json-parse-financial Cycles:10 Average:66.10 Median:66.50 stddev:0.88 (1.3%) stddev-sans-first:0.93 20:42:26 INFO - PROCESS | 10678 | Values: 66.0 67.0 65.0 65.0 66.0 66.0 67.0 67.0 67.0 65.0 20:42:26 INFO - PROCESS | 10678 | 20:42:26 INFO - PROCESS | 10678 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.00 stddev:1.16 (1.8%) stddev-sans-first:1.22 20:42:26 INFO - PROCESS | 10678 | Values: 66.0 65.0 66.0 69.0 66.0 66.0 67.0 66.0 65.0 67.0 20:42:26 INFO - PROCESS | 10678 | 20:42:26 INFO - PROCESS | 10678 | [#10] stanford-crypto-aes Cycles:10 Average:90.40 Median:89.00 stddev:4.30 (4.8%) stddev-sans-first:4.47 20:42:26 INFO - PROCESS | 10678 | Values: 88.0 87.0 91.0 93.0 100.0 86.0 88.0 87.0 90.0 94.0 20:42:26 INFO - PROCESS | 10678 | 20:42:26 INFO - PROCESS | 10678 | [#11] stanford-crypto-ccm Cycles:10 Average:149.10 Median:148.00 stddev:14.65 (9.9%) stddev-sans-first:14.88 20:42:26 INFO - PROCESS | 10678 | Values: 137.0 148.0 140.0 157.0 142.0 140.0 148.0 141.0 187.0 151.0 20:42:26 INFO - PROCESS | 10678 | 20:42:26 INFO - PROCESS | 10678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.40 Median:188.00 stddev:5.44 (2.9%) stddev-sans-first:5.77 20:42:26 INFO - PROCESS | 10678 | Values: 188.0 185.0 185.0 185.0 184.0 200.0 188.0 196.0 189.0 184.0 20:42:26 INFO - PROCESS | 10678 | 20:42:26 INFO - PROCESS | 10678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.20 Median:73.50 stddev:2.25 (3.1%) stddev-sans-first:1.92 20:42:26 INFO - PROCESS | 10678 | Values: 77.0 72.0 71.0 76.0 72.0 72.0 74.0 75.0 70.0 73.0 20:42:26 INFO - PROCESS | 10678 | -------- Summary: end -------- 20:42:26 INFO - PROCESS | 10678 | 20:42:27 INFO - TEST-INFO | 10678: exit 0 20:42:27 INFO - TEST-OK | kraken | took 64399ms 20:42:27 INFO - SUITE-END | took 1184s 20:42:27 INFO - Completed test suite (00:19:45) 20:42:27 INFO - javascript benchmark 20:42:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6169.913806259182, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2502.0867383405057, 2533.3539947313434, 2560.8975640974354, 2561.9359516012087, 2567.5891857302845, 4410.75740834254, 4495.505494395614, 4541.704789188704, 4565.817367305308, 4612.538746125386, 4440.023194897126, 4483.977580112095, 4495.393121928539, 4535.047639995597, 4585.793639286232, 4098.549159592442, 4106.77412742299, 4125.071858831769, 4144.626983571478, 4245.8089385977555, 3850.210706805098, 4254.0, 4254.298040823276, 4266.296061149907, 4280.550542193072, 4068.206699693561, 4083.6528895043957, 4161.4382058422025, 4210.115875666113, 4226.260404429213, 4187.392828039917, 4217.219814334358, 4227.894302642428, 4247.405363249148, 4255.17024180285, 4209.91580168398, 4212.473440819897, 4225.873223803291, 4247.469066366704, 4254.127903779718, 4359.12817436514, 4419.381286619876, 4571.748553829538, 4598.333241679971, 4624.052069325814, 4764.428268607755, 4775.832845850413, 4781.115493633689, 4782.689125206885, 4786.282057691339, 4751.572358487718, 4798.424189097295, 4801.615870730368, 4804.351412559329, 4808.062427826575, 4507.954920450819, 4508.0533088051225, 4508.706934049276, 4508.962938524125, 4510.616597589242, 4837.201861692852, 4861.9027619447415, 4880.194767863334, 4885.755712214375, 4893.363862697897, 4758.286257061399, 4772.0455908817685, 4775.164346239394, 4775.307580400822, 4776.498467660915, 4777.546133117348, 4780.545848144421, 4825.638077144228, 4829.855104346875, 4841.176999910023, 4854.247591623304, 4877.780499877514, 4880.438749543777, 4889.706617602955, 4922.384701912261, 4874.46380898101, 4883.682560633548, 4885.60915126789, 4887.535684110004, 4924.089043526959, 4069.8168582413864, 4105.548389677133, 4113.629773320416, 4157.397177409259, 4167.124903770182, 3633.4186530155575, 3638.5633723953297, 3668.0646435158865, 3670.4861319415304, 3689.114612493036, 4262.4458820353775, 4270.594293542171, 4273.273543497551, 4282.678799090081, 4313.568643135662, 4687.320338550891, 4710.034442939189, 4840.782164802592, 4849.975750121297, 4923.335349727741, 4237.555056719062, 4266.274733295348, 4288.228118938621, 4295.892602684958, 4302.139572085595, 4402.053558484877, 4409.559044095629, 4410.3825464435, 4418.248897687401, 4418.8453404130705, 4443.422355093817, 4481.686281960231, 4534.365188873627, 4593.356930029865, 4641.303804429228, 4861.51384861511, 4883.096627123993, 4886.584640305614, 4915.287283343823, 4917.655764096479, 4436.356728274318, 4472.262076757299, 4577.336286238543, 4601.12578610063, 4633.606143477842, 4760.976195119002, 4812.51874812516, 4819.662623616313, 4846.830360937351, 4894.902101958012, 4656.348111264493, 4686.156491831503, 4909.140900342354, 4914.877128071684, 4970.701757894538, 4671.509491503343, 4707.388039554836, 4707.741074240949, 4824.734639594856, 4836.177849765478, 4762.261849413347, 4779.928301075417, 4781.091592597395, 4782.665213435026, 4802.327674125695, 4668.929966050444, 4682.040181762799, 4714.9292760609305, 4730.0, 4760.16697078003, 4668.276417155346, 4710.882227944328, 4774.665773395829, 4818.4217893852965, 4824.710517368969, 4739.502352253102, 4740.502247263988, 4742.170120229015, 4787.54518320759, 4794.448638406628], "value": 4464.735282421504, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [530.9858170893593, 540.9161579955107, 546.9562435005198, 559.5020431815682, 561.1050374652428, 37424.0, 39595.99999999996, 39752.0, 42691.359629605504, 42697.35953960693, 38649.613503865025, 39021.804890975574, 39050.31396232449, 39103.21793564127, 39144.41283380752, 7531.698732050711, 7674.347680447168, 7686.269804368604, 7705.8844117338285, 9324.393914395543, 9346.065393460667, 9643.80712385752, 9650.03499650033, 9663.4201947883, 9668.371555848882, 9676.709698709015, 9688.321817472779, 9697.757556061084, 9707.077827606367, 9711.75720606987, 9497.335186536946, 9540.809183816285, 9592.568334424968, 9595.66415175469, 9655.855162172538, 9402.576884040234, 9452.95273523635, 9498.287628427826, 9504.524773761354, 9525.761855953588, 32481.0, 32757.344853103044, 32806.50790238148, 32806.6719332806, 32886.506702399485, 3305.8512366943546, 3415.2315728961034, 3419.46998215277, 3462.4979377990303, 3475.6524347565296, 25080.0, 25159.0, 25263.494730105478, 25507.617385739228, 25533.0, 3328.700416962485, 3427.725781937439, 3444.3800115979116, 3546.6453354664586, 3564.091156755037, 226728.0, 226977.0, 227522.0, 228900.0, 229061.0, 38442.0, 40018.599814001485, 45952.3107153393, 46054.76972615116, 46083.0, 60330.0, 60760.69619651874, 60874.39125608776, 61160.69419652873, 66797.66601166963, 11854.525818967317, 12323.0, 12359.75280494403, 12382.876171238353, 12450.75098498043, 8136.0643525995265, 8158.755237342889, 8225.218604232588, 8243.587820608946, 8248.216419440143, 18785.342513012252, 18802.529936751416, 18852.434426967215, 18857.151428185764, 18971.43085707431, 6979.651017449107, 7023.754168604074, 7040.471964602675, 7230.98680232476, 7417.814554636069, 749.6514120933683, 768.4735955870246, 771.3713323641215, 789.0531362365185, 797.9042514898133, 26272.605910911352, 26486.867565662047, 27090.864545677145, 27203.45593088127, 27574.448511029666, 913.4336711239074, 921.7833809054866, 924.3575714878095, 936.2509992006504, 937.1425145991478, 14344.713105737826, 14477.0, 14515.274236288355, 14578.0, 14724.705505889822, 333128.0, 333389.0, 335904.0, 336721.0, 338158.0, 48393.27410088851, 48650.5134948646, 49229.261561075895, 49241.0, 49280.0, 1143.3997151495364, 1171.707073231692, 1182.1252273317855, 1184.7393573413835, 1191.8867707567767, 25339.87330063338, 26075.21774346697, 26680.733192668602, 26941.46117077608, 26993.460130797666, 41258.793706031276, 41695.0, 41738.37392439055, 41991.7900410496, 42022.1595568093, 281247.0, 281528.0, 282244.0, 282781.0, 283576.0, 29750.702492974793, 30555.08334749961, 35570.46644300286, 36823.44764828583, 38802.61197388103, 36011.0, 36414.4537831938, 39332.0, 39762.40356394714, 40566.59433405628, 31369.686303136677, 31412.214694632818, 31728.524072138476, 31901.6809831908, 32672.34655306928, 30949.845250773604, 31233.8438307807, 31989.520157197196, 32583.0, 32968.505472418416, 31574.684253158095, 31771.682283176873, 31987.840060799546, 32065.038048858572, 32073.83963080263, 27557.44885102327, 27920.720792791813, 28590.0, 28625.570616440353, 28880.85559572189, 22166.88916555407, 22610.321690349316, 22727.772722272566, 22799.202027928943, 22814.42963925915], "value": 17049.215162315315, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.1816929939229, 397.30471674569503, 397.8468289708462, 404.141199950106, 420.36734714255044, 12421.192622479533, 15639.765403518957, 16406.835931640693, 17858.374956876512, 17954.281828726867, 17397.652046959083, 17740.733888991643, 17881.91059044703, 17937.910310448464, 18228.088595570203, 5021.899562008776, 5051.217061355486, 5185.559227465651, 5280.049591073605, 5284.339457567804, 5168.948310516885, 5253.527182553569, 5255.500727430888, 5268.578513718893, 5277.577793776508, 5049.697018178903, 5077.873053173664, 5200.453952335007, 5216.087184742655, 5219.895602087975, 5102.056119617864, 5126.615503837208, 5165.483451654842, 5178.870528236786, 5185.818496352609, 4564.566366195206, 4630.953690463086, 4644.2801365788355, 4671.8364857229835, 4672.766361681936, 18049.819501804945, 20810.687839682418, 21266.043028063774, 21457.0, 21494.677579836316, 2182.9126834926583, 2216.9113235470563, 2252.8648281103024, 2255.5155570824645, 2272.9318120456414, 13079.346032698328, 13650.0, 13782.93108534451, 14266.215358155298, 14364.497242596459, 1612.0, 1655.2964989879254, 1676.5305714399988, 1689.2567270400984, 1689.3664875671623, 73526.0, 73568.26431735668, 73742.63128684375, 75342.62328688377, 76407.0, 10059.497025148714, 10230.846537301946, 10341.4312212829, 10390.220733445021, 10483.737906552396, 11963.102767292314, 14395.496157634432, 14401.423943042371, 14434.639134021734, 14464.927675361556, 6199.706108739705, 6328.968355158287, 6570.638614876132, 6610.570312929741, 6626.0, 5905.0, 5919.940800592025, 6076.878462430726, 6143.262808463013, 6147.72335244915, 3939.054626889526, 3946.506686664167, 3956.4460975463458, 4041.9797901010306, 4090.1819636072905, 1984.2559040359865, 2022.7572691277142, 2028.1583142995491, 2029.0767700696442, 2045.1410407628534, 383.20484993638314, 759.236966848314, 767.4474378447509, 793.8253584211465, 798.5089170160426, 10397.964619834993, 11210.49552770111, 11397.430128493708, 11787.292762434281, 11823.940880295544, 392.9214157168578, 396.3954968672797, 399.3670032997731, 403.76783349573526, 406.83116506649407, 5905.527557795366, 5977.910331345033, 6054.424829641177, 6064.120702498113, 6128.908066379008, 524782.0, 528638.0, 529757.0, 549013.0, 549235.0, 69787.65106174437, 91635.54182229046, 92794.04044696674, 92808.0, 96392.51803740936, 426.9594388533084, 431.1936678411391, 433.94575678040246, 433.9761313127745, 434.9238883195428, 10276.383416995004, 10320.845187322046, 10358.274920755775, 10364.792704146026, 10509.159267258754, 37615.0, 38949.22101558009, 39142.217155657294, 39144.217115658095, 39799.80100099481, 56511.71744141253, 57656.42343576678, 57760.4223957755, 57994.0, 59956.0, 7599.050118735158, 7870.527768333918, 7888.645010974635, 7979.0, 8061.838763224585, 9360.625574976924, 12036.157468977088, 12196.817047744113, 12424.440900159334, 12731.23612583248, 10278.743031424274, 10326.380417174994, 10406.595109660402, 10523.210759193244, 11201.159913006393, 8072.273495385443, 10372.792544148924, 10857.83713244286, 10931.398773067558, 10947.233693641369, 10399.48002599882, 10601.204909631655, 10659.840102398626, 10962.342259464138, 11034.0, 7710.228977102469, 7738.226177382442, 7840.3727701784865, 7893.565853878092, 7965.641546130554, 10382.169426446017, 10445.634402795866, 10521.105706015074, 10726.570937162425, 10982.890171098186], "value": 7769.349972787947, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1336.0914578086904, 1351.3851197705046, 1351.6688411339223, 1352.9188248705073, 1357.4230951845466, 6986.266442023584, 7372.004779354786, 7412.4811263211595, 7600.239976002411, 7772.922270777291, 7784.221577842227, 7840.294373506384, 7956.522608643485, 7959.403044771636, 7966.800829979254, 2033.6034473277716, 2101.7477902651704, 2103.6739305407687, 2105.589410065038, 2107.146605624717, 2043.83649308055, 2093.204582258747, 2093.811556959873, 2095.7904209578996, 2100.0339843671927, 2017.6670849309846, 2050.8359331253537, 2074.315475892959, 2074.3569493457003, 2078.023329035351, 2051.8050785175383, 2069.6998935154393, 2070.2960993262213, 2074.159965214091, 2079.12676675795, 1737.1053907237783, 1789.2127463915965, 1985.5234743661417, 2011.6781314989678, 2054.096197673034, 7391.113066432009, 7602.201768814305, 7609.80975475612, 7615.80960475987, 7619.352355049828, 4524.592786649185, 4647.55848194421, 4655.6973796703105, 4662.207424737769, 4666.136764698542, 2821.138048887745, 2834.2489240351324, 2876.2665520292403, 2903.11455006223, 2915.9562606560708, 1053.1416895230439, 1064.031731124673, 1104.7624760676492, 1108.5898217659517, 1162.3548930343657, 10230.18158547322, 10248.385096894135, 10296.970302969718, 10346.896531034668, 10365.63720269787, 3843.2121415109837, 4054.918901621951, 4096.897577560525, 4101.610347017028, 4127.071408932966, 7881.330086942559, 7957.920420795834, 7961.1242763295995, 7971.163027882105, 7991.68033278674, 4538.160440318552, 4593.908121837611, 4606.0, 4627.259638457831, 4628.583427491542, 4060.1136233272077, 4083.4079058536345, 4140.3375459926265, 4166.479190101238, 4178.477690288714, 3162.6362968258945, 3224.193951512122, 3320.4853247746637, 3327.334533093391, 3340.331933613287, 966.0580933589694, 970.369259981018, 976.2336565795816, 984.6701355045997, 987.896270891546, 624.9843753906189, 657.9967100164469, 660.867826434715, 663.171036204744, 667.4726965697045, 4768.117898188846, 4771.761411929389, 4788.832390866303, 4877.048975449824, 5026.472220416877, 525.3459442993498, 526.4235661950158, 529.6319058254553, 532.5100907165418, 541.4666553444854, 3048.9589586113652, 3101.5967924169713, 3142.842857857098, 3163.984180079131, 3200.1839530919465, 8964.955175224082, 9257.166854982948, 9290.62837486493, 9403.0, 9436.0, 9349.158575728217, 9352.251819854395, 9364.719058428122, 9383.765405864908, 9386.85919711205, 6815.0, 7020.368166864904, 7060.646967651597, 7085.999999999897, 7089.751858684921, 4761.571458568746, 4763.761811909321, 4816.494268101799, 4820.373351464427, 4841.273808928548, 8225.465344752572, 8319.168083191633, 8375.07874133857, 8441.775942488182, 8449.577521124042, 8307.460015098999, 8405.159484051546, 8614.483131011908, 8685.174908383693, 8695.260902823078, 6230.470410015199, 6372.267189273293, 6377.266614339224, 6378.330275321025, 6383.872322553616, 7230.24082471354, 7246.60143692102, 7291.489595728248, 7343.522671026366, 7369.705211791683, 6556.377144171296, 6632.0, 6652.567583107082, 6762.087118239171, 6776.898346524707, 6391.808245752635, 6504.6747662615735, 6562.376574225441, 6589.0, 6597.967010165111, 5567.276254086943, 5615.494605485526, 5642.379338272869, 5662.745176466987, 5679.460451257124, 4225.218334608107, 4243.5332113466875, 4335.28467802809, 4375.978120109507, 4452.0205554777895, 4424.668149888836, 4458.375827384104, 4484.506704262594, 4487.932681009853, 4558.658100642531], "value": 3876.676205831997, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.14727901165617, 366.1925454373107, 366.256499306408, 369.5288507153381, 371.9795411252382, 4842.491538388471, 4944.456109827916, 4968.478309777475, 4976.975115124428, 5008.373953255843, 4772.642051846108, 4863.440704318996, 4875.488073752258, 4879.219324908016, 4891.47813574226, 3864.574896761354, 3868.3423817951016, 3877.728559000871, 3883.9805800970958, 3892.2799282132755, 3721.7394782365245, 3845.288621605012, 3849.1339448624117, 3879.495665563473, 3883.825227864753, 3830.8276127574186, 3836.7889766062854, 3854.939891529824, 3857.0935830079907, 3858.498395208619, 3846.769193848364, 3847.7498962567342, 3852.728599562138, 3863.150106976461, 3872.206197729459, 3392.4572068469174, 3398.8130652814084, 3401.540791993074, 3409.8124603146816, 3418.8632454701783, 4673.883152921204, 4800.279958006292, 4839.225723884161, 4842.685225460369, 4851.223804191348, 4353.782310884475, 4367.10474352757, 4375.803088861009, 4384.6273066789045, 4391.5827996340295, 5154.716490593016, 5159.2003239497935, 5163.122269214243, 5180.559652429548, 5189.870253243661, 3485.1809824691177, 3669.2294618130227, 3691.741578089535, 3693.021349342426, 3701.2597480504005, 5210.66130701507, 5297.496737809902, 5353.277307563468, 5386.542143917811, 5407.513323800877, 3761.247750449921, 3763.5295588051495, 3777.2823163598828, 3779.4708740776314, 3788.7726736395352, 3799.4680744695765, 3817.6373244541724, 3830.138218900725, 3834.3673293906195, 3837.13664425502, 4247.941482132859, 4368.432103826546, 4371.628411585051, 4400.295952647625, 4418.536053714378, 5189.636725429259, 5190.714510701948, 5216.60875434344, 5222.2505460670345, 5234.842954711365, 1271.205496564647, 1273.796192609178, 1289.9097063205486, 1292.018066269623, 1292.8707129287184, 823.4194892600702, 875.5447167472878, 881.3478026260649, 897.264243320471, 900.8468560344758, 4355.324924636687, 4375.518692943773, 4379.37237657403, 4383.298672212431, 4421.579949904753, 5183.248428977777, 5242.0, 5269.552088072557, 5275.235090911873, 5289.682619042793, 4198.0, 4433.138082005566, 4461.420015397977, 4466.553344665507, 4484.327350897326, 2745.970261152068, 2759.351552385188, 2773.2650847525424, 2777.416742484101, 2789.762870156019, 4861.319415281863, 4871.975640121847, 4876.683015603974, 4878.487758785347, 4902.828401005948, 5020.970701006285, 5320.14877619579, 5336.439673834269, 5351.51836334724, 5391.892162156735, 4834.920983976924, 4839.902462424051, 4852.344933434012, 4858.7570621468785, 4864.640649285094, 5192.221166825007, 5198.844034678966, 5206.698325418645, 5210.296609957607, 5239.318888544465, 4889.853304400874, 5031.622628302819, 5032.421271553671, 5147.099257629825, 5148.7425628717665, 4802.8799280018275, 4808.735519546459, 4886.120498310338, 4972.229304457815, 4990.326305948795, 3761.0, 3788.753731007476, 3790.3935370340614, 3793.729100751279, 3796.715246356479, 5363.329583802025, 5365.248865158803, 5367.973160134175, 5369.436209197978, 5413.0, 4897.289892965571, 5179.378474583074, 5195.9740201298755, 5231.659942103751, 5265.894682106413, 5208.218767184952, 5208.609354298367, 5210.270562121382, 5210.713410762292, 5229.21561765723, 5136.460671629425, 5158.200478925773, 5164.612654050886, 5165.457626949266, 5183.533481986639, 4876.95123048765, 5151.845444636667, 5170.612204084633, 5197.142471492161, 5237.764300606558, 5078.187490001582, 5082.110630639697, 5103.902660927918, 5104.770285337095, 5107.897842043064], "value": 3888.615740379173, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [657.8684263147371, 660.4320284555282, 712.5404114346244, 735.5917465806477, 756.8297133145041, 11722.589709360163, 12713.809292860615, 12801.975841932646, 12803.999999999989, 12814.359282035884, 12714.0, 12993.2204067756, 13015.869841301585, 13040.152390094661, 13045.804312935314, 784.3999340504504, 794.566961006253, 796.3111908199395, 796.6494742313392, 809.7287408718087, 796.1680044353665, 803.7106641609046, 804.5494523067072, 806.6128258435925, 806.7297455352464, 819.2381085590429, 834.04501845387, 835.9707410240643, 836.9832603347929, 838.053000109875, 835.8202986357962, 837.7905523619095, 837.9790505237387, 838.0237023867187, 839.7102999465175, 607.750822162911, 611.8806832667632, 613.1507861611656, 613.1660941120073, 613.5306490534745, 12829.422675979604, 13050.934745326307, 13089.149205301625, 13099.86900130996, 13811.102278351875, 12076.335801530913, 12514.249145051326, 12522.0, 12642.55751048709, 13039.54361597349, 10246.69259922196, 10320.225983051301, 10332.896671033268, 10357.326773759756, 10925.617603383844, 3142.670019647927, 3164.0507847645845, 3221.4040402525607, 3331.1505566080737, 3339.4990751387245, 51360.486395135944, 54292.99999999961, 54737.452625473634, 62091.0, 62674.0, 9855.507224638739, 10266.332688375382, 10368.637097701696, 10376.636817711344, 10827.296225745302, 18611.534711632048, 18641.533961650795, 18742.625147497245, 18751.718724219147, 19394.418167455, 6710.765123220664, 6980.581165130007, 6985.406240469617, 7014.368706816411, 7279.398532322881, 3456.1705190754037, 3605.296967091392, 3639.9636003640153, 3642.0712718256673, 3669.156094098319, 2887.7978541501893, 3030.530267808493, 3045.6040714707387, 3048.039867441793, 3065.8773649054233, 572.530524969521, 580.1413907416962, 580.5210701171551, 590.734169623671, 598.332858862374, 604.5737754882884, 619.2228752915063, 622.4771192198575, 644.7614382678345, 660.0791895306021, 8521.53131577769, 8753.343499237582, 8769.429987050822, 8869.068747781519, 9110.362274640844, 599.5293694449836, 607.7068731349991, 611.944924956756, 616.4236438929615, 621.7326549583722, 3927.3912543555793, 3983.063979964706, 4008.3586626139677, 4026.0, 4221.746695198298, 49358.012839743, 49787.0, 50249.49750502521, 52740.47259527355, 53188.0, 42333.57666423296, 48398.75800620974, 52313.17792293396, 53825.46174538205, 54078.0, 45720.77139614281, 46804.7659761699, 47095.5290447098, 47099.5290047102, 48500.0, 8878.955605221932, 9391.436513809193, 9398.248140148635, 9430.669926552539, 9434.386764860263, 32068.839655802505, 32143.35713285768, 32482.837585811918, 33813.49279760756, 34165.0, 38695.6130438692, 41463.37804932989, 41494.79252603718, 41615.37576936288, 41737.37393939154, 10940.846927005994, 10961.83557246626, 10965.780684386427, 11130.610428634958, 11353.318800871974, 11994.400279986141, 12071.215371000857, 12099.455524501594, 12260.0, 12718.236905785683, 10987.725306867073, 11138.164637652371, 11227.157963152633, 11238.100951923663, 11522.884771152181, 11559.143789194637, 11674.88325116772, 11988.820167697317, 12004.159708820298, 12197.939010305246, 11761.647150585497, 11909.583164589198, 12072.3360215189, 12402.441890114786, 12429.937850310691, 8483.787905302417, 8692.261157801659, 8865.468071915706, 9005.279577633642, 9222.40054396462, 8031.477953932976, 8848.0, 8979.32655050887, 9198.356115071882, 9309.534523273946], "value": 6187.07006195812, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1595.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 118.0, 117.0, 117.0, 118.0, 116.0, 116.0, 118.0, 116.0, 115.0], "value": 115.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 126.0, 129.0, 179.0, 134.0, 129.0, 133.0, 131.0, 151.0, 129.0], "value": 139.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 167.0, 172.0, 175.0, 164.0, 165.0, 166.0, 167.0, 167.0], "value": 167.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 78.0, 111.0, 80.0, 78.0, 77.0, 77.0, 91.0, 77.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 88.0, 107.0, 89.0, 87.0, 85.0, 104.0, 88.0, 87.0, 107.0], "value": 92.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 119.0, 115.0, 115.0, 117.0, 115.0], "value": 115.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 154.0, 152.0, 151.0, 152.0, 151.0, 153.0, 151.0, 152.0], "value": 151.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 97.0, 97.0, 96.0, 101.0, 101.0, 101.0], "value": 97.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 65.0, 65.0, 66.0, 66.0, 67.0, 67.0, 67.0, 65.0], "value": 66.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 69.0, 66.0, 66.0, 67.0, 66.0, 65.0, 67.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 91.0, 93.0, 100.0, 86.0, 88.0, 87.0, 90.0, 94.0], "value": 90.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 148.0, 140.0, 157.0, 142.0, 140.0, 148.0, 141.0, 187.0, 151.0], "value": 149.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 185.0, 185.0, 185.0, 184.0, 200.0, 188.0, 196.0, 189.0, 184.0], "value": 188.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 72.0, 71.0, 76.0, 72.0, 72.0, 74.0, 75.0, 70.0, 73.0], "value": 73.2, "unit": "score"}]}]} 20:42:27 INFO - Return code: 0 20:42:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:42:27 ERROR - # TBPL SUCCESS # 20:42:27 INFO - Running post-action listener: _resource_record_post_action 20:42:27 INFO - [mozharness: 2017-02-23 04:42:27.906554Z] Finished run-tests step (success) 20:42:27 INFO - Running post-run listener: _resource_record_post_run 20:42:27 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 8192; Write bytes: 363122688; Read time: 20; Write time: 211532 20:42:27 INFO - TinderboxPrint: CPU usage
13.5% 20:42:27 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 20:42:27 INFO - TinderboxPrint: I/O write bytes / time
363,122,688 / 211,532 20:42:27 INFO - TinderboxPrint: CPU idle
8,291.5 (86.5%) 20:42:27 INFO - TinderboxPrint: CPU user
1,235.7 (12.9%) 20:42:27 INFO - TinderboxPrint: Swap in / out
0 / 0 20:42:27 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 105123840; Read time: 0; Write time: 69964 20:42:27 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 8192; Write bytes: 257998848; Read time: 20; Write time: 141568 20:42:28 INFO - Running post-run listener: _upload_blobber_files 20:42:28 INFO - Blob upload gear active. 20:42:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:42:28 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 20:42:28 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:42:28 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:42:28 INFO - (blobuploader) - INFO - Open directory for files ... 20:42:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:42:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:42:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:42:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:42:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:42:29 INFO - (blobuploader) - INFO - Done attempting. 20:42:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:42:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:42:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:42:30 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:42:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:42:30 INFO - (blobuploader) - INFO - Done attempting. 20:42:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:42:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:42:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:42:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:42:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:42:34 INFO - (blobuploader) - INFO - Done attempting. 20:42:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:42:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:42:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:42:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:42:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:42:34 INFO - (blobuploader) - INFO - Done attempting. 20:42:34 INFO - (blobuploader) - INFO - Iteration through files over. 20:42:34 INFO - Return code: 0 20:42:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:42:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:42:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/60e7d5d839bc03c75b5eea37d929b3cbb53b0b6c78fa29d37e472cba59a01b7623bb0f5b46399f44d0b53db83e153f0aacb7db141debd001262b5d92ba1957a7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7799924b537308ae818dfcb35018216c94e0e524464baf0bd4c5b9b9b0c2a8048bfc4a0eb9d693f9ec0b9c5aed37767199c282671456d2110a28043f86d3ed27", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dafa76d756c78ea06c4a315d8cfb4ff7423d8e7b77ed13e929eb114cc638d681c86fa07118f8b17132f0b352d02b3354c27804375b851d7dd53edf47fb2489d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1487a0f2c9cc0cc2a830fb14a5a45822a5336dde9928b8c3aebc1c8144a773d30ff37ceb106481e0a4a61c74f26ecf2ceaf8fe2bbe673b84edd7bdf02e6ccc8d"} 20:42:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:42:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:42:34 INFO - Contents: 20:42:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/60e7d5d839bc03c75b5eea37d929b3cbb53b0b6c78fa29d37e472cba59a01b7623bb0f5b46399f44d0b53db83e153f0aacb7db141debd001262b5d92ba1957a7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7799924b537308ae818dfcb35018216c94e0e524464baf0bd4c5b9b9b0c2a8048bfc4a0eb9d693f9ec0b9c5aed37767199c282671456d2110a28043f86d3ed27", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dafa76d756c78ea06c4a315d8cfb4ff7423d8e7b77ed13e929eb114cc638d681c86fa07118f8b17132f0b352d02b3354c27804375b851d7dd53edf47fb2489d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1487a0f2c9cc0cc2a830fb14a5a45822a5336dde9928b8c3aebc1c8144a773d30ff37ceb106481e0a4a61c74f26ecf2ceaf8fe2bbe673b84edd7bdf02e6ccc8d"} 20:42:34 INFO - Running post-run listener: copy_logs_to_upload_dir 20:42:34 INFO - Copying logs to upload dir... 20:42:34 INFO - mkdir: /builds/slave/test/build/upload/logs 20:42:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.071665 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-02-22 20:42:34.584559) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-22 20:42:34.592699) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1487821811.660450-639367694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/60e7d5d839bc03c75b5eea37d929b3cbb53b0b6c78fa29d37e472cba59a01b7623bb0f5b46399f44d0b53db83e153f0aacb7db141debd001262b5d92ba1957a7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7799924b537308ae818dfcb35018216c94e0e524464baf0bd4c5b9b9b0c2a8048bfc4a0eb9d693f9ec0b9c5aed37767199c282671456d2110a28043f86d3ed27", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dafa76d756c78ea06c4a315d8cfb4ff7423d8e7b77ed13e929eb114cc638d681c86fa07118f8b17132f0b352d02b3354c27804375b851d7dd53edf47fb2489d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1487a0f2c9cc0cc2a830fb14a5a45822a5336dde9928b8c3aebc1c8144a773d30ff37ceb106481e0a4a61c74f26ecf2ceaf8fe2bbe673b84edd7bdf02e6ccc8d"} build_url:https://queue.taskcluster.net/v1/task/fziZoBLZQf6J64GfmjMy5g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011343 build_url: 'https://queue.taskcluster.net/v1/task/fziZoBLZQf6J64GfmjMy5g/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/60e7d5d839bc03c75b5eea37d929b3cbb53b0b6c78fa29d37e472cba59a01b7623bb0f5b46399f44d0b53db83e153f0aacb7db141debd001262b5d92ba1957a7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7799924b537308ae818dfcb35018216c94e0e524464baf0bd4c5b9b9b0c2a8048bfc4a0eb9d693f9ec0b9c5aed37767199c282671456d2110a28043f86d3ed27", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dafa76d756c78ea06c4a315d8cfb4ff7423d8e7b77ed13e929eb114cc638d681c86fa07118f8b17132f0b352d02b3354c27804375b851d7dd53edf47fb2489d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1487a0f2c9cc0cc2a830fb14a5a45822a5336dde9928b8c3aebc1c8144a773d30ff37ceb106481e0a4a61c74f26ecf2ceaf8fe2bbe673b84edd7bdf02e6ccc8d"}' ========= master_lag: 0.05 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-22 20:42:34.652198) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 20:42:34.652509) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1487821811.660450-639367694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 20:42:34.704263) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-22 20:42:34.707583) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-22 20:42:34.707880) ========= ========= Total master_lag: 0.18 =========