builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-070 starttime: 1490191331.51 results: success (0) revision: 27f7aadeea833eca8c9c0e24c858f798e4d6fdd8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-22 07:02:11.515204) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-22 07:02:11.515730) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-22 07:02:11.516040) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-22 07:02:11.531088) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 07:02:11.531447) ========= 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=2432103b8b3de4003b23cad4000001c2-1490191309.938043-1710955734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-22 07:02:12-- 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% 37.7M=0s 2017-03-22 07:02:12 (37.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.102641 ========= master_lag: 0.18 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 07:02:11.818321) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 07:02:11.818932) ========= 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=2432103b8b3de4003b23cad4000001c2-1490191309.938043-1710955734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014912 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 07:02:11.866332) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-22 07:02:11.866656) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 27f7aadeea833eca8c9c0e24c858f798e4d6fdd8 --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 27f7aadeea833eca8c9c0e24c858f798e4d6fdd8 --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=2432103b8b3de4003b23cad4000001c2-1490191309.938043-1710955734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-22 07:02:12,882 truncating revision to first 12 chars 2017-03-22 07:02:12,883 Setting DEBUG logging. 2017-03-22 07:02:12,883 attempt 1/10 2017-03-22 07:02:12,883 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/27f7aadeea83?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-22 07:02:14,138 unpacking tar archive at: mozilla-central-27f7aadeea83/testing/mozharness/ program finished with exit code 0 elapsedTime=1.553333 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-22 07:02:13.446557) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-22 07:02:13.446881) ========= script_repo_revision: 27f7aadeea833eca8c9c0e24c858f798e4d6fdd8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-22 07:02:13.447283) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-22 07:02:13.447541) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-22 07:02:13.455782) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-03-22 07:02:13.456094) ========= /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=2432103b8b3de4003b23cad4000001c2-1490191309.938043-1710955734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:02:14 INFO - MultiFileLogger online at 20170322 07:02:14 in /builds/slave/test 07:02:14 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 07:02:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:02:14 INFO - {'append_to_log': False, 07:02:14 INFO - 'base_work_dir': '/builds/slave/test', 07:02:14 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:02:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:02:14 INFO - 'branch': 'Firefox-Non-PGO', 07:02:14 INFO - 'buildbot_json_path': 'buildprops.json', 07:02:14 INFO - 'config_files': ('talos/linux_config.py',), 07:02:14 INFO - 'default_actions': ('clobber', 07:02:14 INFO - 'read-buildbot-config', 07:02:14 INFO - 'download-and-extract', 07:02:14 INFO - 'populate-webroot', 07:02:14 INFO - 'create-virtualenv', 07:02:14 INFO - 'install', 07:02:14 INFO - 'run-tests'), 07:02:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:02:14 INFO - 'download_minidump_stackwalk': True, 07:02:14 INFO - 'download_symbols': 'ondemand', 07:02:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:02:14 INFO - 'tooltool.py': '/tools/tooltool.py', 07:02:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:02:14 INFO - '/tools/misc-python/virtualenv.py')}, 07:02:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:02:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:02:14 INFO - 'gecko_profile': False, 07:02:14 INFO - 'gecko_profile_interval': 0, 07:02:14 INFO - 'installer_path': 'installer.exe', 07:02:14 INFO - 'log_level': 'info', 07:02:14 INFO - 'log_name': 'talos', 07:02:14 INFO - 'log_to_console': True, 07:02:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:02:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:02:14 INFO - 'opt_config_files': (), 07:02:14 INFO - 'pip_index': False, 07:02:14 INFO - 'suite': 'dromaeojs-e10s', 07:02:14 INFO - 'system_bits': '32', 07:02:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:02:14 INFO - 'title': 'talos-linux64-ix-070', 07:02:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:02:14 INFO - 'use_talos_json': True, 07:02:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:02:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:02:14 INFO - 'work_dir': 'build'} 07:02:14 INFO - [mozharness: 2017-03-22 14:02:14.565889Z] Running clobber step. 07:02:14 INFO - Running pre-action listener: _resource_record_pre_action 07:02:14 INFO - Running main action method: clobber 07:02:14 INFO - rmtree: /builds/slave/test/build 07:02:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:02:16 INFO - Running post-action listener: _resource_record_post_action 07:02:16 INFO - [mozharness: 2017-03-22 14:02:16.028124Z] Finished clobber step (success) 07:02:16 INFO - [mozharness: 2017-03-22 14:02:16.028222Z] Running read-buildbot-config step. 07:02:16 INFO - Running pre-action listener: _resource_record_pre_action 07:02:16 INFO - Running main action method: read_buildbot_config 07:02:16 INFO - Using buildbot properties: 07:02:16 INFO - { 07:02:16 INFO - "project": "", 07:02:16 INFO - "product": "firefox", 07:02:16 INFO - "who": "cbook@mozilla.com", 07:02:16 INFO - "installer_path": "public/build/target.tar.bz2", 07:02:16 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:02:16 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 07:02:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 07:02:16 INFO - "stage_platform": "linux64", 07:02:16 INFO - "basedir": "/builds/slave/test", 07:02:16 INFO - "buildnumber": 766, 07:02:16 INFO - "platform": "ubuntu64_hw", 07:02:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:02:16 INFO - "slavebuilddir": "test", 07:02:16 INFO - "taskId": "WvNe85jaSWKCtJ2lkncKYw", 07:02:16 INFO - "branch": "mozilla-central", 07:02:16 INFO - "script_repo_revision": "production", 07:02:16 INFO - "revision": "27f7aadeea833eca8c9c0e24c858f798e4d6fdd8", 07:02:16 INFO - "slavename": "talos-linux64-ix-070", 07:02:16 INFO - "repo_path": "mozilla-central" 07:02:16 INFO - } 07:02:16 INFO - Finding installer, test and symbols from parent task. 07:02:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WvNe85jaSWKCtJ2lkncKYw'}, attempt #1 07:02:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WvNe85jaSWKCtJ2lkncKYw'}, attempt #1 07:02:16 INFO - Task dependencies: MUCxLFXLQvKtAGf9VyDhNQ 07:02:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MUCxLFXLQvKtAGf9VyDhNQ'}, attempt #1 07:02:17 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/MUCxLFXLQvKtAGf9VyDhNQ/artifacts/public/build/target.tar.bz2 07:02:17 INFO - Set test_url: https://queue.taskcluster.net/v1/task/MUCxLFXLQvKtAGf9VyDhNQ/artifacts/public/build/test_packages.json 07:02:17 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/MUCxLFXLQvKtAGf9VyDhNQ/artifacts/public/build/target.crashreporter-symbols.zip 07:02:17 INFO - Running post-action listener: _resource_record_post_action 07:02:17 INFO - [mozharness: 2017-03-22 14:02:17.398748Z] Finished read-buildbot-config step (success) 07:02:17 INFO - [mozharness: 2017-03-22 14:02:17.398972Z] Running download-and-extract step. 07:02:17 INFO - Running pre-action listener: _resource_record_pre_action 07:02:17 INFO - Running main action method: download_and_extract 07:02:17 INFO - mkdir: /builds/slave/test/build/tests 07:02:17 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')]} 07:02:17 INFO - trying https://queue.taskcluster.net/v1/task/MUCxLFXLQvKtAGf9VyDhNQ/artifacts/public/build/target.test_packages.json 07:02:17 INFO - Downloading https://queue.taskcluster.net/v1/task/MUCxLFXLQvKtAGf9VyDhNQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:02:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MUCxLFXLQvKtAGf9VyDhNQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:02:17 INFO - Downloaded 986 bytes. 07:02:17 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:02:17 INFO - Using the following test package requirements: 07:02:17 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:02:17 INFO - u'common': [u'target.common.tests.zip'], 07:02:17 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:02:17 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:02:17 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:02:17 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:02:17 INFO - u'mozbase': [u'target.common.tests.zip'], 07:02:17 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:02:17 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:02:17 INFO - u'web-platform': [u'target.common.tests.zip', 07:02:17 INFO - u'target.web-platform.tests.zip'], 07:02:17 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:02:17 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 07:02:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MUCxLFXLQvKtAGf9VyDhNQ/artifacts/public/build/target.common.tests.zip 07:02:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MUCxLFXLQvKtAGf9VyDhNQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:02:17 INFO - Fetch https://queue.taskcluster.net/v1/task/MUCxLFXLQvKtAGf9VyDhNQ/artifacts/public/build/target.common.tests.zip into memory 07:02:19 INFO - Expected file size: 58119317 07:02:19 INFO - Obtained file size: 58119317 07:02:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 07:02:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MUCxLFXLQvKtAGf9VyDhNQ/artifacts/public/build/target.common.tests.zip 07:02:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MUCxLFXLQvKtAGf9VyDhNQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:02:29 INFO - Fetch https://queue.taskcluster.net/v1/task/MUCxLFXLQvKtAGf9VyDhNQ/artifacts/public/build/target.common.tests.zip into memory 07:02:31 INFO - Expected file size: 58119317 07:02:31 INFO - Obtained file size: 58119317 07:02:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MUCxLFXLQvKtAGf9VyDhNQ/artifacts/public/build/target.talos.tests.zip 07:02:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MUCxLFXLQvKtAGf9VyDhNQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:02:42 INFO - Fetch https://queue.taskcluster.net/v1/task/MUCxLFXLQvKtAGf9VyDhNQ/artifacts/public/build/target.talos.tests.zip into memory 07:02:42 INFO - Expected file size: 14404171 07:02:42 INFO - Obtained file size: 14404171 07:02:43 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')]} 07:02:43 INFO - trying https://queue.taskcluster.net/v1/task/MUCxLFXLQvKtAGf9VyDhNQ/artifacts/public/build/target.tar.bz2 07:02:43 INFO - Downloading https://queue.taskcluster.net/v1/task/MUCxLFXLQvKtAGf9VyDhNQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:02:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MUCxLFXLQvKtAGf9VyDhNQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:02:44 INFO - Downloaded 61918756 bytes. 07:02:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MUCxLFXLQvKtAGf9VyDhNQ/artifacts/public/build/target.tar.bz2 07:02:44 INFO - mkdir: /builds/slave/test/properties 07:02:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:02:44 INFO - Writing to file /builds/slave/test/properties/build_url 07:02:44 INFO - Contents: 07:02:44 INFO - build_url:https://queue.taskcluster.net/v1/task/MUCxLFXLQvKtAGf9VyDhNQ/artifacts/public/build/target.tar.bz2 07:02:44 INFO - Running post-action listener: _resource_record_post_action 07:02:44 INFO - Running post-action listener: set_extra_try_arguments 07:02:44 INFO - [mozharness: 2017-03-22 14:02:44.537005Z] Finished download-and-extract step (success) 07:02:44 INFO - [mozharness: 2017-03-22 14:02:44.537157Z] Running populate-webroot step. 07:02:44 INFO - Running pre-action listener: _resource_record_pre_action 07:02:44 INFO - Running main action method: populate_webroot 07:02:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:02:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:02:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:02:44 INFO - '--tppagecycles', 07:02:44 INFO - '7'], 07:02:44 INFO - 'tests': ['tsvgm']}}, 07:02:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:02:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:02:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:02:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:02:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:02:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:02:44 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:02:44 INFO - 'talos_options': ['--disable-e10s'], 07:02:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:02:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:02:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:02:44 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:02:44 INFO - 'talos_options': ['--disable-e10s'], 07:02:44 INFO - 'tests': ['damp', 'tps']}, 07:02:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:02:44 INFO - 'tests': ['damp', 'tps']}, 07:02:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:02:44 INFO - 'tests': ['dromaeo_dom']}, 07:02:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:02:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:02:44 INFO - 'tests': ['basic_compositor_video']}, 07:02:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:02:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:02:44 INFO - 'tests': ['a11yr', 07:02:44 INFO - 'ts_paint', 07:02:44 INFO - 'tpaint', 07:02:44 INFO - 'sessionrestore', 07:02:44 INFO - 'sessionrestore_no_auto_restore', 07:02:44 INFO - 'tabpaint']}, 07:02:44 INFO - 'other-e10s': {'tests': ['a11yr', 07:02:44 INFO - 'ts_paint', 07:02:44 INFO - 'tpaint', 07:02:44 INFO - 'sessionrestore', 07:02:44 INFO - 'sessionrestore_no_auto_restore', 07:02:44 INFO - 'tabpaint']}, 07:02:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:02:44 INFO - 'ts_paint', 07:02:44 INFO - 'tpaint', 07:02:44 INFO - 'sessionrestore', 07:02:44 INFO - 'sessionrestore_no_auto_restore', 07:02:44 INFO - 'tabpaint']}, 07:02:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:02:44 INFO - 'ts_paint', 07:02:44 INFO - 'tpaint', 07:02:44 INFO - 'sessionrestore', 07:02:44 INFO - 'sessionrestore_no_auto_restore', 07:02:44 INFO - 'tabpaint']}, 07:02:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:02:44 INFO - 'tests': ['a11yr', 07:02:44 INFO - 'ts_paint', 07:02:44 INFO - 'tpaint', 07:02:44 INFO - 'sessionrestore', 07:02:44 INFO - 'sessionrestore_no_auto_restore', 07:02:44 INFO - 'tabpaint']}, 07:02:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:02:44 INFO - 'tests': ['a11yr', 07:02:44 INFO - 'ts_paint', 07:02:44 INFO - 'tpaint', 07:02:44 INFO - 'sessionrestore', 07:02:44 INFO - 'sessionrestore_no_auto_restore', 07:02:44 INFO - 'tabpaint']}, 07:02:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:02:44 INFO - 'tests': ['tsvgx', 07:02:44 INFO - 'tsvgr_opacity', 07:02:44 INFO - 'tart', 07:02:44 INFO - 'tscrollx', 07:02:44 INFO - 'cart', 07:02:44 INFO - 'tsvg_static']}, 07:02:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:02:44 INFO - 'tsvgr_opacity', 07:02:44 INFO - 'tart', 07:02:44 INFO - 'tscrollx', 07:02:44 INFO - 'cart', 07:02:44 INFO - 'tsvg_static']}, 07:02:44 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:02:44 INFO - 'talos_options': ['--disable-e10s'], 07:02:44 INFO - 'tests': ['tp5o']}, 07:02:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:02:44 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:02:44 INFO - 'talos_options': ['--disable-e10s', 07:02:44 INFO - '--xperf_path', 07:02:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:02:44 INFO - 'tests': ['tp5n']}, 07:02:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:02:44 INFO - 'talos_options': ['--xperf_path', 07:02:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:02:44 INFO - 'tests': ['tp5n']}}, 07:02:44 INFO - 'talos.zip': {'path': '', 07:02:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:02:44 INFO - Running post-action listener: _resource_record_post_action 07:02:44 INFO - [mozharness: 2017-03-22 14:02:44.550984Z] Finished populate-webroot step (success) 07:02:44 INFO - [mozharness: 2017-03-22 14:02:44.551073Z] Running create-virtualenv step. 07:02:44 INFO - Running pre-action listener: _resource_record_pre_action 07:02:44 INFO - Running main action method: create_virtualenv 07:02:44 INFO - Creating virtualenv /builds/slave/test/build/venv 07:02:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:02:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:02:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:02:44 INFO - Using real prefix '/usr' 07:02:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:02:45 INFO - Installing distribute.............................................................................................................................................................................................done. 07:02:47 INFO - Installing pip.................done. 07:02:47 INFO - Return code: 0 07:02:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:02:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:02:47 INFO - Reading from file tmpfile_stdout 07:02:47 INFO - Output received: 07:02:47 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:02:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:02:47 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')]} 07:02:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:47 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')]} 07:02:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:47 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 0x226c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2364a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2509b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2507290>, '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 0x2507b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2508040>, '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': '2432103b8b3de4003b23cad4000001c2-1490191309.938043-1710955734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:02:47 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 07:02:47 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 07:02:47 INFO - Using env: {'DISPLAY': ':0', 07:02:47 INFO - 'HOME': '/home/cltbld', 07:02:47 INFO - 'LANG': 'en_US.UTF-8', 07:02:47 INFO - 'LANGUAGE': 'en_US:en', 07:02:47 INFO - 'LOGNAME': 'cltbld', 07:02:47 INFO - 'MAIL': '/var/mail/cltbld', 07:02:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:47 INFO - 'MOZ_NO_REMOTE': '1', 07:02:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:47 INFO - 'NO_EM_RESTART': '1', 07:02:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:47 INFO - 'PWD': '/builds/slave/test', 07:02:47 INFO - 'SHELL': '/bin/bash', 07:02:47 INFO - 'SHLVL': '1', 07:02:47 INFO - 'TERM': 'linux', 07:02:47 INFO - 'TMOUT': '86400', 07:02:47 INFO - 'USER': 'cltbld', 07:02:47 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490191309.938043-1710955734', 07:02:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:47 INFO - '_': '/tools/buildbot/bin/python'} 07:02:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:02:47 INFO - Cleaning up... 07:02:47 INFO - Return code: 0 07:02:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:02:47 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')]} 07:02:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:47 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')]} 07:02:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:47 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 0x226c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2364a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2509b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2507290>, '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 0x2507b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2508040>, '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': '2432103b8b3de4003b23cad4000001c2-1490191309.938043-1710955734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:02:47 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 07:02:47 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 07:02:47 INFO - Using env: {'DISPLAY': ':0', 07:02:47 INFO - 'HOME': '/home/cltbld', 07:02:47 INFO - 'LANG': 'en_US.UTF-8', 07:02:47 INFO - 'LANGUAGE': 'en_US:en', 07:02:47 INFO - 'LOGNAME': 'cltbld', 07:02:47 INFO - 'MAIL': '/var/mail/cltbld', 07:02:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:47 INFO - 'MOZ_NO_REMOTE': '1', 07:02:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:47 INFO - 'NO_EM_RESTART': '1', 07:02:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:47 INFO - 'PWD': '/builds/slave/test', 07:02:47 INFO - 'SHELL': '/bin/bash', 07:02:47 INFO - 'SHLVL': '1', 07:02:47 INFO - 'TERM': 'linux', 07:02:47 INFO - 'TMOUT': '86400', 07:02:47 INFO - 'USER': 'cltbld', 07:02:47 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490191309.938043-1710955734', 07:02:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:47 INFO - '_': '/tools/buildbot/bin/python'} 07:02:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:47 INFO - Downloading/unpacking psutil>=3.1.1 07:02:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:47 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 07:02:47 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 07:02:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:02:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:02:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:02:50 INFO - Installing collected packages: psutil 07:02:50 INFO - Running setup.py install for psutil 07:02:50 INFO - building 'psutil._psutil_linux' extension 07:02:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:02:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:02:50 INFO - building 'psutil._psutil_posix' extension 07:02:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:02:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:02:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:02:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:02:50 INFO - Successfully installed psutil 07:02:50 INFO - Cleaning up... 07:02:50 INFO - Return code: 0 07:02:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:02:50 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')]} 07:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:50 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')]} 07:02:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x226c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2364a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2509b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2507290>, '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 0x2507b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2508040>, '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': '2432103b8b3de4003b23cad4000001c2-1490191309.938043-1710955734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:02:50 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 07:02:50 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 07:02:50 INFO - Using env: {'DISPLAY': ':0', 07:02:50 INFO - 'HOME': '/home/cltbld', 07:02:50 INFO - 'LANG': 'en_US.UTF-8', 07:02:50 INFO - 'LANGUAGE': 'en_US:en', 07:02:50 INFO - 'LOGNAME': 'cltbld', 07:02:50 INFO - 'MAIL': '/var/mail/cltbld', 07:02:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:50 INFO - 'MOZ_NO_REMOTE': '1', 07:02:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:50 INFO - 'NO_EM_RESTART': '1', 07:02:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:50 INFO - 'PWD': '/builds/slave/test', 07:02:50 INFO - 'SHELL': '/bin/bash', 07:02:50 INFO - 'SHLVL': '1', 07:02:50 INFO - 'TERM': 'linux', 07:02:50 INFO - 'TMOUT': '86400', 07:02:50 INFO - 'USER': 'cltbld', 07:02:50 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490191309.938043-1710955734', 07:02:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:50 INFO - '_': '/tools/buildbot/bin/python'} 07:02:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:50 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 07:02:50 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 07:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:02:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:02:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:02:52 INFO - Installing collected packages: mozsystemmonitor 07:02:52 INFO - Running setup.py install for mozsystemmonitor 07:02:53 INFO - Successfully installed mozsystemmonitor 07:02:53 INFO - Cleaning up... 07:02:53 INFO - Return code: 0 07:02:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:02:53 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')]} 07:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:53 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')]} 07:02:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:53 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 0x226c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2364a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2509b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2507290>, '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 0x2507b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2508040>, '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': '2432103b8b3de4003b23cad4000001c2-1490191309.938043-1710955734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:02:53 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 07:02:53 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 07:02:53 INFO - Using env: {'DISPLAY': ':0', 07:02:53 INFO - 'HOME': '/home/cltbld', 07:02:53 INFO - 'LANG': 'en_US.UTF-8', 07:02:53 INFO - 'LANGUAGE': 'en_US:en', 07:02:53 INFO - 'LOGNAME': 'cltbld', 07:02:53 INFO - 'MAIL': '/var/mail/cltbld', 07:02:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:53 INFO - 'MOZ_NO_REMOTE': '1', 07:02:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:53 INFO - 'NO_EM_RESTART': '1', 07:02:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:53 INFO - 'PWD': '/builds/slave/test', 07:02:53 INFO - 'SHELL': '/bin/bash', 07:02:53 INFO - 'SHLVL': '1', 07:02:53 INFO - 'TERM': 'linux', 07:02:53 INFO - 'TMOUT': '86400', 07:02:53 INFO - 'USER': 'cltbld', 07:02:53 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490191309.938043-1710955734', 07:02:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:53 INFO - '_': '/tools/buildbot/bin/python'} 07:02:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:53 INFO - Downloading/unpacking jsonschema==2.5.1 07:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:53 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 07:02:53 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 07:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:02:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:55 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 07:02:55 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 07:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:55 INFO - Downloading functools32-3.2.3-2.tar.gz 07:02:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:02:55 INFO - warning: no files found matching '*.txt' 07:02:55 INFO - no previously-included directories found matching 'build' 07:02:55 INFO - no previously-included directories found matching 'dist' 07:02:55 INFO - no previously-included directories found matching '.git*' 07:02:55 INFO - Installing collected packages: jsonschema, functools32 07:02:55 INFO - Running setup.py install for functools32 07:02:55 INFO - warning: no files found matching '*.txt' 07:02:55 INFO - no previously-included directories found matching 'build' 07:02:55 INFO - no previously-included directories found matching 'dist' 07:02:55 INFO - no previously-included directories found matching '.git*' 07:02:55 INFO - Successfully installed jsonschema functools32 07:02:55 INFO - Cleaning up... 07:02:55 INFO - Return code: 0 07:02:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:02:55 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')]} 07:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:55 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')]} 07:02:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:55 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 0x226c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2364a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2509b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2507290>, '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 0x2507b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2508040>, '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': '2432103b8b3de4003b23cad4000001c2-1490191309.938043-1710955734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:02:55 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 07:02:55 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 07:02:55 INFO - Using env: {'DISPLAY': ':0', 07:02:55 INFO - 'HOME': '/home/cltbld', 07:02:55 INFO - 'LANG': 'en_US.UTF-8', 07:02:55 INFO - 'LANGUAGE': 'en_US:en', 07:02:55 INFO - 'LOGNAME': 'cltbld', 07:02:55 INFO - 'MAIL': '/var/mail/cltbld', 07:02:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:55 INFO - 'MOZ_NO_REMOTE': '1', 07:02:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:55 INFO - 'NO_EM_RESTART': '1', 07:02:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:55 INFO - 'PWD': '/builds/slave/test', 07:02:55 INFO - 'SHELL': '/bin/bash', 07:02:55 INFO - 'SHLVL': '1', 07:02:55 INFO - 'TERM': 'linux', 07:02:55 INFO - 'TMOUT': '86400', 07:02:55 INFO - 'USER': 'cltbld', 07:02:55 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490191309.938043-1710955734', 07:02:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:55 INFO - '_': '/tools/buildbot/bin/python'} 07:02:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:02:56 INFO - Cleaning up... 07:02:56 INFO - Return code: 0 07:02:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:02:56 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')]} 07:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:56 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')]} 07:02:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:56 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 0x226c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2364a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2509b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2507290>, '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 0x2507b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2508040>, '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': '2432103b8b3de4003b23cad4000001c2-1490191309.938043-1710955734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:02:56 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 07:02:56 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 07:02:56 INFO - Using env: {'DISPLAY': ':0', 07:02:56 INFO - 'HOME': '/home/cltbld', 07:02:56 INFO - 'LANG': 'en_US.UTF-8', 07:02:56 INFO - 'LANGUAGE': 'en_US:en', 07:02:56 INFO - 'LOGNAME': 'cltbld', 07:02:56 INFO - 'MAIL': '/var/mail/cltbld', 07:02:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:56 INFO - 'MOZ_NO_REMOTE': '1', 07:02:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:56 INFO - 'NO_EM_RESTART': '1', 07:02:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:56 INFO - 'PWD': '/builds/slave/test', 07:02:56 INFO - 'SHELL': '/bin/bash', 07:02:56 INFO - 'SHLVL': '1', 07:02:56 INFO - 'TERM': 'linux', 07:02:56 INFO - 'TMOUT': '86400', 07:02:56 INFO - 'USER': 'cltbld', 07:02:56 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490191309.938043-1710955734', 07:02:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:56 INFO - '_': '/tools/buildbot/bin/python'} 07:02:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:56 INFO - Downloading/unpacking blobuploader==1.2.4 07:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:56 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 07:02:56 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 07:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:58 INFO - Downloading blobuploader-1.2.4.tar.gz 07:02:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:02:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:58 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 07:02:58 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 07:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:02:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:58 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 07:02:58 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 07:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:59 INFO - Downloading docopt-0.6.1.tar.gz 07:02:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:02:59 INFO - Installing collected packages: blobuploader, requests, docopt 07:02:59 INFO - Running setup.py install for blobuploader 07:02:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:02:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:02:59 INFO - Running setup.py install for requests 07:02:59 INFO - Running setup.py install for docopt 07:02:59 INFO - Successfully installed blobuploader requests docopt 07:02:59 INFO - Cleaning up... 07:02:59 INFO - Return code: 0 07:02:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:02:59 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')]} 07:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:59 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')]} 07:02:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:59 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 0x226c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2364a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2509b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2507290>, '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 0x2507b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2508040>, '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': '2432103b8b3de4003b23cad4000001c2-1490191309.938043-1710955734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:02:59 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 07:02:59 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 07:02:59 INFO - Using env: {'DISPLAY': ':0', 07:02:59 INFO - 'HOME': '/home/cltbld', 07:02:59 INFO - 'LANG': 'en_US.UTF-8', 07:02:59 INFO - 'LANGUAGE': 'en_US:en', 07:02:59 INFO - 'LOGNAME': 'cltbld', 07:02:59 INFO - 'MAIL': '/var/mail/cltbld', 07:02:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:59 INFO - 'MOZ_NO_REMOTE': '1', 07:02:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:59 INFO - 'NO_EM_RESTART': '1', 07:02:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:59 INFO - 'PWD': '/builds/slave/test', 07:02:59 INFO - 'SHELL': '/bin/bash', 07:02:59 INFO - 'SHLVL': '1', 07:02:59 INFO - 'TERM': 'linux', 07:02:59 INFO - 'TMOUT': '86400', 07:02:59 INFO - 'USER': 'cltbld', 07:02:59 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490191309.938043-1710955734', 07:02:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:59 INFO - '_': '/tools/buildbot/bin/python'} 07:02:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:02:59 INFO - Running setup.py (path:/tmp/pip-_uYgv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:02:59 INFO - Running setup.py (path:/tmp/pip-nZoipu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:03:00 INFO - Running setup.py (path:/tmp/pip-BKsuIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:03:00 INFO - Running setup.py (path:/tmp/pip-WDFR8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:03:00 INFO - Running setup.py (path:/tmp/pip-Pe4XHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:03:00 INFO - Running setup.py (path:/tmp/pip-k7KAkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:03:00 INFO - Running setup.py (path:/tmp/pip-TK9dxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:03:00 INFO - Running setup.py (path:/tmp/pip-NZ9IVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:03:00 INFO - Running setup.py (path:/tmp/pip-GUFVju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:03:00 INFO - Running setup.py (path:/tmp/pip-tSJC01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:03:00 INFO - Running setup.py (path:/tmp/pip-Ra6Xis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:03:00 INFO - Running setup.py (path:/tmp/pip-shij1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:03:00 INFO - Running setup.py (path:/tmp/pip-UXaRUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:03:00 INFO - Running setup.py (path:/tmp/pip-9XTiEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:03:00 INFO - Running setup.py (path:/tmp/pip-pPsM0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:03:01 INFO - Running setup.py (path:/tmp/pip-SQu8fN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:03:01 INFO - Running setup.py (path:/tmp/pip-OjB0EW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:03:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:03:01 INFO - Running setup.py install for manifestparser 07:03:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:03:01 INFO - Running setup.py install for mozcrash 07:03:01 INFO - Running setup.py install for mozdebug 07:03:01 INFO - Running setup.py install for mozdevice 07:03:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:03:01 INFO - Running setup.py install for mozfile 07:03:01 INFO - Running setup.py install for mozhttpd 07:03:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:03:01 INFO - Running setup.py install for mozinfo 07:03:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:03:01 INFO - Running setup.py install for mozInstall 07:03:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:03:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:03:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:03:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:03:01 INFO - Running setup.py install for mozleak 07:03:02 INFO - Running setup.py install for mozlog 07:03:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:03:02 INFO - Running setup.py install for moznetwork 07:03:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:03:02 INFO - Running setup.py install for mozprocess 07:03:02 INFO - Running setup.py install for mozprofile 07:03:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:03:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:03:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:03:02 INFO - Running setup.py install for mozrunner 07:03:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:03:02 INFO - Running setup.py install for mozscreenshot 07:03:02 INFO - Running setup.py install for moztest 07:03:02 INFO - Running setup.py install for mozversion 07:03:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:03:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:03:02 INFO - Cleaning up... 07:03:02 INFO - Return code: 0 07:03:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:03:02 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')]} 07:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:02 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')]} 07:03:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:02 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 0x226c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2364a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2509b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2507290>, '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 0x2507b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2508040>, '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': '2432103b8b3de4003b23cad4000001c2-1490191309.938043-1710955734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:03:02 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 07:03:02 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 07:03:02 INFO - Using env: {'DISPLAY': ':0', 07:03:02 INFO - 'HOME': '/home/cltbld', 07:03:02 INFO - 'LANG': 'en_US.UTF-8', 07:03:02 INFO - 'LANGUAGE': 'en_US:en', 07:03:02 INFO - 'LOGNAME': 'cltbld', 07:03:02 INFO - 'MAIL': '/var/mail/cltbld', 07:03:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:02 INFO - 'MOZ_NO_REMOTE': '1', 07:03:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:02 INFO - 'NO_EM_RESTART': '1', 07:03:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:02 INFO - 'PWD': '/builds/slave/test', 07:03:02 INFO - 'SHELL': '/bin/bash', 07:03:02 INFO - 'SHLVL': '1', 07:03:02 INFO - 'TERM': 'linux', 07:03:02 INFO - 'TMOUT': '86400', 07:03:02 INFO - 'USER': 'cltbld', 07:03:02 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490191309.938043-1710955734', 07:03:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:02 INFO - '_': '/tools/buildbot/bin/python'} 07:03:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:03:03 INFO - Running setup.py (path:/tmp/pip-OEw83O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:03:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:03:03 INFO - Running setup.py (path:/tmp/pip-1XhhP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:03:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:03:03 INFO - Running setup.py (path:/tmp/pip-IV1NjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:03:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:03:03 INFO - Running setup.py (path:/tmp/pip-sFwMnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:03:03 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)) 07:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:03:03 INFO - Running setup.py (path:/tmp/pip-IaCSL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:03:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:03:03 INFO - Running setup.py (path:/tmp/pip-sP0yuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:03:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:03:03 INFO - Running setup.py (path:/tmp/pip-C6d8rp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:03:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:03:03 INFO - Running setup.py (path:/tmp/pip-MXsnhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:03:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:03:03 INFO - Running setup.py (path:/tmp/pip-h3Dudt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:03:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:03:03 INFO - Running setup.py (path:/tmp/pip-CzGiFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:03:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:03:03 INFO - Running setup.py (path:/tmp/pip-LZPw72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:03:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:03:03 INFO - Running setup.py (path:/tmp/pip-ShJutB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:03:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:03:04 INFO - Running setup.py (path:/tmp/pip-DFg9c9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:03:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:03:04 INFO - Running setup.py (path:/tmp/pip-H1Wcha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:03:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:03:04 INFO - Running setup.py (path:/tmp/pip-NYQglT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:03:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:03:04 INFO - Running setup.py (path:/tmp/pip-aGnBQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:03:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:03:04 INFO - Running setup.py (path:/tmp/pip-wlXe0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:03:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:03:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:03:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:03:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:03:04 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)) 07:03:04 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)) 07:03:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:03:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:03:04 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 07:03:04 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 07:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:03:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:03:06 INFO - Downloading blessings-1.6.tar.gz 07:03:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:03:06 INFO - Installing collected packages: blessings 07:03:06 INFO - Running setup.py install for blessings 07:03:06 INFO - Successfully installed blessings 07:03:06 INFO - Cleaning up... 07:03:06 INFO - Return code: 0 07:03:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:03:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:03:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:03:06 INFO - Reading from file tmpfile_stdout 07:03:06 INFO - Current package versions: 07:03:06 INFO - argparse == 1.2.1 07:03:06 INFO - blessings == 1.6 07:03:06 INFO - blobuploader == 1.2.4 07:03:06 INFO - docopt == 0.6.1 07:03:06 INFO - functools32 == 3.2.3-2 07:03:06 INFO - jsonschema == 2.5.1 07:03:06 INFO - manifestparser == 1.1 07:03:06 INFO - mozInstall == 1.12 07:03:06 INFO - mozcrash == 1.0 07:03:06 INFO - mozdebug == 0.1 07:03:06 INFO - mozdevice == 0.49 07:03:06 INFO - mozfile == 1.2 07:03:06 INFO - mozhttpd == 0.7 07:03:06 INFO - mozinfo == 0.9 07:03:06 INFO - mozleak == 0.1 07:03:06 INFO - mozlog == 3.4 07:03:06 INFO - moznetwork == 0.27 07:03:06 INFO - mozprocess == 0.25 07:03:06 INFO - mozprofile == 0.28 07:03:06 INFO - mozrunner == 6.13 07:03:06 INFO - mozscreenshot == 0.1 07:03:06 INFO - mozsystemmonitor == 0.3 07:03:06 INFO - moztest == 0.8 07:03:06 INFO - mozversion == 1.4 07:03:06 INFO - psutil == 3.1.1 07:03:06 INFO - requests == 1.2.3 07:03:06 INFO - wsgiref == 0.1.2 07:03:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:03: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')]} 07:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03: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')]} 07:03:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:06 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 0x226c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2364a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2509b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2507290>, '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 0x2507b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2508040>, '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': '2432103b8b3de4003b23cad4000001c2-1490191309.938043-1710955734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:03:06 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 07:03:06 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 07:03:06 INFO - Using env: {'DISPLAY': ':0', 07:03:06 INFO - 'HOME': '/home/cltbld', 07:03:06 INFO - 'LANG': 'en_US.UTF-8', 07:03:06 INFO - 'LANGUAGE': 'en_US:en', 07:03:06 INFO - 'LOGNAME': 'cltbld', 07:03:06 INFO - 'MAIL': '/var/mail/cltbld', 07:03:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:06 INFO - 'MOZ_NO_REMOTE': '1', 07:03:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:06 INFO - 'NO_EM_RESTART': '1', 07:03:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:06 INFO - 'PWD': '/builds/slave/test', 07:03:06 INFO - 'SHELL': '/bin/bash', 07:03:06 INFO - 'SHLVL': '1', 07:03:06 INFO - 'TERM': 'linux', 07:03:06 INFO - 'TMOUT': '86400', 07:03:06 INFO - 'USER': 'cltbld', 07:03:06 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490191309.938043-1710955734', 07:03:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:06 INFO - '_': '/tools/buildbot/bin/python'} 07:03:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:03:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:03:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:03:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:03:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:03:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:03:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:03:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:03:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:03:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:03:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:03:07 INFO - Cleaning up... 07:03:07 INFO - Return code: 0 07:03:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:03:07 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')]} 07:03:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:07 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')]} 07:03:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:07 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 0x226c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2364a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2509b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2507290>, '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 0x2507b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2508040>, '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': '2432103b8b3de4003b23cad4000001c2-1490191309.938043-1710955734', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:03:07 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 07:03:07 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 07:03:07 INFO - Using env: {'DISPLAY': ':0', 07:03:07 INFO - 'HOME': '/home/cltbld', 07:03:07 INFO - 'LANG': 'en_US.UTF-8', 07:03:07 INFO - 'LANGUAGE': 'en_US:en', 07:03:07 INFO - 'LOGNAME': 'cltbld', 07:03:07 INFO - 'MAIL': '/var/mail/cltbld', 07:03:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:07 INFO - 'MOZ_NO_REMOTE': '1', 07:03:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:07 INFO - 'NO_EM_RESTART': '1', 07:03:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:07 INFO - 'PWD': '/builds/slave/test', 07:03:07 INFO - 'SHELL': '/bin/bash', 07:03:07 INFO - 'SHLVL': '1', 07:03:07 INFO - 'TERM': 'linux', 07:03:07 INFO - 'TMOUT': '86400', 07:03:07 INFO - 'USER': 'cltbld', 07:03:07 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490191309.938043-1710955734', 07:03:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:07 INFO - '_': '/tools/buildbot/bin/python'} 07:03:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:03:07 INFO - Cleaning up... 07:03:07 INFO - Return code: 0 07:03:07 INFO - Running post-action listener: _resource_record_post_action 07:03:07 INFO - Running post-action listener: _start_resource_monitoring 07:03:07 INFO - Starting resource monitoring. 07:03:07 INFO - [mozharness: 2017-03-22 14:03:07.388008Z] Finished create-virtualenv step (success) 07:03:07 INFO - [mozharness: 2017-03-22 14:03:07.388521Z] Running install step. 07:03:07 INFO - Running pre-action listener: _resource_record_pre_action 07:03:07 INFO - Running main action method: install 07:03:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:03:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:03:07 INFO - Reading from file tmpfile_stdout 07:03:07 INFO - Detecting whether we're running mozinstall >=1.0... 07:03:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:03:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:03:07 INFO - Reading from file tmpfile_stdout 07:03:07 INFO - Output received: 07:03:07 INFO - Usage: mozinstall [options] installer 07:03:07 INFO - Options: 07:03:07 INFO - -h, --help show this help message and exit 07:03:07 INFO - -d DEST, --destination=DEST 07:03:07 INFO - Directory to install application into. [default: 07:03:07 INFO - "/builds/slave/test"] 07:03:07 INFO - --app=APP Application being installed. [default: firefox] 07:03:07 INFO - mkdir: /builds/slave/test/build/application 07:03:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:03:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:03:23 INFO - Reading from file tmpfile_stdout 07:03:23 INFO - Output received: 07:03:23 INFO - /builds/slave/test/build/application/firefox/firefox 07:03:23 INFO - Running post-action listener: _resource_record_post_action 07:03:23 INFO - [mozharness: 2017-03-22 14:03:23.135408Z] Finished install step (success) 07:03:23 INFO - [mozharness: 2017-03-22 14:03:23.135748Z] Running run-tests step. 07:03:23 INFO - Running pre-action listener: _resource_record_pre_action 07:03:23 INFO - Running main action method: run_tests 07:03:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:03:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:03:23 INFO - Python 2.7.3 07:03:23 INFO - Return code: 0 07:03:23 INFO - grabbing minidump binary from tooltool 07:03:23 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')]} 07:03:23 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 0x2507290>, '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 0x2507b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2508040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:03:23 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:03:23 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:03:23 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:03:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:03:23 INFO - Return code: 0 07:03:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:03:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:03:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:03:23 INFO - ENV: RUST_BACKTRACE is now 1 07:03:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:03:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:03:23 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/MUCxLFXLQvKtAGf9VyDhNQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-070', '--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 07:03:23 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/MUCxLFXLQvKtAGf9VyDhNQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-070 --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 07:03:23 INFO - Using env: {'DISPLAY': ':0', 07:03:23 INFO - 'HOME': '/home/cltbld', 07:03:23 INFO - 'LANG': 'en_US.UTF-8', 07:03:23 INFO - 'LANGUAGE': 'en_US:en', 07:03:23 INFO - 'LOGNAME': 'cltbld', 07:03:23 INFO - 'MAIL': '/var/mail/cltbld', 07:03:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:03:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:03:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:23 INFO - 'MOZ_NO_REMOTE': '1', 07:03:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:03:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:23 INFO - 'NO_EM_RESTART': '1', 07:03:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:23 INFO - 'PWD': '/builds/slave/test', 07:03:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:03:23 INFO - 'RUST_BACKTRACE': '1', 07:03:23 INFO - 'SHELL': '/bin/bash', 07:03:23 INFO - 'SHLVL': '1', 07:03:23 INFO - 'TERM': 'linux', 07:03:23 INFO - 'TMOUT': '86400', 07:03:23 INFO - 'USER': 'cltbld', 07:03:23 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1490191309.938043-1710955734', 07:03:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:23 INFO - '_': '/tools/buildbot/bin/python'} 07:03:23 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/MUCxLFXLQvKtAGf9VyDhNQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-070', '--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 07:03:23 INFO - mozversion application_buildid: 20170322132647 07:03:23 INFO - mozversion application_changeset: 27f7aadeea833eca8c9c0e24c858f798e4d6fdd8 07:03:23 INFO - mozversion application_display_name: Nightly 07:03:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:03:23 INFO - mozversion application_name: Firefox 07:03:23 INFO - mozversion application_remotingname: firefox 07:03:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:03:23 INFO - mozversion application_vendor: Mozilla 07:03:23 INFO - mozversion application_version: 55.0a1 07:03:23 INFO - mozversion platform_buildid: 20170322132647 07:03:23 INFO - mozversion platform_changeset: 27f7aadeea833eca8c9c0e24c858f798e4d6fdd8 07:03:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:03:23 INFO - mozversion platform_version: 55.0a1 07:03:23 INFO - using testdate: 1490191403 07:03:23 INFO - actual date: 1490191403 07:03:23 INFO - starting webserver on 'localhost:54580' 07:03:23 INFO - SUITE-START | Running 2 tests 07:03:23 INFO - TEST-START | dromaeo_css 07:03:23 INFO - operating with platform_type : linux_ 07:03:23 INFO - Initialising browser for dromaeo_css test... 07:03:23 INFO - TEST-INFO | started process 21696 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0ZsXBw/profile http://localhost:54580/getInfo.html) 07:03:28 INFO - PID 21696 | __metrics Screen width/height:1600/1200 07:03:28 INFO - PID 21696 | colorDepth:24 07:03:28 INFO - PID 21696 | Browser inner width/height: 1024/697 07:03:28 INFO - PID 21696 | __metrics 07:03:29 ERROR - PID 21696 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 07:03:30 INFO - TEST-INFO | 21696: exit 0 07:03:30 INFO - Browser initialized. 07:03:30 INFO - Running cycle 1/1 for dromaeo_css test... 07:03:30 INFO - TEST-INFO | started process 21826 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0ZsXBw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:03:42 INFO - PID 21826 | RSS: Main: 155152384 07:03:42 INFO - PID 21826 | 07:06:47 INFO - PID 21826 | Cycle 1(1): loaded http://localhost:54580/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54580/tests/dromaeo/cssquery-ext.html) 07:06:48 INFO - PID 21826 | RSS: Main: 164511744 07:06:48 INFO - PID 21826 | 07:08:30 INFO - PID 21826 | ************************* 07:08:30 INFO - PID 21826 | A coding exception was thrown and uncaught in a Task. 07:08:30 INFO - PID 21826 | 07:08:30 ERROR - PID 21826 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:08:30 INFO - PID 21826 | Full stack: 07:08:30 INFO - PID 21826 | ************************* 07:09:50 INFO - PID 21826 | Cycle 1(1): loaded http://localhost:54580/tests/dromaeo/cssquery-ext.html (next: http://localhost:54580/tests/dromaeo/cssquery-jquery.html) 07:09:51 INFO - PID 21826 | RSS: Main: 160182272 07:09:51 INFO - PID 21826 | 07:12:53 INFO - PID 21826 | Cycle 1(1): loaded http://localhost:54580/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54580/tests/dromaeo/cssquery-mootools.html) 07:12:54 INFO - PID 21826 | RSS: Main: 167514112 07:12:54 INFO - PID 21826 | 07:15:56 INFO - PID 21826 | Cycle 1(1): loaded http://localhost:54580/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54580/tests/dromaeo/cssquery-prototype.html) 07:15:56 INFO - PID 21826 | RSS: Main: 161509376 07:15:56 INFO - PID 21826 | 07:18:59 INFO - PID 21826 | Cycle 1(1): loaded http://localhost:54580/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54580/tests/dromaeo/cssquery-yui.html) 07:19:00 INFO - PID 21826 | RSS: Main: 167460864 07:19:00 INFO - PID 21826 | 07:22:03 INFO - PID 21826 | Cycle 1(1): loaded http://localhost:54580/tests/dromaeo/cssquery-yui.html (next: http://localhost:54580/tests/dromaeo/cssquery-dojo.html) 07:22:03 INFO - PID 21826 | RSS: Main: 162078720 07:22:03 INFO - PID 21826 | 07:22:03 INFO - PID 21826 | __start_tp_report 07:22:03 INFO - PID 21826 | _x_x_mozilla_page_load 07:22:03 INFO - PID 21826 | _x_x_mozilla_page_load_details 07:22:03 INFO - PID 21826 | |i|pagename|runs| 07:22:03 INFO - PID 21826 | |0;dojo.html;2664.840109593424;2682.5439675255207;2691.098482008527;2721.8911243550247;2725.7955653326;5073.441921388644;5165.096108181067;5174.715390653512;5196.688198708081;5215.947840521599;5121.590272778178;5143.125668636331;5167.069927413064;5211;5226.973865130669;4685.69542979707;4708.246680531116;4736.100140973222;4738.312944623028;4747.8575642730775;4728.858134255978;4738.71567705937;4750.738709370983;4767.404074490689;4811.855644330676;4584.541545845422;4614.8154073837;4687.648426368036;4693.967327188047;4712.882177945545;4613;4662.743549104798;4672.649551283634;4706.858794236178;4711.787969541345;4531.682782205247;4620.630349572026;4623.69945953512;4656.580907718321;4665.953340466586;5023.819402440424;5051.040302342543;5097.923531147036;5098.796048158069;5098.949010509885;5539.224508568804;5545.584081193886;5565.499105080562;5585.441455854423;5603.187537807036;5598.10430331145;5601.943980560183;5608.102703567451;5614.859628509279;5628.493435590775;5084.745762711849;5212.921806172911;5217.452167522393;5224.738763061831;5270.051390749702;5647.6893770843;5694.914576281359;5740.655560666373;5746.482816546531;5767.423257674199;5295.655782374133;5359.490848369399;5365.436629153961;5484.533814625802;5485.61600687956;5393.919091213556;5469.808556700496;5484.972575137099;5492.038893193675;5550.27846379968;5331.893362132736;5440.047991601533;5443.7822487100075;5446.482584154499;5452.890942181213;5420.430854760193;5421.674699518042;5429.104197807396;5433.347998240237;5434.619576629598;4543.068670922453;4550.2492088804975;4555.20283950314;4568.79440425175;4592.058627981256;3970.82131304092;3974.0462289050997;3981.044549308203;4006.0585762345827;4018.3168861293652;4814.494478079751;4817.229243321122;4821.180399332122;4834.516548345137;4871.025794841046;5450.236966824647;5455.372632147354;5577.191307260425;5614.185943038318;5615.241942337814;4795.424549054136;4813.9037219256115;4824.927626085611;4842.878928026757;4851.223804191312;4869.561739443467;4891.972685735964;4897.314375987365;4906.632002599819;4947.1837146871085;5044.949550504448;5046.09170349326;5177.948220517822;5188.818391356284;5239.973800130975;5575;5581.358143813513;5592.189132575835;5607.158926161109;5635.154726791015;5138.203578445347;5140.537351638371;5141.28022076917;5142.074426603098;5146.76839542229;5356.839294821161;5442.238086667949;5443.510084092451;5450.155225939986;5452.972735136299;5501.614886957875;5577.051901176728;5590.636608620427;5611.719414029364;5613.494785469327;5364.409914909279;5386.380566234933;5388.434214407431;5398.4871437213405;5414.485623865727;5263.526282634582;5319.4414586467865;5371.704556249444;5390.380106287827;5407.080796264723;5254.737263136904;5294.97352513235;5296.470352964673;5300.7084610345255;5353.78584856617;5374.623776335619;5376.650517716336;5377.973110134581;5385.596080293915;5451.972740136274;5177.8187763428095;5181.430042695225;5227.3465816772905;5247.606429517725;5251.553617942518 07:22:03 INFO - PID 21826 | |1;ext.html;666.3469799596395;721.72935149319;742;1065.0893486069415;1076.7684947736236;31029.844850775742;31918.680813191862;31965;32043.67956320436;32046.35907281853;33190.66809331906;33748;33820;36587.63412365882;36847.63152368476;7165.426765858719;7303.160136584294;7307.159676637175;7342.632868356561;7441.776746697607;7276.527025743336;7353.742619008336;7392.039034925479;7392.630368481581;7409.851802963937;7406.7777966660815;7439;7448.962755186217;7453.739119130832;7468.775936721907;7329.083864516935;7385.6307184640555;7388.3719883809945;7451.441141914378;7517.210692877278;6959.8956015659805;6999.300069993011;7024.894626580605;7032.191298000745;7040.823979400505;35128.29743405118;35264.29471410583;35266.47100293497;35564.288714225826;35581.46627800585;2571.29289445404;2581.625664278688;2584.082650659008;2598.7791037761813;2664.2273740615196;21815.890920545455;21873.890630546906;21902.452438689;22000.669989950162;22100.33698989033;2734.6308248386613;2760.4203117345382;2763.571646394812;2765.7234276572385;2788.2750484873877;130969.34515327362;132023;132436.33781831223;133108.3344583271;133921;36908.26183476369;37240.25519489595;37459.62540374616;37542.43686344707;37582.62417375846;39878.80060599736;39943.40084898729;42149;42333.788331058146;42462.47987761571;11748.941255293668;11936.58221962227;12011.219270747373;12035.338056406981;12048.397580120958;9392.15470607635;9444.433333999981;9449.905500944902;9451.574679139318;9457.43255404678;13444.32778361078;13465.326733663278;13489.460421583222;13563;13679;5464;5518;5529.419410961871;5617.887642247132;5653.265075540154;839.4879123734516;857.237059017475;865.048446708628;865.9307255419551;877.4206428428803;21140.47148821292;21620.891895540422;21713.67429488559;21724.674129888066;21951;943.4999450291357;953.2326477185793;953.7853982853941;955.5747692277009;983.0808194338316;11080.501377438035;11111.333320000826;11399.316041037398;11416.94291528537;11436.428178591037;221638;222205;223483;223723;224226;44322.33516497255;44674.77662611731;44698.329525057154;44737;44763.32855007112;1187.9940600296943;1207.6293406983139;1232.580922486359;1236.4250623460134;1237;22839.376580791384;23855.52288954246;24132.758672413052;24288.514229714954;25426.364340891625;31034.0689779307;31441.21396965094;31456.685433146293;31478.685213147575;31516.527252091695;200058;200851;201796;201817;201935;29554.852225738734;29609;29813.552796707634;29837.850810745807;29912.85043574855;35157.82421087878;35543.82228088843;35595.64404355923;36253.65561026757;36254.018087016404;30282.84858575693;30304.5454318181;30404.847975759978;30528.542071869382;31613.367732644758;30102.397952041276;30410.39179216359;30643.23391915131;30794;31615.683843161274;29654.894668542485;30090.548641769954;30327.545086823273;30396.84801575978;30499.2375190622;23580.88209558941;25478.23565293044;26876.59685104686;26941.730582693923;28011.579826302215;22047.22834700778;22127.778722212573;22166.445838854157;22167.778322217215;22227.110915563197 07:22:03 INFO - PID 21826 | |2;jquery.html;408.5342709311384;417.73473844109003;421.2606874934489;437.48158432257776;440.9184300904333;11949.701257468545;13383.799243011363;16791.664166716673;17404.43209142126;17500.912495437522;17305.480835574952;17624.295028198856;17873.19570619322;17929.64140717185;18106.4568062958;5639.351474580414;5709.71451427429;5732.7133643317875;5927.555433342495;5933.495652869511;5708.686022268774;5768.942310576904;5769.624974376652;5770.2210201622875;5790.160426738121;5477.698726570037;5711.114777209539;5725.885482290351;5726.885462290752;5733.885322293551;5638.887222255573;5653.802116925908;5690.146478028288;5774.307083150028;5819.970900145472;5156.767945442464;5175.560077393426;5182.974085129588;5190.169572868323;5191.299174611417;22080.447988800246;22555.097796088136;22834.543309133725;22893.427664308358;22990.655140172912;1598.9520314390586;1607.6302450436465;1624.6669432766373;1633.5834362237672;1669.232153209525;13825.51610693621;13976.161430314214;14011.579652610439;14142.717145657132;14900.403983840633;1621.7567364895242;1629.2029179162869;1637.6571658687162;1638.1563494800068;1656.6686662667514;84901;88340.11659883383;88818.5559072207;89624;89764;11087.33475991443;11091.5563377464;11112.888871111347;11210.607628732956;11546.806106839673;15624.687506249811;15763;15898.205089745466;15900.76148857768;15931.522054338388;7158.14102307716;7322.231165727629;7373.188949215582;7458.2541745826065;7479.476436649491;6430.967845160838;6505.804825855232;6708.731650734014;6746.595204287759;6747;6978.616176110261;6993.580385176906;7074.75238366665;7115.644217789089;7191.173015103225;1893.5739458621974;1900.8479321654233;1905.4474202481401;1915.5115445561294;2119.8940052997286;826.6404114210337;838.3502785341287;843.9367047471465;866.8959724833061;884.3544212724747;16432.917835410746;16482.42311519115;16619.252133653772;16795.748063779054;17457.47627571175;857.652650676477;860.8493513635214;861.8017855893054;864.5561911607631;876.7501262140387;9331.393459425115;9376.953115234517;9378.64009718587;9622.566984485715;10882.40146791934;454745;461295;470994;476619;486579;91409;94120.52939735394;94399;94580.52709736407;96058;1077.0683358894657;1085.0614218700766;1112.671761830262;1118.139032944628;1123.9831402528969;16665.416710415077;16863;18066.548336291697;18138.637227255116;18285.81714182841;41982.790086049376;44205;44417.11165776731;44678.3298250533;44711;54211.18683219676;56156.43843561512;56262.43737562572;56747.14879276897;57496.42503575078;8213.876791848246;8226.670933162606;8246.662314427653;8286.254237118688;8367.497950123012;13203.603891883258;13632.182069075887;13850.584482465541;13926.51257205993;14261.215633140277;11448.198626096426;11542.94228528852;11725.120615953667;11741.945159597208;11925.165238433226;10949.671509854717;11122.388268645302;11158.10735141203;11158.274712143684;11164.497597607964;10423;10436.37381757097;10765.892341076802;10771.515281812493;10778.946105269424;8368.790780230544;8504.107068757692;8568.100349463217;8666.050138718738;8772.473651580925;11056.557737690402;11170.497327620114;11185.440727963733;11185.888141118485;11523.654290371302 07:22:03 INFO - PID 21826 | |3;mootools.html;1288.8195652608636;1350.4260689207085;1355.9593212203638;1361.8638136186376;1365.6039748472947;9341.719748407542;9830.754231144225;10135.695929122128;10180;10182.490875456226;9827.312088153833;9912.702618921443;9942.453165075936;9994.45030523321;10008.099271065603;2163.167180635459;2194.6378847490223;2197.373748481683;2217.8891055447243;2220.467087898901;2106.515501434671;2159.384575396012;2170.077716970289;2171.250918433146;2173.9565208695817;2123.6389813731703;2144.8927553622334;2152.881591512466;2155.299527653511;2159.1039718516877;2086.2072412483235;2090.017691684913;2091.748990121195;2100.516881117344;2101.674240492726;1836.5500452389117;1896.421591414618;1995.5310502032012;2072.4197224777085;2150.6773983902385;9843.310968232227;9916;9954.352967057119;10194.184465242763;10247.128994035516;5217.3217481727515;5415.48552887475;5416.0792665247;5417.160340147283;5432.429594892558;3071.508558630608;3126.765492588065;3130.63997640272;3156.226724452501;3163.6678148794504;957.7636219427645;958.434523631054;972.2562239886493;976.3946353260952;1026.1175389165312;14689;14699.706005879929;14888.106713597219;14900.62748431298;14921;4699.976500117546;4758.1435341638835;4775.562458442065;4803.3995750531185;4914.680545764514;11130.664320281618;11135.220534562664;11155.27490713101;11169.553217871195;11185.217034807485;5366.2755528004;5369.812056578001;5380.623356365017;5394.163904594716;5402.783888644411;4872.731999740048;4907.411110666671;5007.47421520735;5031.52200540948;5086.618503612244;3831.9616803832164;3928.607139286106;3979;4006.198760247904;4054.493188351456;1128.802459569572;1132.0999805154922;1138;1141.5034460009922;1144.2276463387348;666.7499687617144;674.2280089297825;683.6855046678584;686.4645576450376;693.3066933066933;5634.352049514277;5695.601307908407;5752.856178595485;5828.737706803119;6059.7273122709585;812.3298278919915;817.2154731457748;825.7481468152271;832.3923535818765;860.4665107633307;3301.3892429900543;3330.200751819546;3361.6470270621235;3367.9494807577908;3425.1779572902824;12946.546870859664;13210.207387556777;13396.263205523595;13396.732065358638;13421.39603717835;12984.350782461028;13064.216147031018;13119.606411807661;13270;13352.866471335163;9393.342466027449;9403.34176607631;9513.621594601349;9531.094546018117;9537.761555961157;5462.3445186577865;5637.57718171147;5726.455986681259;5768.221290125779;5847.1229315603;11587.768244635228;11680.47437865315;11790.941045295061;11792.882071179522;11817.409129543317;12105.092118091003;12110.091743119125;12216.26702397859;12290.20113692607;12318.507259709511;7611.162772094955;7688.538687678757;7722.92277077222;7875.133735288999;7878.645460954156;9333.673321433716;9336.673216437392;9346.15884570392;9421.858672119786;9432.103950124727;7834.255745704149;7872.527648341118;7892.6053697313755;7976.322012628992;8033.437659363788;8217.30152937007;8225.424220304521;8284.544350060563;8291.917080829115;8318.625661845352;6918.135233095863;6922.58464492132;7004.3696067354185;7005;7019.4735394844565;4853.635977301646;4959.553640172402;5021.472745361831;5040.966601846686;5074.746262686925;5079.92380114306;5127.871868188992;5180.844574662766;5362.678239305654;5364.839054828361 07:22:03 INFO - PID 21826 | |4;prototype.html;382.33855430105916;401.1455599572911;403.56011946977793;406.28291066268025;406.6827874258076;5420.783168673258;5508;5531.419200983894;5557.499825015748;5567.805126820562;5368.409474957752;5441.319835020622;5445.264889239951;5451.182322651604;5464.672119672822;4219.873403797883;4222.78886055696;4223.838444427776;4228.217779710748;4232.470941132358;4070.694697897655;4223;4249.830006799724;4255.829766809324;4278.828846846122;4185.965175247951;4201.684873634475;4207.137536804948;4209.34755112958;4209.705320627558;4205.537390887031;4211.620954114129;4219.683523735732;4225.492940847103;4239.91520169598;3501.2997400519744;3713.090292878262;3727.459518369821;3739.4016957286703;3742.831572579213;5250.9474905250845;5282.260483532308;5288.127458969304;5311.442298558634;5337.290583044785;4843.757812109416;4844.95155048452;4847.303443794679;4853.927191092136;4868.610511159099;5521.503064724154;5648.293963254593;5705.942940570624;5734.254546908917;5739.483446489836;4056.5740597237454;4064.0855807443386;4067.4102255172834;4067.9389809152885;4069.796510174509;5736.368999410061;5847.707614619252;5888.764449422018;6040.335563088057;6081.756729730805;4150.418941348214;4151.14901445209;4151.813168407369;4153.293940030202;4153.813078411479;4204.894877628022;4223.155368926227;4224.640905523003;4241.491021077429;4242.61816436516;4830.415727585725;4837.733924634179;4846.636502262344;4866.248150665758;5021.799128034911;5758.539316854642;5796.275465566804;5800.1299805029585;5802.912956305659;5803.245578074823;1586.4209563509467;1597.7922870026823;1598.1370060167612;1607.4856046065381;1618.4173697468902;1076.4402510694395;1157.3865851098763;1157.7684463107412;1161.2451906260828;1166.3585028234438;5068.366454193226;5077.593792496591;5079.3396858408905;5081.669691470042;5083.542481176712;6002.159697642333;6003;6010.3689112643415;6014.699265036731;6020.939790602126;4968.826091086795;4999.800007999712;5043.092243396224;5051.974740126276;5077.416097148801;3153.984230078835;3186.2512309607223;3186.3786561620263;3190.760692948038;3191.1702957231287;5454.945450545523;5563.471470210324;5564.248826408464;5569.10894256917;5572.359178694502;6058.878822423527;6080.7567697291615;6110.883449440728;6111.724972376253;6158.137860699506;5533.280673512579;5545.195946587723;5546.584006199551;5563.803782186849;5564.777408903679;5704.286964129484;5926.244296402194;5929.407059294036;5951.523878089656;5983.880322393441;5822.73797679097;5828.184054232326;5847.327557330961;5850.678212698343;5854.799766048035;5197.298364720715;5325.760340784596;5367.060764366299;5505.587080969023;5545.72271386421;4445.488768791501;4473.217186992329;4479.417675702138;4497.887552811206;4526.8189272428735;5809;5943.881122377615;5949.167116603766;5956.940430595639;5980.641161530322;5715.542536653127;5729.510327314845;5761.658238221905;5761.884762304647;5762.625429347079;5747.540196784331;5753.453421924911;5755.942440575541;5773.220615216892;5800.651960882361;5469.906018796177;5597.580181486323;5645.774169033192;5656.575756818337;5665.402469431858;5787.450192231731;5796.739146738491;5798.855028624318;5801.3908539602735;5803.883922321445;5466.590005749665;5654.6324488908085;5656.981743286248;5661.179129026185;5661.2923384576925 07:22:03 INFO - PID 21826 | |5;yui.html;685.1435705368289;689.6689588997284;698.4168219536687;720.4092644031892;722.5267449820369;12362;12757.617271481848;12997.675058123552;13057.151285166457;13328.333583320844;12348.567800126975;12523.311217883012;12538.561150359716;12543.435545400456;13008.154469959469;625.0468036244717;643.1060825452624;818.615250832111;832.37571821134;857.7898414888361;847.2882778466087;858.0561382479254;858.2919091749301;860.9397342186049;861.8750281209221;896.0680891872445;899.9325050621229;899.9820003599924;900.8963969143567;903.3495882964288;890.7639475538988;890.9287257019455;894.2309613732185;895.50299583731;895.9820803583892;660.3231687520282;660.828184671984;660.9471242300605;662.6256165266657;663.0683889135772;13632.727345453135;13753.106048106942;13776;13801.930990345085;14023.29883505831;13233.735325293537;13290.667733306647;13724.65688357789;13766.129072388672;14135.929320353333;9970.351927124786;10073.949630251875;10232.64185753495;10239.641612543599;10395.16838652906;2570.717221105677;2571.3186005708503;2577.1366592191453;2657.853818040007;2676.1168814291236;33622.55462854446;47725.76137119292;51854.48145518534;58947;58986.705066474824;10597.9470102649;10599.947000264949;10656.89343106559;10767.3539587625;10858.511366988505;19706.21175152978;19721.901390492956;19740.506487337643;19773;19831.900840495993;6552.410283074546;6714.429273511709;6776.15298087739;6808.489363297773;6961.37347638715;3328.5173649821127;3340.883069092619;3346.7489938254243;3373.797572145679;3440.2775417162175;3457.3776720190103;3513.50810886471;3520.964790352115;3544.57465104184;3553.964460355415;673.6025744810586;685.4721864164566;686.9484788640872;692.7886994466736;705.3827900586987;532.2256117349248;537.1030379266634;544.8882978989297;557.8354385456219;562.1455387810587;8100.630677085381;8189.754307370788;8455.74632761018;8481.872771908425;8628.43915145526;531.3544043986575;541.9701916394636;554.2849723856181;561.3123923194055;564.8051422259314;3771.340015497277;3789.374753165697;3812.599677033927;3831.5976822433245;3924.156306394139;61047;61364.693176534725;62255.6887215561;62522;64538.6773066141;55481;55646.16530752042;56100;56543;59212;48390;48545;48919;49013.509864900894;49383.75308123508;7777.92222077772;7992.8001799953145;8085.43401961857;8101.473404228706;8152.2662960333855;26309.473810524065;26660.200193994213;26789;27260.454790904467;27311.180664580093;31783;32405.675943240265;32449.837750811093;32830.507542387364;33102.172445688084;10369.222308326755;10878.673639790819;11245.325280483197;11296.774064518828;11577.6526704199;11292.604758833402;12359;12613.558525451932;12676.366181690693;13009.154404963647;11456.94271528637;11638.592649257236;12277.693057673272;12280.263184208976;12707.555235566711;12126.451716073574;12344.62966111018;12999.870001300244;13757.656058598215;13760.518381856587;11719.531218751496;12557.434915428645;12664.176828506117;12965.481380744664;12992.415341309475;10394.376337419779;10422.218333624856;11020.724481888017;11023.873898636852;11062.612808551663;8628.870566941627;8887.866681999905;10284.537195826355;10437.269391142547;10508.737281567715 07:22:03 INFO - PID 21826 | __end_tp_report 07:22:03 INFO - PID 21826 | __start_cc_report 07:22:03 INFO - PID 21826 | _x_x_mozilla_cycle_collect,372 07:22:03 INFO - PID 21826 | __end_cc_report 07:22:03 INFO - PID 21826 | __startTimestamp1490192523469__endTimestamp 07:22:03 INFO - PID 21826 | 07:22:03 INFO - PID 21826 | ------- Summary: start ------- 07:22:03 INFO - PID 21826 | Number of tests: 6 07:22:03 INFO - PID 21826 | 07:22:03 INFO - PID 21826 | [#0] dojo.html Cycles:165 Average:5077.73 Median:5217.45 stddev:573.35 (11.0%) stddev-sans-first:542.96 07:22:03 INFO - PID 21826 | Values: 2664.8 2682.5 2691.1 2721.9 2725.8 5073.4 5165.1 5174.7 5196.7 5215.9 5121.6 5143.1 5167.1 5211.0 5227.0 4685.7 4708.2 4736.1 4738.3 4747.9 4728.9 4738.7 4750.7 4767.4 4811.9 4584.5 4614.8 4687.6 4694.0 4712.9 4613.0 4662.7 4672.6 4706.9 4711.8 4531.7 4620.6 4623.7 4656.6 4666.0 5023.8 5051.0 5097.9 5098.8 5098.9 5539.2 5545.6 5565.5 5585.4 5603.2 5598.1 5601.9 5608.1 5614.9 5628.5 5084.7 5212.9 5217.5 5224.7 5270.1 5647.7 5694.9 5740.7 5746.5 5767.4 5295.7 5359.5 5365.4 5484.5 5485.6 5393.9 5469.8 5485.0 5492.0 5550.3 5331.9 5440.0 5443.8 5446.5 5452.9 5420.4 5421.7 5429.1 5433.3 5434.6 4543.1 4550.2 4555.2 4568.8 4592.1 3970.8 3974.0 3981.0 4006.1 4018.3 4814.5 4817.2 4821.2 4834.5 4871.0 5450.2 5455.4 5577.2 5614.2 5615.2 4795.4 4813.9 4824.9 4842.9 4851.2 4869.6 4892.0 4897.3 4906.6 4947.2 5044.9 5046.1 5177.9 5188.8 5240.0 5575.0 5581.4 5592.2 5607.2 5635.2 5138.2 5140.5 5141.3 5142.1 5146.8 5356.8 5442.2 5443.5 5450.2 5453.0 5501.6 5577.1 5590.6 5611.7 5613.5 5364.4 5386.4 5388.4 5398.5 5414.5 5263.5 5319.4 5371.7 5390.4 5407.1 5254.7 5295.0 5296.5 5300.7 5353.8 5374.6 5376.7 5378.0 5385.6 5452.0 5177.8 5181.4 5227.3 5247.6 5251.6 07:22:03 INFO - PID 21826 | 07:22:03 INFO - PID 21826 | [#1] ext.html Cycles:180 Average:32893.81 Median:31031.96 stddev:49286.52 (158.8%) stddev-sans-first:49365.38 07:22:03 INFO - PID 21826 | Values: 666.3 721.7 742.0 1065.1 1076.8 31029.8 31918.7 31965.0 32043.7 32046.4 33190.7 33748.0 33820.0 36587.6 36847.6 7165.4 7303.2 7307.2 7342.6 7441.8 7276.5 7353.7 7392.0 7392.6 7409.9 7406.8 7439.0 7449.0 7453.7 7468.8 7329.1 7385.6 7388.4 7451.4 7517.2 6959.9 6999.3 7024.9 7032.2 7040.8 35128.3 35264.3 35266.5 35564.3 35581.5 2571.3 2581.6 2584.1 2598.8 2664.2 21815.9 21873.9 21902.5 22000.7 22100.3 2734.6 2760.4 2763.6 2765.7 2788.3 130969.3 132023.0 132436.3 133108.3 133921.0 36908.3 37240.3 37459.6 37542.4 37582.6 39878.8 39943.4 42149.0 42333.8 42462.5 11748.9 11936.6 12011.2 12035.3 12048.4 9392.2 9444.4 9449.9 9451.6 9457.4 13444.3 13465.3 13489.5 13563.0 13679.0 5464.0 5518.0 5529.4 5617.9 5653.3 839.5 857.2 865.0 865.9 877.4 21140.5 21620.9 21713.7 21724.7 21951.0 943.5 953.2 953.8 955.6 983.1 11080.5 11111.3 11399.3 11416.9 11436.4 221638.0 222205.0 223483.0 223723.0 224226.0 44322.3 44674.8 44698.3 44737.0 44763.3 1188.0 1207.6 1232.6 1236.4 1237.0 22839.4 23855.5 24132.8 24288.5 25426.4 31034.1 31441.2 31456.7 31478.7 31516.5 200058.0 200851.0 201796.0 201817.0 201935.0 29554.9 29609.0 29813.6 29837.9 29912.9 35157.8 35543.8 35595.6 36253.7 36254.0 30282.8 30304.5 30404.8 30528.5 31613.4 30102.4 30410.4 30643.2 30794.0 31615.7 29654.9 30090.5 30327.5 30396.8 30499.2 23580.9 25478.2 26876.6 26941.7 28011.6 22047.2 22127.8 22166.4 22167.8 22227.1 07:22:03 INFO - PID 21826 | 07:22:03 INFO - PID 21826 | [#2] jquery.html Cycles:180 Average:28518.06 Median:439.20 stddev:77860.29 (17727.8%) stddev-sans-first:78050.10 07:22:03 INFO - PID 21826 | Values: 408.5 417.7 421.3 437.5 440.9 11949.7 13383.8 16791.7 17404.4 17500.9 17305.5 17624.3 17873.2 17929.6 18106.5 5639.4 5709.7 5732.7 5927.6 5933.5 5708.7 5768.9 5769.6 5770.2 5790.2 5477.7 5711.1 5725.9 5726.9 5733.9 5638.9 5653.8 5690.1 5774.3 5820.0 5156.8 5175.6 5183.0 5190.2 5191.3 22080.4 22555.1 22834.5 22893.4 22990.7 1599.0 1607.6 1624.7 1633.6 1669.2 13825.5 13976.2 14011.6 14142.7 14900.4 1621.8 1629.2 1637.7 1638.2 1656.7 84901.0 88340.1 88818.6 89624.0 89764.0 11087.3 11091.6 11112.9 11210.6 11546.8 15624.7 15763.0 15898.2 15900.8 15931.5 7158.1 7322.2 7373.2 7458.3 7479.5 6431.0 6505.8 6708.7 6746.6 6747.0 6978.6 6993.6 7074.8 7115.6 7191.2 1893.6 1900.8 1905.4 1915.5 2119.9 826.6 838.4 843.9 866.9 884.4 16432.9 16482.4 16619.3 16795.7 17457.5 857.7 860.8 861.8 864.6 876.8 9331.4 9377.0 9378.6 9622.6 10882.4 454745.0 461295.0 470994.0 476619.0 486579.0 91409.0 94120.5 94399.0 94580.5 96058.0 1077.1 1085.1 1112.7 1118.1 1124.0 16665.4 16863.0 18066.5 18138.6 18285.8 41982.8 44205.0 44417.1 44678.3 44711.0 54211.2 56156.4 56262.4 56747.1 57496.4 8213.9 8226.7 8246.7 8286.3 8367.5 13203.6 13632.2 13850.6 13926.5 14261.2 11448.2 11542.9 11725.1 11741.9 11925.2 10949.7 11122.4 11158.1 11158.3 11164.5 10423.0 10436.4 10765.9 10771.5 10778.9 8368.8 8504.1 8568.1 8666.1 8772.5 11056.6 11170.5 11185.4 11185.9 11523.7 07:22:03 INFO - PID 21826 | 07:22:03 INFO - PID 21826 | [#3] mootools.html Cycles:180 Average:6229.26 Median:4828.52 stddev:4050.39 (83.9%) stddev-sans-first:4044.74 07:22:03 INFO - PID 21826 | Values: 1288.8 1350.4 1356.0 1361.9 1365.6 9341.7 9830.8 10135.7 10180.0 10182.5 9827.3 9912.7 9942.5 9994.5 10008.1 2163.2 2194.6 2197.4 2217.9 2220.5 2106.5 2159.4 2170.1 2171.3 2174.0 2123.6 2144.9 2152.9 2155.3 2159.1 2086.2 2090.0 2091.7 2100.5 2101.7 1836.6 1896.4 1995.5 2072.4 2150.7 9843.3 9916.0 9954.4 10194.2 10247.1 5217.3 5415.5 5416.1 5417.2 5432.4 3071.5 3126.8 3130.6 3156.2 3163.7 957.8 958.4 972.3 976.4 1026.1 14689.0 14699.7 14888.1 14900.6 14921.0 4700.0 4758.1 4775.6 4803.4 4914.7 11130.7 11135.2 11155.3 11169.6 11185.2 5366.3 5369.8 5380.6 5394.2 5402.8 4872.7 4907.4 5007.5 5031.5 5086.6 3832.0 3928.6 3979.0 4006.2 4054.5 1128.8 1132.1 1138.0 1141.5 1144.2 666.7 674.2 683.7 686.5 693.3 5634.4 5695.6 5752.9 5828.7 6059.7 812.3 817.2 825.7 832.4 860.5 3301.4 3330.2 3361.6 3367.9 3425.2 12946.5 13210.2 13396.3 13396.7 13421.4 12984.4 13064.2 13119.6 13270.0 13352.9 9393.3 9403.3 9513.6 9531.1 9537.8 5462.3 5637.6 5726.5 5768.2 5847.1 11587.8 11680.5 11790.9 11792.9 11817.4 12105.1 12110.1 12216.3 12290.2 12318.5 7611.2 7688.5 7722.9 7875.1 7878.6 9333.7 9336.7 9346.2 9421.9 9432.1 7834.3 7872.5 7892.6 7976.3 8033.4 8217.3 8225.4 8284.5 8291.9 8318.6 6918.1 6922.6 7004.4 7005.0 7019.5 4853.6 4959.6 5021.5 5041.0 5074.7 5079.9 5127.9 5180.8 5362.7 5364.8 07:22:03 INFO - PID 21826 | 07:22:03 INFO - PID 21826 | [#4] prototype.html Cycles:180 Average:4779.82 Median:5331.53 stddev:1360.72 (25.5%) stddev-sans-first:1323.90 07:22:03 INFO - PID 21826 | Values: 382.3 401.1 403.6 406.3 406.7 5420.8 5508.0 5531.4 5557.5 5567.8 5368.4 5441.3 5445.3 5451.2 5464.7 4219.9 4222.8 4223.8 4228.2 4232.5 4070.7 4223.0 4249.8 4255.8 4278.8 4186.0 4201.7 4207.1 4209.3 4209.7 4205.5 4211.6 4219.7 4225.5 4239.9 3501.3 3713.1 3727.5 3739.4 3742.8 5250.9 5282.3 5288.1 5311.4 5337.3 4843.8 4845.0 4847.3 4853.9 4868.6 5521.5 5648.3 5705.9 5734.3 5739.5 4056.6 4064.1 4067.4 4067.9 4069.8 5736.4 5847.7 5888.8 6040.3 6081.8 4150.4 4151.1 4151.8 4153.3 4153.8 4204.9 4223.2 4224.6 4241.5 4242.6 4830.4 4837.7 4846.6 4866.2 5021.8 5758.5 5796.3 5800.1 5802.9 5803.2 1586.4 1597.8 1598.1 1607.5 1618.4 1076.4 1157.4 1157.8 1161.2 1166.4 5068.4 5077.6 5079.3 5081.7 5083.5 6002.2 6003.0 6010.4 6014.7 6020.9 4968.8 4999.8 5043.1 5052.0 5077.4 3154.0 3186.3 3186.4 3190.8 3191.2 5454.9 5563.5 5564.2 5569.1 5572.4 6058.9 6080.8 6110.9 6111.7 6158.1 5533.3 5545.2 5546.6 5563.8 5564.8 5704.3 5926.2 5929.4 5951.5 5983.9 5822.7 5828.2 5847.3 5850.7 5854.8 5197.3 5325.8 5367.1 5505.6 5545.7 4445.5 4473.2 4479.4 4497.9 4526.8 5809.0 5943.9 5949.2 5956.9 5980.6 5715.5 5729.5 5761.7 5761.9 5762.6 5747.5 5753.5 5755.9 5773.2 5800.7 5469.9 5597.6 5645.8 5656.6 5665.4 5787.5 5796.7 5798.9 5801.4 5803.9 5466.6 5654.6 5657.0 5661.2 5661.3 07:22:03 INFO - PID 21826 | 07:22:03 INFO - PID 21826 | [#5] yui.html Cycles:180 Average:13767.65 Median:3532.77 stddev:16331.52 (462.3%) stddev-sans-first:16347.78 07:22:03 INFO - PID 21826 | Values: 685.1 689.7 698.4 720.4 722.5 12362.0 12757.6 12997.7 13057.2 13328.3 12348.6 12523.3 12538.6 12543.4 13008.2 625.0 643.1 818.6 832.4 857.8 847.3 858.1 858.3 860.9 861.9 896.1 899.9 900.0 900.9 903.3 890.8 890.9 894.2 895.5 896.0 660.3 660.8 660.9 662.6 663.1 13632.7 13753.1 13776.0 13801.9 14023.3 13233.7 13290.7 13724.7 13766.1 14135.9 9970.4 10073.9 10232.6 10239.6 10395.2 2570.7 2571.3 2577.1 2657.9 2676.1 33622.6 47725.8 51854.5 58947.0 58986.7 10597.9 10599.9 10656.9 10767.4 10858.5 19706.2 19721.9 19740.5 19773.0 19831.9 6552.4 6714.4 6776.2 6808.5 6961.4 3328.5 3340.9 3346.7 3373.8 3440.3 3457.4 3513.5 3521.0 3544.6 3554.0 673.6 685.5 686.9 692.8 705.4 532.2 537.1 544.9 557.8 562.1 8100.6 8189.8 8455.7 8481.9 8628.4 531.4 542.0 554.3 561.3 564.8 3771.3 3789.4 3812.6 3831.6 3924.2 61047.0 61364.7 62255.7 62522.0 64538.7 55481.0 55646.2 56100.0 56543.0 59212.0 48390.0 48545.0 48919.0 49013.5 49383.8 7777.9 7992.8 8085.4 8101.5 8152.3 26309.5 26660.2 26789.0 27260.5 27311.2 31783.0 32405.7 32449.8 32830.5 33102.2 10369.2 10878.7 11245.3 11296.8 11577.7 11292.6 12359.0 12613.6 12676.4 13009.2 11456.9 11638.6 12277.7 12280.3 12707.6 12126.5 12344.6 12999.9 13757.7 13760.5 11719.5 12557.4 12664.2 12965.5 12992.4 10394.4 10422.2 11020.7 11023.9 11062.6 8628.9 8887.9 10284.5 10437.3 10508.7 07:22:03 INFO - PID 21826 | -------- Summary: end -------- 07:22:03 INFO - PID 21826 | 07:22:04 INFO - TEST-INFO | 21826: exit 0 07:22:04 INFO - TEST-OK | dromaeo_css | took 1120884ms 07:22:04 INFO - TEST-START | kraken 07:22:04 INFO - operating with platform_type : linux_ 07:22:04 INFO - Initialising browser for kraken test... 07:22:04 INFO - TEST-INFO | started process 22206 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnyQHtW/profile http://localhost:54580/getInfo.html) 07:22:08 INFO - PID 22206 | __metrics Screen width/height:1600/1200 07:22:08 INFO - PID 22206 | colorDepth:24 07:22:08 INFO - PID 22206 | Browser inner width/height: 1024/697 07:22:08 INFO - PID 22206 | __metrics 07:22:09 ERROR - PID 22206 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 07:22:10 INFO - TEST-INFO | 22206: exit 0 07:22:10 INFO - Browser initialized. 07:22:10 INFO - Running cycle 1/1 for kraken test... 07:22:10 INFO - TEST-INFO | started process 22335 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnyQHtW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:22:22 INFO - PID 22335 | RSS: Main: 154378240 07:22:22 INFO - PID 22335 | 07:22:25 INFO - PID 22335 | Cycle 1(1): loaded http://localhost:54580/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54580/tests/kraken/driver.html?testName=audio-beat-detection) 07:22:26 INFO - PID 22335 | RSS: Main: 160526336 07:22:26 INFO - PID 22335 | 07:22:29 INFO - PID 22335 | Cycle 1(1): loaded http://localhost:54580/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54580/tests/kraken/driver.html?testName=audio-dft) 07:22:29 INFO - PID 22335 | RSS: Main: 160153600 07:22:29 INFO - PID 22335 | 07:22:32 INFO - PID 22335 | Cycle 1(1): loaded http://localhost:54580/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54580/tests/kraken/driver.html?testName=audio-fft) 07:22:33 INFO - PID 22335 | RSS: Main: 156786688 07:22:33 INFO - PID 22335 | 07:22:35 INFO - PID 22335 | Cycle 1(1): loaded http://localhost:54580/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54580/tests/kraken/driver.html?testName=audio-oscillator) 07:22:36 INFO - PID 22335 | RSS: Main: 158437376 07:22:36 INFO - PID 22335 | 07:22:38 INFO - PID 22335 | Cycle 1(1): loaded http://localhost:54580/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54580/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:22:38 INFO - PID 22335 | RSS: Main: 157806592 07:22:38 INFO - PID 22335 | 07:22:42 INFO - PID 22335 | Cycle 1(1): loaded http://localhost:54580/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54580/tests/kraken/driver.html?testName=imaging-darkroom) 07:22:42 INFO - PID 22335 | RSS: Main: 163389440 07:22:42 INFO - PID 22335 | 07:22:46 INFO - PID 22335 | Cycle 1(1): loaded http://localhost:54580/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54580/tests/kraken/driver.html?testName=imaging-desaturate) 07:22:47 INFO - PID 22335 | RSS: Main: 160776192 07:22:47 INFO - PID 22335 | 07:22:50 INFO - PID 22335 | Cycle 1(1): loaded http://localhost:54580/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54580/tests/kraken/driver.html?testName=json-parse-financial) 07:22:50 INFO - PID 22335 | RSS: Main: 161742848 07:22:50 INFO - PID 22335 | 07:22:52 INFO - PID 22335 | Cycle 1(1): loaded http://localhost:54580/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54580/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:22:53 INFO - PID 22335 | RSS: Main: 161861632 07:22:53 INFO - PID 22335 | 07:22:54 INFO - PID 22335 | Cycle 1(1): loaded http://localhost:54580/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54580/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:22:55 INFO - PID 22335 | RSS: Main: 162295808 07:22:55 INFO - PID 22335 | 07:22:57 INFO - PID 22335 | Cycle 1(1): loaded http://localhost:54580/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54580/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:22:58 INFO - PID 22335 | RSS: Main: 162570240 07:22:58 INFO - PID 22335 | 07:23:01 INFO - PID 22335 | Cycle 1(1): loaded http://localhost:54580/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54580/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:23:02 INFO - PID 22335 | RSS: Main: 163143680 07:23:02 INFO - PID 22335 | 07:23:05 INFO - PID 22335 | Cycle 1(1): loaded http://localhost:54580/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54580/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:23:06 INFO - PID 22335 | RSS: Main: 162779136 07:23:06 INFO - PID 22335 | 07:23:07 INFO - PID 22335 | Cycle 1(1): loaded http://localhost:54580/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54580/tests/kraken/driver.html?testName=ai-astar) 07:23:08 INFO - PID 22335 | RSS: Main: 164630528 07:23:08 INFO - PID 22335 | 07:23:08 INFO - PID 22335 | __start_tp_report 07:23:08 INFO - PID 22335 | _x_x_mozilla_page_load 07:23:08 INFO - PID 22335 | _x_x_mozilla_page_load_details 07:23:08 INFO - PID 22335 | |i|pagename|runs| 07:23:08 INFO - PID 22335 | |0;ai-astar;103;111;113;114;112;112;113;113;111;112 07:23:08 INFO - PID 22335 | |1;audio-beat-detection;149;126;126;165;129;132;129;125;154;127 07:23:08 INFO - PID 22335 | |2;audio-dft;164;166;168;169;165;174;166;163;166;165 07:23:08 INFO - PID 22335 | |3;audio-fft;75;75;75;109;76;75;75;76;90;75 07:23:08 INFO - PID 22335 | |4;audio-oscillator;84;84;117;84;84;84;105;85;84;111 07:23:08 INFO - PID 22335 | |5;imaging-gaussian-blur;115;114;114;114;115;118;113;114;114;115 07:23:08 INFO - PID 22335 | |6;imaging-darkroom;152;151;150;149;150;151;150;151;150;151 07:23:08 INFO - PID 22335 | |7;imaging-desaturate;94;95;95;95;95;95;95;95;95;94 07:23:08 INFO - PID 22335 | |8;json-parse-financial;69;69;68;71;70;70;69;70;70;70 07:23:08 INFO - PID 22335 | |9;json-stringify-tinderbox;54;54;55;55;55;57;61;55;56;55 07:23:08 INFO - PID 22335 | |10;stanford-crypto-aes;83;83;83;83;89;85;91;83;82;90 07:23:08 INFO - PID 22335 | |11;stanford-crypto-ccm;140;142;137;136;140;135;142;134;226;142 07:23:08 INFO - PID 22335 | |12;stanford-crypto-pbkdf2;192;199;198;207;192;196;198;193;196;189 07:23:08 INFO - PID 22335 | |13;stanford-crypto-sha256-iterative;74;71;71;71;72;71;72;71;72;72 07:23:08 INFO - PID 22335 | __end_tp_report 07:23:08 INFO - PID 22335 | __start_cc_report 07:23:08 INFO - PID 22335 | _x_x_mozilla_cycle_collect,864 07:23:08 INFO - PID 22335 | __end_cc_report 07:23:08 INFO - PID 22335 | __startTimestamp1490192588058__endTimestamp 07:23:08 INFO - PID 22335 | 07:23:08 INFO - PID 22335 | ------- Summary: start ------- 07:23:08 INFO - PID 22335 | Number of tests: 14 07:23:08 INFO - PID 22335 | 07:23:08 INFO - PID 22335 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.50 stddev:3.10 (2.8%) stddev-sans-first:1.00 07:23:08 INFO - PID 22335 | Values: 103.0 111.0 113.0 114.0 112.0 112.0 113.0 113.0 111.0 112.0 07:23:08 INFO - PID 22335 | 07:23:08 INFO - PID 22335 | [#1] audio-beat-detection Cycles:10 Average:136.20 Median:130.50 stddev:14.34 (11.0%) stddev-sans-first:14.44 07:23:08 INFO - PID 22335 | Values: 149.0 126.0 126.0 165.0 129.0 132.0 129.0 125.0 154.0 127.0 07:23:08 INFO - PID 22335 | 07:23:08 INFO - PID 22335 | [#2] audio-dft Cycles:10 Average:166.60 Median:166.00 stddev:3.13 (1.9%) stddev-sans-first:3.18 07:23:08 INFO - PID 22335 | Values: 164.0 166.0 168.0 169.0 165.0 174.0 166.0 163.0 166.0 165.0 07:23:08 INFO - PID 22335 | 07:23:08 INFO - PID 22335 | [#3] audio-fft Cycles:10 Average:80.10 Median:75.00 stddev:11.17 (14.9%) stddev-sans-first:11.69 07:23:08 INFO - PID 22335 | Values: 75.0 75.0 75.0 109.0 76.0 75.0 75.0 76.0 90.0 75.0 07:23:08 INFO - PID 22335 | 07:23:08 INFO - PID 22335 | [#4] audio-oscillator Cycles:10 Average:92.20 Median:84.00 stddev:13.28 (15.8%) stddev-sans-first:13.75 07:23:08 INFO - PID 22335 | Values: 84.0 84.0 117.0 84.0 84.0 84.0 105.0 85.0 84.0 111.0 07:23:08 INFO - PID 22335 | 07:23:08 INFO - PID 22335 | [#5] imaging-gaussian-blur Cycles:10 Average:114.60 Median:114.50 stddev:1.35 (1.2%) stddev-sans-first:1.42 07:23:08 INFO - PID 22335 | Values: 115.0 114.0 114.0 114.0 115.0 118.0 113.0 114.0 114.0 115.0 07:23:08 INFO - PID 22335 | 07:23:08 INFO - PID 22335 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:151.00 stddev:0.85 (0.6%) stddev-sans-first:0.71 07:23:08 INFO - PID 22335 | Values: 152.0 151.0 150.0 149.0 150.0 151.0 150.0 151.0 150.0 151.0 07:23:08 INFO - PID 22335 | 07:23:08 INFO - PID 22335 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 07:23:08 INFO - PID 22335 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 07:23:08 INFO - PID 22335 | 07:23:08 INFO - PID 22335 | [#8] json-parse-financial Cycles:10 Average:69.60 Median:70.00 stddev:0.84 (1.2%) stddev-sans-first:0.87 07:23:08 INFO - PID 22335 | Values: 69.0 69.0 68.0 71.0 70.0 70.0 69.0 70.0 70.0 70.0 07:23:08 INFO - PID 22335 | 07:23:08 INFO - PID 22335 | [#9] json-stringify-tinderbox Cycles:10 Average:55.70 Median:55.00 stddev:2.06 (3.7%) stddev-sans-first:2.09 07:23:08 INFO - PID 22335 | Values: 54.0 54.0 55.0 55.0 55.0 57.0 61.0 55.0 56.0 55.0 07:23:08 INFO - PID 22335 | 07:23:08 INFO - PID 22335 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:84.00 stddev:3.43 (4.1%) stddev-sans-first:3.54 07:23:08 INFO - PID 22335 | Values: 83.0 83.0 83.0 83.0 89.0 85.0 91.0 83.0 82.0 90.0 07:23:08 INFO - PID 22335 | 07:23:08 INFO - PID 22335 | [#11] stanford-crypto-ccm Cycles:10 Average:147.40 Median:141.00 stddev:27.78 (19.7%) stddev-sans-first:29.34 07:23:08 INFO - PID 22335 | Values: 140.0 142.0 137.0 136.0 140.0 135.0 142.0 134.0 226.0 142.0 07:23:08 INFO - PID 22335 | 07:23:08 INFO - PID 22335 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.00 Median:197.00 stddev:5.03 (2.6%) stddev-sans-first:5.13 07:23:08 INFO - PID 22335 | Values: 192.0 199.0 198.0 207.0 192.0 196.0 198.0 193.0 196.0 189.0 07:23:08 INFO - PID 22335 | 07:23:08 INFO - PID 22335 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.70 Median:72.00 stddev:0.95 (1.3%) stddev-sans-first:0.53 07:23:08 INFO - PID 22335 | Values: 74.0 71.0 71.0 71.0 72.0 71.0 72.0 71.0 72.0 72.0 07:23:08 INFO - PID 22335 | -------- Summary: end -------- 07:23:08 INFO - PID 22335 | 07:23:09 INFO - TEST-INFO | 22335: exit 0 07:23:09 INFO - TEST-OK | kraken | took 65036ms 07:23:09 INFO - SUITE-END | took 1185s 07:23:09 INFO - Completed test suite (00:19:46) 07:23:09 INFO - javascript benchmark 07:23:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6631.374960307024, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2664.840109593424, 2682.5439675255207, 2691.098482008527, 2721.8911243550247, 2725.7955653326, 5073.441921388644, 5165.096108181067, 5174.715390653512, 5196.688198708081, 5215.947840521599, 5121.590272778178, 5143.125668636331, 5167.069927413064, 5211.0, 5226.973865130669, 4685.69542979707, 4708.246680531116, 4736.100140973222, 4738.312944623028, 4747.8575642730775, 4728.858134255978, 4738.71567705937, 4750.738709370983, 4767.404074490689, 4811.855644330676, 4584.541545845422, 4614.8154073837, 4687.648426368036, 4693.967327188047, 4712.882177945545, 4613.0, 4662.743549104798, 4672.649551283634, 4706.858794236178, 4711.787969541345, 4531.682782205247, 4620.630349572026, 4623.69945953512, 4656.580907718321, 4665.953340466586, 5023.819402440424, 5051.040302342543, 5097.923531147036, 5098.796048158069, 5098.949010509885, 5539.224508568804, 5545.584081193886, 5565.499105080562, 5585.441455854423, 5603.187537807036, 5598.10430331145, 5601.943980560183, 5608.102703567451, 5614.859628509279, 5628.493435590775, 5084.745762711849, 5212.921806172911, 5217.452167522393, 5224.738763061831, 5270.051390749702, 5647.6893770843, 5694.914576281359, 5740.655560666373, 5746.482816546531, 5767.423257674199, 5295.655782374133, 5359.490848369399, 5365.436629153961, 5484.533814625802, 5485.61600687956, 5393.919091213556, 5469.808556700496, 5484.972575137099, 5492.038893193675, 5550.27846379968, 5331.893362132736, 5440.047991601533, 5443.7822487100075, 5446.482584154499, 5452.890942181213, 5420.430854760193, 5421.674699518042, 5429.104197807396, 5433.347998240237, 5434.619576629598, 4543.068670922453, 4550.2492088804975, 4555.20283950314, 4568.79440425175, 4592.058627981256, 3970.82131304092, 3974.0462289050997, 3981.044549308203, 4006.0585762345827, 4018.3168861293652, 4814.494478079751, 4817.229243321122, 4821.180399332122, 4834.516548345137, 4871.025794841046, 5450.236966824647, 5455.372632147354, 5577.191307260425, 5614.185943038318, 5615.241942337814, 4795.424549054136, 4813.9037219256115, 4824.927626085611, 4842.878928026757, 4851.223804191312, 4869.561739443467, 4891.972685735964, 4897.314375987365, 4906.632002599819, 4947.1837146871085, 5044.949550504448, 5046.09170349326, 5177.948220517822, 5188.818391356284, 5239.973800130975, 5575.0, 5581.358143813513, 5592.189132575835, 5607.158926161109, 5635.154726791015, 5138.203578445347, 5140.537351638371, 5141.28022076917, 5142.074426603098, 5146.76839542229, 5356.839294821161, 5442.238086667949, 5443.510084092451, 5450.155225939986, 5452.972735136299, 5501.614886957875, 5577.051901176728, 5590.636608620427, 5611.719414029364, 5613.494785469327, 5364.409914909279, 5386.380566234933, 5388.434214407431, 5398.4871437213405, 5414.485623865727, 5263.526282634582, 5319.4414586467865, 5371.704556249444, 5390.380106287827, 5407.080796264723, 5254.737263136904, 5294.97352513235, 5296.470352964673, 5300.7084610345255, 5353.78584856617, 5374.623776335619, 5376.650517716336, 5377.973110134581, 5385.596080293915, 5451.972740136274, 5177.8187763428095, 5181.430042695225, 5227.3465816772905, 5247.606429517725, 5251.553617942518], "value": 5037.2334561678945, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [666.3469799596395, 721.72935149319, 742.0, 1065.0893486069415, 1076.7684947736236, 31029.844850775742, 31918.680813191862, 31965.0, 32043.67956320436, 32046.35907281853, 33190.66809331906, 33748.0, 33820.0, 36587.63412365882, 36847.63152368476, 7165.426765858719, 7303.160136584294, 7307.159676637175, 7342.632868356561, 7441.776746697607, 7276.527025743336, 7353.742619008336, 7392.039034925479, 7392.630368481581, 7409.851802963937, 7406.7777966660815, 7439.0, 7448.962755186217, 7453.739119130832, 7468.775936721907, 7329.083864516935, 7385.6307184640555, 7388.3719883809945, 7451.441141914378, 7517.210692877278, 6959.8956015659805, 6999.300069993011, 7024.894626580605, 7032.191298000745, 7040.823979400505, 35128.29743405118, 35264.29471410583, 35266.47100293497, 35564.288714225826, 35581.46627800585, 2571.29289445404, 2581.625664278688, 2584.082650659008, 2598.7791037761813, 2664.2273740615196, 21815.890920545455, 21873.890630546906, 21902.452438689, 22000.669989950162, 22100.33698989033, 2734.6308248386613, 2760.4203117345382, 2763.571646394812, 2765.7234276572385, 2788.2750484873877, 130969.34515327362, 132023.0, 132436.33781831223, 133108.3344583271, 133921.0, 36908.26183476369, 37240.25519489595, 37459.62540374616, 37542.43686344707, 37582.62417375846, 39878.80060599736, 39943.40084898729, 42149.0, 42333.788331058146, 42462.47987761571, 11748.941255293668, 11936.58221962227, 12011.219270747373, 12035.338056406981, 12048.397580120958, 9392.15470607635, 9444.433333999981, 9449.905500944902, 9451.574679139318, 9457.43255404678, 13444.32778361078, 13465.326733663278, 13489.460421583222, 13563.0, 13679.0, 5464.0, 5518.0, 5529.419410961871, 5617.887642247132, 5653.265075540154, 839.4879123734516, 857.237059017475, 865.048446708628, 865.9307255419551, 877.4206428428803, 21140.47148821292, 21620.891895540422, 21713.67429488559, 21724.674129888066, 21951.0, 943.4999450291357, 953.2326477185793, 953.7853982853941, 955.5747692277009, 983.0808194338316, 11080.501377438035, 11111.333320000826, 11399.316041037398, 11416.94291528537, 11436.428178591037, 221638.0, 222205.0, 223483.0, 223723.0, 224226.0, 44322.33516497255, 44674.77662611731, 44698.329525057154, 44737.0, 44763.32855007112, 1187.9940600296943, 1207.6293406983139, 1232.580922486359, 1236.4250623460134, 1237.0, 22839.376580791384, 23855.52288954246, 24132.758672413052, 24288.514229714954, 25426.364340891625, 31034.0689779307, 31441.21396965094, 31456.685433146293, 31478.685213147575, 31516.527252091695, 200058.0, 200851.0, 201796.0, 201817.0, 201935.0, 29554.852225738734, 29609.0, 29813.552796707634, 29837.850810745807, 29912.85043574855, 35157.82421087878, 35543.82228088843, 35595.64404355923, 36253.65561026757, 36254.018087016404, 30282.84858575693, 30304.5454318181, 30404.847975759978, 30528.542071869382, 31613.367732644758, 30102.397952041276, 30410.39179216359, 30643.23391915131, 30794.0, 31615.683843161274, 29654.894668542485, 30090.548641769954, 30327.545086823273, 30396.84801575978, 30499.2375190622, 23580.88209558941, 25478.23565293044, 26876.59685104686, 26941.730582693923, 28011.579826302215, 22047.22834700778, 22127.778722212573, 22166.445838854157, 22167.778322217215, 22227.110915563197], "value": 14769.520455821443, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.5342709311384, 417.73473844109003, 421.2606874934489, 437.48158432257776, 440.9184300904333, 11949.701257468545, 13383.799243011363, 16791.664166716673, 17404.43209142126, 17500.912495437522, 17305.480835574952, 17624.295028198856, 17873.19570619322, 17929.64140717185, 18106.4568062958, 5639.351474580414, 5709.71451427429, 5732.7133643317875, 5927.555433342495, 5933.495652869511, 5708.686022268774, 5768.942310576904, 5769.624974376652, 5770.2210201622875, 5790.160426738121, 5477.698726570037, 5711.114777209539, 5725.885482290351, 5726.885462290752, 5733.885322293551, 5638.887222255573, 5653.802116925908, 5690.146478028288, 5774.307083150028, 5819.970900145472, 5156.767945442464, 5175.560077393426, 5182.974085129588, 5190.169572868323, 5191.299174611417, 22080.447988800246, 22555.097796088136, 22834.543309133725, 22893.427664308358, 22990.655140172912, 1598.9520314390586, 1607.6302450436465, 1624.6669432766373, 1633.5834362237672, 1669.232153209525, 13825.51610693621, 13976.161430314214, 14011.579652610439, 14142.717145657132, 14900.403983840633, 1621.7567364895242, 1629.2029179162869, 1637.6571658687162, 1638.1563494800068, 1656.6686662667514, 84901.0, 88340.11659883383, 88818.5559072207, 89624.0, 89764.0, 11087.33475991443, 11091.5563377464, 11112.888871111347, 11210.607628732956, 11546.806106839673, 15624.687506249811, 15763.0, 15898.205089745466, 15900.76148857768, 15931.522054338388, 7158.14102307716, 7322.231165727629, 7373.188949215582, 7458.2541745826065, 7479.476436649491, 6430.967845160838, 6505.804825855232, 6708.731650734014, 6746.595204287759, 6747.0, 6978.616176110261, 6993.580385176906, 7074.75238366665, 7115.644217789089, 7191.173015103225, 1893.5739458621974, 1900.8479321654233, 1905.4474202481401, 1915.5115445561294, 2119.8940052997286, 826.6404114210337, 838.3502785341287, 843.9367047471465, 866.8959724833061, 884.3544212724747, 16432.917835410746, 16482.42311519115, 16619.252133653772, 16795.748063779054, 17457.47627571175, 857.652650676477, 860.8493513635214, 861.8017855893054, 864.5561911607631, 876.7501262140387, 9331.393459425115, 9376.953115234517, 9378.64009718587, 9622.566984485715, 10882.40146791934, 454745.0, 461295.0, 470994.0, 476619.0, 486579.0, 91409.0, 94120.52939735394, 94399.0, 94580.52709736407, 96058.0, 1077.0683358894657, 1085.0614218700766, 1112.671761830262, 1118.139032944628, 1123.9831402528969, 16665.416710415077, 16863.0, 18066.548336291697, 18138.637227255116, 18285.81714182841, 41982.790086049376, 44205.0, 44417.11165776731, 44678.3298250533, 44711.0, 54211.18683219676, 56156.43843561512, 56262.43737562572, 56747.14879276897, 57496.42503575078, 8213.876791848246, 8226.670933162606, 8246.662314427653, 8286.254237118688, 8367.497950123012, 13203.603891883258, 13632.182069075887, 13850.584482465541, 13926.51257205993, 14261.215633140277, 11448.198626096426, 11542.94228528852, 11725.120615953667, 11741.945159597208, 11925.165238433226, 10949.671509854717, 11122.388268645302, 11158.10735141203, 11158.274712143684, 11164.497597607964, 10423.0, 10436.37381757097, 10765.892341076802, 10771.515281812493, 10778.946105269424, 8368.790780230544, 8504.107068757692, 8568.100349463217, 8666.050138718738, 8772.473651580925, 11056.557737690402, 11170.497327620114, 11185.440727963733, 11185.888141118485, 11523.654290371302], "value": 9002.275459875264, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1288.8195652608636, 1350.4260689207085, 1355.9593212203638, 1361.8638136186376, 1365.6039748472947, 9341.719748407542, 9830.754231144225, 10135.695929122128, 10180.0, 10182.490875456226, 9827.312088153833, 9912.702618921443, 9942.453165075936, 9994.45030523321, 10008.099271065603, 2163.167180635459, 2194.6378847490223, 2197.373748481683, 2217.8891055447243, 2220.467087898901, 2106.515501434671, 2159.384575396012, 2170.077716970289, 2171.250918433146, 2173.9565208695817, 2123.6389813731703, 2144.8927553622334, 2152.881591512466, 2155.299527653511, 2159.1039718516877, 2086.2072412483235, 2090.017691684913, 2091.748990121195, 2100.516881117344, 2101.674240492726, 1836.5500452389117, 1896.421591414618, 1995.5310502032012, 2072.4197224777085, 2150.6773983902385, 9843.310968232227, 9916.0, 9954.352967057119, 10194.184465242763, 10247.128994035516, 5217.3217481727515, 5415.48552887475, 5416.0792665247, 5417.160340147283, 5432.429594892558, 3071.508558630608, 3126.765492588065, 3130.63997640272, 3156.226724452501, 3163.6678148794504, 957.7636219427645, 958.434523631054, 972.2562239886493, 976.3946353260952, 1026.1175389165312, 14689.0, 14699.706005879929, 14888.106713597219, 14900.62748431298, 14921.0, 4699.976500117546, 4758.1435341638835, 4775.562458442065, 4803.3995750531185, 4914.680545764514, 11130.664320281618, 11135.220534562664, 11155.27490713101, 11169.553217871195, 11185.217034807485, 5366.2755528004, 5369.812056578001, 5380.623356365017, 5394.163904594716, 5402.783888644411, 4872.731999740048, 4907.411110666671, 5007.47421520735, 5031.52200540948, 5086.618503612244, 3831.9616803832164, 3928.607139286106, 3979.0, 4006.198760247904, 4054.493188351456, 1128.802459569572, 1132.0999805154922, 1138.0, 1141.5034460009922, 1144.2276463387348, 666.7499687617144, 674.2280089297825, 683.6855046678584, 686.4645576450376, 693.3066933066933, 5634.352049514277, 5695.601307908407, 5752.856178595485, 5828.737706803119, 6059.7273122709585, 812.3298278919915, 817.2154731457748, 825.7481468152271, 832.3923535818765, 860.4665107633307, 3301.3892429900543, 3330.200751819546, 3361.6470270621235, 3367.9494807577908, 3425.1779572902824, 12946.546870859664, 13210.207387556777, 13396.263205523595, 13396.732065358638, 13421.39603717835, 12984.350782461028, 13064.216147031018, 13119.606411807661, 13270.0, 13352.866471335163, 9393.342466027449, 9403.34176607631, 9513.621594601349, 9531.094546018117, 9537.761555961157, 5462.3445186577865, 5637.57718171147, 5726.455986681259, 5768.221290125779, 5847.1229315603, 11587.768244635228, 11680.47437865315, 11790.941045295061, 11792.882071179522, 11817.409129543317, 12105.092118091003, 12110.091743119125, 12216.26702397859, 12290.20113692607, 12318.507259709511, 7611.162772094955, 7688.538687678757, 7722.92277077222, 7875.133735288999, 7878.645460954156, 9333.673321433716, 9336.673216437392, 9346.15884570392, 9421.858672119786, 9432.103950124727, 7834.255745704149, 7872.527648341118, 7892.6053697313755, 7976.322012628992, 8033.437659363788, 8217.30152937007, 8225.424220304521, 8284.544350060563, 8291.917080829115, 8318.625661845352, 6918.135233095863, 6922.58464492132, 7004.3696067354185, 7005.0, 7019.4735394844565, 4853.635977301646, 4959.553640172402, 5021.472745361831, 5040.966601846686, 5074.746262686925, 5079.92380114306, 5127.871868188992, 5180.844574662766, 5362.678239305654, 5364.839054828361], "value": 4659.092199550232, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.33855430105916, 401.1455599572911, 403.56011946977793, 406.28291066268025, 406.6827874258076, 5420.783168673258, 5508.0, 5531.419200983894, 5557.499825015748, 5567.805126820562, 5368.409474957752, 5441.319835020622, 5445.264889239951, 5451.182322651604, 5464.672119672822, 4219.873403797883, 4222.78886055696, 4223.838444427776, 4228.217779710748, 4232.470941132358, 4070.694697897655, 4223.0, 4249.830006799724, 4255.829766809324, 4278.828846846122, 4185.965175247951, 4201.684873634475, 4207.137536804948, 4209.34755112958, 4209.705320627558, 4205.537390887031, 4211.620954114129, 4219.683523735732, 4225.492940847103, 4239.91520169598, 3501.2997400519744, 3713.090292878262, 3727.459518369821, 3739.4016957286703, 3742.831572579213, 5250.9474905250845, 5282.260483532308, 5288.127458969304, 5311.442298558634, 5337.290583044785, 4843.757812109416, 4844.95155048452, 4847.303443794679, 4853.927191092136, 4868.610511159099, 5521.503064724154, 5648.293963254593, 5705.942940570624, 5734.254546908917, 5739.483446489836, 4056.5740597237454, 4064.0855807443386, 4067.4102255172834, 4067.9389809152885, 4069.796510174509, 5736.368999410061, 5847.707614619252, 5888.764449422018, 6040.335563088057, 6081.756729730805, 4150.418941348214, 4151.14901445209, 4151.813168407369, 4153.293940030202, 4153.813078411479, 4204.894877628022, 4223.155368926227, 4224.640905523003, 4241.491021077429, 4242.61816436516, 4830.415727585725, 4837.733924634179, 4846.636502262344, 4866.248150665758, 5021.799128034911, 5758.539316854642, 5796.275465566804, 5800.1299805029585, 5802.912956305659, 5803.245578074823, 1586.4209563509467, 1597.7922870026823, 1598.1370060167612, 1607.4856046065381, 1618.4173697468902, 1076.4402510694395, 1157.3865851098763, 1157.7684463107412, 1161.2451906260828, 1166.3585028234438, 5068.366454193226, 5077.593792496591, 5079.3396858408905, 5081.669691470042, 5083.542481176712, 6002.159697642333, 6003.0, 6010.3689112643415, 6014.699265036731, 6020.939790602126, 4968.826091086795, 4999.800007999712, 5043.092243396224, 5051.974740126276, 5077.416097148801, 3153.984230078835, 3186.2512309607223, 3186.3786561620263, 3190.760692948038, 3191.1702957231287, 5454.945450545523, 5563.471470210324, 5564.248826408464, 5569.10894256917, 5572.359178694502, 6058.878822423527, 6080.7567697291615, 6110.883449440728, 6111.724972376253, 6158.137860699506, 5533.280673512579, 5545.195946587723, 5546.584006199551, 5563.803782186849, 5564.777408903679, 5704.286964129484, 5926.244296402194, 5929.407059294036, 5951.523878089656, 5983.880322393441, 5822.73797679097, 5828.184054232326, 5847.327557330961, 5850.678212698343, 5854.799766048035, 5197.298364720715, 5325.760340784596, 5367.060764366299, 5505.587080969023, 5545.72271386421, 4445.488768791501, 4473.217186992329, 4479.417675702138, 4497.887552811206, 4526.8189272428735, 5809.0, 5943.881122377615, 5949.167116603766, 5956.940430595639, 5980.641161530322, 5715.542536653127, 5729.510327314845, 5761.658238221905, 5761.884762304647, 5762.625429347079, 5747.540196784331, 5753.453421924911, 5755.942440575541, 5773.220615216892, 5800.651960882361, 5469.906018796177, 5597.580181486323, 5645.774169033192, 5656.575756818337, 5665.402469431858, 5787.450192231731, 5796.739146738491, 5798.855028624318, 5801.3908539602735, 5803.883922321445, 5466.590005749665, 5654.6324488908085, 5656.981743286248, 5661.179129026185, 5661.2923384576925], "value": 4378.303898656755, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [685.1435705368289, 689.6689588997284, 698.4168219536687, 720.4092644031892, 722.5267449820369, 12362.0, 12757.617271481848, 12997.675058123552, 13057.151285166457, 13328.333583320844, 12348.567800126975, 12523.311217883012, 12538.561150359716, 12543.435545400456, 13008.154469959469, 625.0468036244717, 643.1060825452624, 818.615250832111, 832.37571821134, 857.7898414888361, 847.2882778466087, 858.0561382479254, 858.2919091749301, 860.9397342186049, 861.8750281209221, 896.0680891872445, 899.9325050621229, 899.9820003599924, 900.8963969143567, 903.3495882964288, 890.7639475538988, 890.9287257019455, 894.2309613732185, 895.50299583731, 895.9820803583892, 660.3231687520282, 660.828184671984, 660.9471242300605, 662.6256165266657, 663.0683889135772, 13632.727345453135, 13753.106048106942, 13776.0, 13801.930990345085, 14023.29883505831, 13233.735325293537, 13290.667733306647, 13724.65688357789, 13766.129072388672, 14135.929320353333, 9970.351927124786, 10073.949630251875, 10232.64185753495, 10239.641612543599, 10395.16838652906, 2570.717221105677, 2571.3186005708503, 2577.1366592191453, 2657.853818040007, 2676.1168814291236, 33622.55462854446, 47725.76137119292, 51854.48145518534, 58947.0, 58986.705066474824, 10597.9470102649, 10599.947000264949, 10656.89343106559, 10767.3539587625, 10858.511366988505, 19706.21175152978, 19721.901390492956, 19740.506487337643, 19773.0, 19831.900840495993, 6552.410283074546, 6714.429273511709, 6776.15298087739, 6808.489363297773, 6961.37347638715, 3328.5173649821127, 3340.883069092619, 3346.7489938254243, 3373.797572145679, 3440.2775417162175, 3457.3776720190103, 3513.50810886471, 3520.964790352115, 3544.57465104184, 3553.964460355415, 673.6025744810586, 685.4721864164566, 686.9484788640872, 692.7886994466736, 705.3827900586987, 532.2256117349248, 537.1030379266634, 544.8882978989297, 557.8354385456219, 562.1455387810587, 8100.630677085381, 8189.754307370788, 8455.74632761018, 8481.872771908425, 8628.43915145526, 531.3544043986575, 541.9701916394636, 554.2849723856181, 561.3123923194055, 564.8051422259314, 3771.340015497277, 3789.374753165697, 3812.599677033927, 3831.5976822433245, 3924.156306394139, 61047.0, 61364.693176534725, 62255.6887215561, 62522.0, 64538.6773066141, 55481.0, 55646.16530752042, 56100.0, 56543.0, 59212.0, 48390.0, 48545.0, 48919.0, 49013.509864900894, 49383.75308123508, 7777.92222077772, 7992.8001799953145, 8085.43401961857, 8101.473404228706, 8152.2662960333855, 26309.473810524065, 26660.200193994213, 26789.0, 27260.454790904467, 27311.180664580093, 31783.0, 32405.675943240265, 32449.837750811093, 32830.507542387364, 33102.172445688084, 10369.222308326755, 10878.673639790819, 11245.325280483197, 11296.774064518828, 11577.6526704199, 11292.604758833402, 12359.0, 12613.558525451932, 12676.366181690693, 13009.154404963647, 11456.94271528637, 11638.592649257236, 12277.693057673272, 12280.263184208976, 12707.555235566711, 12126.451716073574, 12344.62966111018, 12999.870001300244, 13757.656058598215, 13760.518381856587, 11719.531218751496, 12557.434915428645, 12664.176828506117, 12965.481380744664, 12992.415341309475, 10394.376337419779, 10422.218333624856, 11020.724481888017, 11023.873898636852, 11062.612808551663, 8628.870566941627, 8887.866681999905, 10284.537195826355, 10437.269391142547, 10508.737281567715], "value": 6224.01223368176, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1572.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 113.0, 114.0, 112.0, 112.0, 113.0, 113.0, 111.0, 112.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 126.0, 126.0, 165.0, 129.0, 132.0, 129.0, 125.0, 154.0, 127.0], "value": 136.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 168.0, 169.0, 165.0, 174.0, 166.0, 163.0, 166.0, 165.0], "value": 166.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 109.0, 76.0, 75.0, 75.0, 76.0, 90.0, 75.0], "value": 80.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 117.0, 84.0, 84.0, 84.0, 105.0, 85.0, 84.0, 111.0], "value": 92.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 114.0, 115.0, 118.0, 113.0, 114.0, 114.0, 115.0], "value": 114.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 150.0, 149.0, 150.0, 151.0, 150.0, 151.0, 150.0, 151.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 68.0, 71.0, 70.0, 70.0, 69.0, 70.0, 70.0, 70.0], "value": 69.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 55.0, 55.0, 57.0, 61.0, 55.0, 56.0, 55.0], "value": 55.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 83.0, 89.0, 85.0, 91.0, 83.0, 82.0, 90.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 142.0, 137.0, 136.0, 140.0, 135.0, 142.0, 134.0, 226.0, 142.0], "value": 147.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 199.0, 198.0, 207.0, 192.0, 196.0, 198.0, 193.0, 196.0, 189.0], "value": 196.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 71.0, 71.0, 71.0, 72.0, 71.0, 72.0, 71.0, 72.0, 72.0], "value": 71.7, "unit": "score"}]}]} 07:23:09 INFO - Return code: 0 07:23:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:23:09 ERROR - # TBPL SUCCESS # 07:23:09 INFO - Running post-action listener: _resource_record_post_action 07:23:09 INFO - [mozharness: 2017-03-22 14:23:09.888570Z] Finished run-tests step (success) 07:23:09 INFO - Running post-run listener: _resource_record_post_run 07:23:09 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 0; Write bytes: 364859392; Read time: 0; Write time: 295948 07:23:09 INFO - TinderboxPrint: CPU usage
13.3% 07:23:09 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 07:23:09 INFO - TinderboxPrint: I/O write bytes / time
364,859,392 / 295,948 07:23:09 INFO - TinderboxPrint: CPU idle
8,313.1 (86.7%) 07:23:09 INFO - TinderboxPrint: CPU user
1,220.2 (12.7%) 07:23:09 INFO - TinderboxPrint: Swap in / out
0 / 0 07:23:09 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 105492480; Read time: 0; Write time: 107700 07:23:09 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 259366912; Read time: 0; Write time: 188248 07:23:10 INFO - Running post-run listener: _upload_blobber_files 07:23:10 INFO - Blob upload gear active. 07:23:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:23:10 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 07:23:10 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'] 07:23:10 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 07:23:11 INFO - (blobuploader) - INFO - Open directory for files ... 07:23:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:23:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:23:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:23:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:23:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:23:11 INFO - (blobuploader) - INFO - Done attempting. 07:23:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:23:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:23:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:23:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:23:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:23:12 INFO - (blobuploader) - INFO - Done attempting. 07:23:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:23:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:23:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:23:13 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:23:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:23:13 INFO - (blobuploader) - INFO - Done attempting. 07:23:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:23:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:23:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:23:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:23:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:23:18 INFO - (blobuploader) - INFO - Done attempting. 07:23:18 INFO - (blobuploader) - INFO - Iteration through files over. 07:23:18 INFO - Return code: 0 07:23:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:23:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:23:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9d7f310f5e689f65afa920b3048e150cbf535e71018676e006de943df54a92c8414af1532cd4ddd4a6474f557845136dcf1c5ac884f2ce1e9e4d8bec2f04224d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ac0041889f6f3ea47af62828360ee694618bdd14aba205396ac9323be9cd16ba5a3b29f9f429e5f5c525740f6a5d6af984850117ba86f17353c3b73e681ad35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/def8d29be19c5df61f3c49a1c2292b1cfda3476652651abc8182d893ce4cb7841f76ffd9090531064d2faa0806edf603fa79dea1ab695bb097e67f37d06b5b42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a8941ebb0fc25b21339231c35012b71f6a1694c323e38207b13de32d3efeddcc7b7b793dd668c5eeac1006623a14e54fafc66a15477b41a19ca10f6eac80fcf"} 07:23:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:23:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:23:18 INFO - Contents: 07:23:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9d7f310f5e689f65afa920b3048e150cbf535e71018676e006de943df54a92c8414af1532cd4ddd4a6474f557845136dcf1c5ac884f2ce1e9e4d8bec2f04224d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ac0041889f6f3ea47af62828360ee694618bdd14aba205396ac9323be9cd16ba5a3b29f9f429e5f5c525740f6a5d6af984850117ba86f17353c3b73e681ad35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/def8d29be19c5df61f3c49a1c2292b1cfda3476652651abc8182d893ce4cb7841f76ffd9090531064d2faa0806edf603fa79dea1ab695bb097e67f37d06b5b42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a8941ebb0fc25b21339231c35012b71f6a1694c323e38207b13de32d3efeddcc7b7b793dd668c5eeac1006623a14e54fafc66a15477b41a19ca10f6eac80fcf"} 07:23:18 INFO - Running post-run listener: copy_logs_to_upload_dir 07:23:18 INFO - Copying logs to upload dir... 07:23:18 INFO - mkdir: /builds/slave/test/build/upload/logs 07:23:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.093543 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-03-22 07:23:17.552710) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-22 07:23:17.558356) ========= 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=2432103b8b3de4003b23cad4000001c2-1490191309.938043-1710955734 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/9d7f310f5e689f65afa920b3048e150cbf535e71018676e006de943df54a92c8414af1532cd4ddd4a6474f557845136dcf1c5ac884f2ce1e9e4d8bec2f04224d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ac0041889f6f3ea47af62828360ee694618bdd14aba205396ac9323be9cd16ba5a3b29f9f429e5f5c525740f6a5d6af984850117ba86f17353c3b73e681ad35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/def8d29be19c5df61f3c49a1c2292b1cfda3476652651abc8182d893ce4cb7841f76ffd9090531064d2faa0806edf603fa79dea1ab695bb097e67f37d06b5b42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a8941ebb0fc25b21339231c35012b71f6a1694c323e38207b13de32d3efeddcc7b7b793dd668c5eeac1006623a14e54fafc66a15477b41a19ca10f6eac80fcf"} build_url:https://queue.taskcluster.net/v1/task/MUCxLFXLQvKtAGf9VyDhNQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011346 build_url: 'https://queue.taskcluster.net/v1/task/MUCxLFXLQvKtAGf9VyDhNQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9d7f310f5e689f65afa920b3048e150cbf535e71018676e006de943df54a92c8414af1532cd4ddd4a6474f557845136dcf1c5ac884f2ce1e9e4d8bec2f04224d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ac0041889f6f3ea47af62828360ee694618bdd14aba205396ac9323be9cd16ba5a3b29f9f429e5f5c525740f6a5d6af984850117ba86f17353c3b73e681ad35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/def8d29be19c5df61f3c49a1c2292b1cfda3476652651abc8182d893ce4cb7841f76ffd9090531064d2faa0806edf603fa79dea1ab695bb097e67f37d06b5b42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a8941ebb0fc25b21339231c35012b71f6a1694c323e38207b13de32d3efeddcc7b7b793dd668c5eeac1006623a14e54fafc66a15477b41a19ca10f6eac80fcf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-22 07:23:17.586964) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 07:23:17.587349) ========= 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=2432103b8b3de4003b23cad4000001c2-1490191309.938043-1710955734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 07:23:17.672064) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-22 07:23:17.672500) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-22 07:23:17.673023) ========= ========= Total master_lag: 0.34 =========