builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-046 starttime: 1490195906.69 results: success (0) revision: 00c595de162736689a83e894a84f9eb99a5fa6ac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-22 08:18:26.694085) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-22 08:18:26.694596) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-22 08:18:26.694893) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-22 08:18:26.710863) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 08:18:26.711497) ========= 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=652eb03db935cfc1c15ebda0000001ad-1490195320.931823-1506931366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-22 08:18:26-- 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% 68.8M=0s 2017-03-22 08:18:27 (68.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.090255 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 08:18:26.816257) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 08:18:26.816579) ========= 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=652eb03db935cfc1c15ebda0000001ad-1490195320.931823-1506931366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021391 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 08:18:26.866016) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-22 08:18:26.866365) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 00c595de162736689a83e894a84f9eb99a5fa6ac --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 00c595de162736689a83e894a84f9eb99a5fa6ac --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=652eb03db935cfc1c15ebda0000001ad-1490195320.931823-1506931366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-22 08:18:27,157 truncating revision to first 12 chars 2017-03-22 08:18:27,157 Setting DEBUG logging. 2017-03-22 08:18:27,157 attempt 1/10 2017-03-22 08:18:27,157 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/00c595de1627?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-22 08:18:28,082 unpacking tar archive at: mozilla-central-00c595de1627/testing/mozharness/ program finished with exit code 0 elapsedTime=1.305203 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-22 08:18:28.184977) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-22 08:18:28.185349) ========= script_repo_revision: 00c595de162736689a83e894a84f9eb99a5fa6ac ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-22 08:18:28.185772) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-22 08:18:28.186061) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-22 08:18:28.195098) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-03-22 08:18:28.195511) ========= /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=652eb03db935cfc1c15ebda0000001ad-1490195320.931823-1506931366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:18:28 INFO - MultiFileLogger online at 20170322 08:18:28 in /builds/slave/test 08:18:28 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 08:18:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:18:28 INFO - {'append_to_log': False, 08:18:28 INFO - 'base_work_dir': '/builds/slave/test', 08:18:28 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:18:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:18:28 INFO - 'branch': 'Firefox-Non-PGO', 08:18:28 INFO - 'buildbot_json_path': 'buildprops.json', 08:18:28 INFO - 'config_files': ('talos/linux_config.py',), 08:18:28 INFO - 'default_actions': ('clobber', 08:18:28 INFO - 'read-buildbot-config', 08:18:28 INFO - 'download-and-extract', 08:18:28 INFO - 'populate-webroot', 08:18:28 INFO - 'create-virtualenv', 08:18:28 INFO - 'install', 08:18:28 INFO - 'run-tests'), 08:18:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:18:28 INFO - 'download_minidump_stackwalk': True, 08:18:28 INFO - 'download_symbols': 'ondemand', 08:18:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:18:28 INFO - 'tooltool.py': '/tools/tooltool.py', 08:18:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:18:28 INFO - '/tools/misc-python/virtualenv.py')}, 08:18:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:18:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:18:28 INFO - 'gecko_profile': False, 08:18:28 INFO - 'gecko_profile_interval': 0, 08:18:28 INFO - 'installer_path': 'installer.exe', 08:18:28 INFO - 'log_level': 'info', 08:18:28 INFO - 'log_name': 'talos', 08:18:28 INFO - 'log_to_console': True, 08:18:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:18:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:18:28 INFO - 'opt_config_files': (), 08:18:28 INFO - 'pip_index': False, 08:18:28 INFO - 'suite': 'dromaeojs-e10s', 08:18:28 INFO - 'system_bits': '32', 08:18:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:18:28 INFO - 'title': 'talos-linux64-ix-046', 08:18:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:18:28 INFO - 'use_talos_json': True, 08:18:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:18:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:18:28 INFO - 'work_dir': 'build'} 08:18:28 INFO - [mozharness: 2017-03-22 15:18:28.579947Z] Running clobber step. 08:18:28 INFO - Running pre-action listener: _resource_record_pre_action 08:18:28 INFO - Running main action method: clobber 08:18:28 INFO - rmtree: /builds/slave/test/build 08:18:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:18:29 INFO - Running post-action listener: _resource_record_post_action 08:18:29 INFO - [mozharness: 2017-03-22 15:18:29.519059Z] Finished clobber step (success) 08:18:29 INFO - [mozharness: 2017-03-22 15:18:29.519158Z] Running read-buildbot-config step. 08:18:29 INFO - Running pre-action listener: _resource_record_pre_action 08:18:29 INFO - Running main action method: read_buildbot_config 08:18:29 INFO - Using buildbot properties: 08:18:29 INFO - { 08:18:29 INFO - "project": "", 08:18:29 INFO - "product": "firefox", 08:18:29 INFO - "who": "ffxbld@noreply.mozilla.org", 08:18:29 INFO - "installer_path": "public/build/target.tar.bz2", 08:18:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:18:29 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:18:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:18:29 INFO - "stage_platform": "linux64", 08:18:29 INFO - "basedir": "/builds/slave/test", 08:18:29 INFO - "buildnumber": 479, 08:18:29 INFO - "platform": "ubuntu64_hw", 08:18:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:18:29 INFO - "slavebuilddir": "test", 08:18:29 INFO - "taskId": "Z_KiDGdCSwqLxHoWD-T1_A", 08:18:29 INFO - "branch": "mozilla-central", 08:18:29 INFO - "script_repo_revision": "production", 08:18:29 INFO - "revision": "00c595de162736689a83e894a84f9eb99a5fa6ac", 08:18:29 INFO - "slavename": "talos-linux64-ix-046", 08:18:29 INFO - "repo_path": "mozilla-central" 08:18:29 INFO - } 08:18:29 INFO - Finding installer, test and symbols from parent task. 08:18:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z_KiDGdCSwqLxHoWD-T1_A'}, attempt #1 08:18:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z_KiDGdCSwqLxHoWD-T1_A'}, attempt #1 08:18:30 INFO - Task dependencies: NCVlMVCEQb6oMUK_FqfiRg 08:18:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg'}, attempt #1 08:18:30 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.tar.bz2 08:18:30 INFO - Set test_url: https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/test_packages.json 08:18:30 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.crashreporter-symbols.zip 08:18:30 INFO - Running post-action listener: _resource_record_post_action 08:18:30 INFO - [mozharness: 2017-03-22 15:18:30.908882Z] Finished read-buildbot-config step (success) 08:18:30 INFO - [mozharness: 2017-03-22 15:18:30.909097Z] Running download-and-extract step. 08:18:30 INFO - Running pre-action listener: _resource_record_pre_action 08:18:30 INFO - Running main action method: download_and_extract 08:18:30 INFO - mkdir: /builds/slave/test/build/tests 08:18:30 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')]} 08:18:30 INFO - trying https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.test_packages.json 08:18:30 INFO - Downloading https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:18:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:18:31 INFO - Downloaded 986 bytes. 08:18:31 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:18:31 INFO - Using the following test package requirements: 08:18:31 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:18:31 INFO - u'common': [u'target.common.tests.zip'], 08:18:31 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:18:31 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:18:31 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:18:31 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:18:31 INFO - u'mozbase': [u'target.common.tests.zip'], 08:18:31 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:18:31 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:18:31 INFO - u'web-platform': [u'target.common.tests.zip', 08:18:31 INFO - u'target.web-platform.tests.zip'], 08:18:31 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:18:31 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:18:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.common.tests.zip 08:18:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:18:31 INFO - Fetch https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.common.tests.zip into memory 08:18:32 INFO - Expected file size: 58119319 08:18:32 INFO - Obtained file size: 58119319 08:18:42 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:18:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.common.tests.zip 08:18:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:18:42 INFO - Fetch https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.common.tests.zip into memory 08:18:43 INFO - Expected file size: 58119319 08:18:43 INFO - Obtained file size: 58119319 08:18:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.talos.tests.zip 08:18:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:18:54 INFO - Fetch https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.talos.tests.zip into memory 08:18:54 INFO - Expected file size: 14404171 08:18:54 INFO - Obtained file size: 14404171 08:18: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')]} 08:18:55 INFO - trying https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.tar.bz2 08:18:55 INFO - Downloading https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:18:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:18:57 INFO - Downloaded 61863816 bytes. 08:18:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.tar.bz2 08:18:57 INFO - mkdir: /builds/slave/test/properties 08:18:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:18:57 INFO - Writing to file /builds/slave/test/properties/build_url 08:18:57 INFO - Contents: 08:18:57 INFO - build_url:https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.tar.bz2 08:18:57 INFO - Running post-action listener: _resource_record_post_action 08:18:57 INFO - Running post-action listener: set_extra_try_arguments 08:18:57 INFO - [mozharness: 2017-03-22 15:18:57.260150Z] Finished download-and-extract step (success) 08:18:57 INFO - [mozharness: 2017-03-22 15:18:57.260247Z] Running populate-webroot step. 08:18:57 INFO - Running pre-action listener: _resource_record_pre_action 08:18:57 INFO - Running main action method: populate_webroot 08:18:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:18:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:18:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:18:57 INFO - '--tppagecycles', 08:18:57 INFO - '7'], 08:18:57 INFO - 'tests': ['tsvgm']}}, 08:18:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:18:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:18:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:18:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:18:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:18:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:18:57 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:18:57 INFO - 'talos_options': ['--disable-e10s'], 08:18:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:18:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:18:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:18:57 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:18:57 INFO - 'talos_options': ['--disable-e10s'], 08:18:57 INFO - 'tests': ['damp', 'tps']}, 08:18:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:18:57 INFO - 'tests': ['damp', 'tps']}, 08:18:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:18:57 INFO - 'tests': ['dromaeo_dom']}, 08:18:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:18:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:18:57 INFO - 'tests': ['basic_compositor_video']}, 08:18:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:18:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:18:57 INFO - 'tests': ['a11yr', 08:18:57 INFO - 'ts_paint', 08:18:57 INFO - 'tpaint', 08:18:57 INFO - 'sessionrestore', 08:18:57 INFO - 'sessionrestore_no_auto_restore', 08:18:57 INFO - 'tabpaint']}, 08:18:57 INFO - 'other-e10s': {'tests': ['a11yr', 08:18:57 INFO - 'ts_paint', 08:18:57 INFO - 'tpaint', 08:18:57 INFO - 'sessionrestore', 08:18:57 INFO - 'sessionrestore_no_auto_restore', 08:18:57 INFO - 'tabpaint']}, 08:18:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:18:57 INFO - 'ts_paint', 08:18:57 INFO - 'tpaint', 08:18:57 INFO - 'sessionrestore', 08:18:57 INFO - 'sessionrestore_no_auto_restore', 08:18:57 INFO - 'tabpaint']}, 08:18:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:18:57 INFO - 'ts_paint', 08:18:57 INFO - 'tpaint', 08:18:57 INFO - 'sessionrestore', 08:18:57 INFO - 'sessionrestore_no_auto_restore', 08:18:57 INFO - 'tabpaint']}, 08:18:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:18:57 INFO - 'tests': ['a11yr', 08:18:57 INFO - 'ts_paint', 08:18:57 INFO - 'tpaint', 08:18:57 INFO - 'sessionrestore', 08:18:57 INFO - 'sessionrestore_no_auto_restore', 08:18:57 INFO - 'tabpaint']}, 08:18:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:18:57 INFO - 'tests': ['a11yr', 08:18:57 INFO - 'ts_paint', 08:18:57 INFO - 'tpaint', 08:18:57 INFO - 'sessionrestore', 08:18:57 INFO - 'sessionrestore_no_auto_restore', 08:18:57 INFO - 'tabpaint']}, 08:18:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:18:57 INFO - 'tests': ['tsvgx', 08:18:57 INFO - 'tsvgr_opacity', 08:18:57 INFO - 'tart', 08:18:57 INFO - 'tscrollx', 08:18:57 INFO - 'cart', 08:18:57 INFO - 'tsvg_static']}, 08:18:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:18:57 INFO - 'tsvgr_opacity', 08:18:57 INFO - 'tart', 08:18:57 INFO - 'tscrollx', 08:18:57 INFO - 'cart', 08:18:57 INFO - 'tsvg_static']}, 08:18:57 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:18:57 INFO - 'talos_options': ['--disable-e10s'], 08:18:57 INFO - 'tests': ['tp5o']}, 08:18:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:18:57 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:18:57 INFO - 'talos_options': ['--disable-e10s', 08:18:57 INFO - '--xperf_path', 08:18:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:18:57 INFO - 'tests': ['tp5n']}, 08:18:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:18:57 INFO - 'talos_options': ['--xperf_path', 08:18:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:18:57 INFO - 'tests': ['tp5n']}}, 08:18:57 INFO - 'talos.zip': {'path': '', 08:18:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:18:57 INFO - Running post-action listener: _resource_record_post_action 08:18:57 INFO - [mozharness: 2017-03-22 15:18:57.273458Z] Finished populate-webroot step (success) 08:18:57 INFO - [mozharness: 2017-03-22 15:18:57.273547Z] Running create-virtualenv step. 08:18:57 INFO - Running pre-action listener: _resource_record_pre_action 08:18:57 INFO - Running main action method: create_virtualenv 08:18:57 INFO - Creating virtualenv /builds/slave/test/build/venv 08:18:57 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 08:18:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:18:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:18:57 INFO - Using real prefix '/usr' 08:18:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:18:57 INFO - Installing distribute.............................................................................................................................................................................................done. 08:18:59 INFO - Installing pip.................done. 08:18:59 INFO - Return code: 0 08:18:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:18:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:19:00 INFO - Reading from file tmpfile_stdout 08:19:00 INFO - Output received: 08:19:00 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) 08:19:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x1f2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2027a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ccb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ca290>, '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 0x21cab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cb040>, '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': '652eb03db935cfc1c15ebda0000001ad-1490195320.931823-1506931366', '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 08:19:00 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 08:19:00 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 08:19:00 INFO - Using env: {'DISPLAY': ':0', 08:19:00 INFO - 'HOME': '/home/cltbld', 08:19:00 INFO - 'LANG': 'en_US.UTF-8', 08:19:00 INFO - 'LANGUAGE': 'en_US:en', 08:19:00 INFO - 'LOGNAME': 'cltbld', 08:19:00 INFO - 'MAIL': '/var/mail/cltbld', 08:19:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:00 INFO - 'MOZ_NO_REMOTE': '1', 08:19:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:00 INFO - 'NO_EM_RESTART': '1', 08:19:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:00 INFO - 'PWD': '/builds/slave/test', 08:19:00 INFO - 'SHELL': '/bin/bash', 08:19:00 INFO - 'SHLVL': '1', 08:19:00 INFO - 'TERM': 'linux', 08:19:00 INFO - 'TMOUT': '86400', 08:19:00 INFO - 'USER': 'cltbld', 08:19:00 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1490195320.931823-1506931366', 08:19:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:00 INFO - '_': '/tools/buildbot/bin/python'} 08:19:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:00 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 08:19:00 INFO - Cleaning up... 08:19:00 INFO - Return code: 0 08:19:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x1f2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2027a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ccb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ca290>, '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 0x21cab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cb040>, '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': '652eb03db935cfc1c15ebda0000001ad-1490195320.931823-1506931366', '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 08:19:00 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 08:19:00 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 08:19:00 INFO - Using env: {'DISPLAY': ':0', 08:19:00 INFO - 'HOME': '/home/cltbld', 08:19:00 INFO - 'LANG': 'en_US.UTF-8', 08:19:00 INFO - 'LANGUAGE': 'en_US:en', 08:19:00 INFO - 'LOGNAME': 'cltbld', 08:19:00 INFO - 'MAIL': '/var/mail/cltbld', 08:19:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:00 INFO - 'MOZ_NO_REMOTE': '1', 08:19:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:00 INFO - 'NO_EM_RESTART': '1', 08:19:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:00 INFO - 'PWD': '/builds/slave/test', 08:19:00 INFO - 'SHELL': '/bin/bash', 08:19:00 INFO - 'SHLVL': '1', 08:19:00 INFO - 'TERM': 'linux', 08:19:00 INFO - 'TMOUT': '86400', 08:19:00 INFO - 'USER': 'cltbld', 08:19:00 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1490195320.931823-1506931366', 08:19:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:00 INFO - '_': '/tools/buildbot/bin/python'} 08:19:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:00 INFO - Downloading/unpacking psutil>=3.1.1 08:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:00 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 08:19:00 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 08:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:19:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:19:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:19:02 INFO - Installing collected packages: psutil 08:19:02 INFO - Running setup.py install for psutil 08:19:02 INFO - building 'psutil._psutil_linux' extension 08:19:02 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 08:19:02 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 08:19:02 INFO - building 'psutil._psutil_posix' extension 08:19:02 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 08:19:03 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 08:19:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:19:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:19:03 INFO - Successfully installed psutil 08:19:03 INFO - Cleaning up... 08:19:03 INFO - Return code: 0 08:19:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:19:03 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')]} 08:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:03 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')]} 08:19:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x1f2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2027a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ccb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ca290>, '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 0x21cab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cb040>, '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': '652eb03db935cfc1c15ebda0000001ad-1490195320.931823-1506931366', '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 08:19:03 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 08:19:03 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 08:19:03 INFO - Using env: {'DISPLAY': ':0', 08:19:03 INFO - 'HOME': '/home/cltbld', 08:19:03 INFO - 'LANG': 'en_US.UTF-8', 08:19:03 INFO - 'LANGUAGE': 'en_US:en', 08:19:03 INFO - 'LOGNAME': 'cltbld', 08:19:03 INFO - 'MAIL': '/var/mail/cltbld', 08:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:03 INFO - 'MOZ_NO_REMOTE': '1', 08:19:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:03 INFO - 'NO_EM_RESTART': '1', 08:19:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:03 INFO - 'PWD': '/builds/slave/test', 08:19:03 INFO - 'SHELL': '/bin/bash', 08:19:03 INFO - 'SHLVL': '1', 08:19:03 INFO - 'TERM': 'linux', 08:19:03 INFO - 'TMOUT': '86400', 08:19:03 INFO - 'USER': 'cltbld', 08:19:03 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1490195320.931823-1506931366', 08:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:03 INFO - '_': '/tools/buildbot/bin/python'} 08:19:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:03 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 08:19:03 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 08:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:19:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:19:05 INFO - Installing collected packages: mozsystemmonitor 08:19:05 INFO - Running setup.py install for mozsystemmonitor 08:19:05 INFO - Successfully installed mozsystemmonitor 08:19:05 INFO - Cleaning up... 08:19:05 INFO - Return code: 0 08:19:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:19:05 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')]} 08:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:05 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')]} 08:19:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:05 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 0x1f2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2027a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ccb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ca290>, '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 0x21cab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cb040>, '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': '652eb03db935cfc1c15ebda0000001ad-1490195320.931823-1506931366', '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 08:19:05 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 08:19:05 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 08:19:05 INFO - Using env: {'DISPLAY': ':0', 08:19:05 INFO - 'HOME': '/home/cltbld', 08:19:05 INFO - 'LANG': 'en_US.UTF-8', 08:19:05 INFO - 'LANGUAGE': 'en_US:en', 08:19:05 INFO - 'LOGNAME': 'cltbld', 08:19:05 INFO - 'MAIL': '/var/mail/cltbld', 08:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:05 INFO - 'MOZ_NO_REMOTE': '1', 08:19:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:05 INFO - 'NO_EM_RESTART': '1', 08:19:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:05 INFO - 'PWD': '/builds/slave/test', 08:19:05 INFO - 'SHELL': '/bin/bash', 08:19:05 INFO - 'SHLVL': '1', 08:19:05 INFO - 'TERM': 'linux', 08:19:05 INFO - 'TMOUT': '86400', 08:19:05 INFO - 'USER': 'cltbld', 08:19:05 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1490195320.931823-1506931366', 08:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:05 INFO - '_': '/tools/buildbot/bin/python'} 08:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:05 INFO - Downloading/unpacking jsonschema==2.5.1 08:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:05 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 08:19:05 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 08:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:19:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:08 INFO - Downloading functools32-3.2.3-2.tar.gz 08:19:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:19:08 INFO - warning: no files found matching '*.txt' 08:19:08 INFO - no previously-included directories found matching 'build' 08:19:08 INFO - no previously-included directories found matching 'dist' 08:19:08 INFO - no previously-included directories found matching '.git*' 08:19:08 INFO - Installing collected packages: jsonschema, functools32 08:19:08 INFO - Running setup.py install for functools32 08:19:08 INFO - warning: no files found matching '*.txt' 08:19:08 INFO - no previously-included directories found matching 'build' 08:19:08 INFO - no previously-included directories found matching 'dist' 08:19:08 INFO - no previously-included directories found matching '.git*' 08:19:08 INFO - Successfully installed jsonschema functools32 08:19:08 INFO - Cleaning up... 08:19:08 INFO - Return code: 0 08:19:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:19:08 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')]} 08:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:08 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')]} 08:19:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x1f2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2027a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ccb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ca290>, '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 0x21cab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cb040>, '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': '652eb03db935cfc1c15ebda0000001ad-1490195320.931823-1506931366', '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 08:19:08 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 08:19:08 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 08:19:08 INFO - Using env: {'DISPLAY': ':0', 08:19:08 INFO - 'HOME': '/home/cltbld', 08:19:08 INFO - 'LANG': 'en_US.UTF-8', 08:19:08 INFO - 'LANGUAGE': 'en_US:en', 08:19:08 INFO - 'LOGNAME': 'cltbld', 08:19:08 INFO - 'MAIL': '/var/mail/cltbld', 08:19:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:08 INFO - 'MOZ_NO_REMOTE': '1', 08:19:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:08 INFO - 'NO_EM_RESTART': '1', 08:19:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:08 INFO - 'PWD': '/builds/slave/test', 08:19:08 INFO - 'SHELL': '/bin/bash', 08:19:08 INFO - 'SHLVL': '1', 08:19:08 INFO - 'TERM': 'linux', 08:19:08 INFO - 'TMOUT': '86400', 08:19:08 INFO - 'USER': 'cltbld', 08:19:08 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1490195320.931823-1506931366', 08:19:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:08 INFO - '_': '/tools/buildbot/bin/python'} 08:19:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:19:08 INFO - Cleaning up... 08:19:08 INFO - Return code: 0 08:19:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:19:08 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')]} 08:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:08 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')]} 08:19:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x1f2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2027a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ccb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ca290>, '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 0x21cab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cb040>, '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': '652eb03db935cfc1c15ebda0000001ad-1490195320.931823-1506931366', '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 08:19:08 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 08:19:08 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 08:19:08 INFO - Using env: {'DISPLAY': ':0', 08:19:08 INFO - 'HOME': '/home/cltbld', 08:19:08 INFO - 'LANG': 'en_US.UTF-8', 08:19:08 INFO - 'LANGUAGE': 'en_US:en', 08:19:08 INFO - 'LOGNAME': 'cltbld', 08:19:08 INFO - 'MAIL': '/var/mail/cltbld', 08:19:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:08 INFO - 'MOZ_NO_REMOTE': '1', 08:19:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:08 INFO - 'NO_EM_RESTART': '1', 08:19:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:08 INFO - 'PWD': '/builds/slave/test', 08:19:08 INFO - 'SHELL': '/bin/bash', 08:19:08 INFO - 'SHLVL': '1', 08:19:08 INFO - 'TERM': 'linux', 08:19:08 INFO - 'TMOUT': '86400', 08:19:08 INFO - 'USER': 'cltbld', 08:19:08 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1490195320.931823-1506931366', 08:19:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:08 INFO - '_': '/tools/buildbot/bin/python'} 08:19:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:08 INFO - Downloading/unpacking blobuploader==1.2.4 08:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:08 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 08:19:08 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 08:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:10 INFO - Downloading blobuploader-1.2.4.tar.gz 08:19:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:19:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:10 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 08:19:10 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 08:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:19:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:11 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 08:19:11 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 08:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:11 INFO - Downloading docopt-0.6.1.tar.gz 08:19:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:19:11 INFO - Installing collected packages: blobuploader, requests, docopt 08:19:11 INFO - Running setup.py install for blobuploader 08:19:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:19:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:19:11 INFO - Running setup.py install for requests 08:19:12 INFO - Running setup.py install for docopt 08:19:12 INFO - Successfully installed blobuploader requests docopt 08:19:12 INFO - Cleaning up... 08:19:12 INFO - Return code: 0 08:19:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:19:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x1f2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2027a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ccb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ca290>, '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 0x21cab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cb040>, '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': '652eb03db935cfc1c15ebda0000001ad-1490195320.931823-1506931366', '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 08:19:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 08:19:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.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 08:19:12 INFO - Using env: {'DISPLAY': ':0', 08:19:12 INFO - 'HOME': '/home/cltbld', 08:19:12 INFO - 'LANG': 'en_US.UTF-8', 08:19:12 INFO - 'LANGUAGE': 'en_US:en', 08:19:12 INFO - 'LOGNAME': 'cltbld', 08:19:12 INFO - 'MAIL': '/var/mail/cltbld', 08:19:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:12 INFO - 'MOZ_NO_REMOTE': '1', 08:19:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:12 INFO - 'NO_EM_RESTART': '1', 08:19:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:12 INFO - 'PWD': '/builds/slave/test', 08:19:12 INFO - 'SHELL': '/bin/bash', 08:19:12 INFO - 'SHLVL': '1', 08:19:12 INFO - 'TERM': 'linux', 08:19:12 INFO - 'TMOUT': '86400', 08:19:12 INFO - 'USER': 'cltbld', 08:19:12 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1490195320.931823-1506931366', 08:19:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:12 INFO - '_': '/tools/buildbot/bin/python'} 08:19:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:19:12 INFO - Running setup.py (path:/tmp/pip-KJcPFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:19:12 INFO - Running setup.py (path:/tmp/pip-ygMJh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:19:12 INFO - Running setup.py (path:/tmp/pip-wE7QKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:19:12 INFO - Running setup.py (path:/tmp/pip-AgMXbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:19:12 INFO - Running setup.py (path:/tmp/pip-pHMZ99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:19:12 INFO - Running setup.py (path:/tmp/pip-mSdfLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:19:12 INFO - Running setup.py (path:/tmp/pip-5I0jj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:19:12 INFO - Running setup.py (path:/tmp/pip-7kPV16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:19:13 INFO - Running setup.py (path:/tmp/pip-ZuW4ob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:19:13 INFO - Running setup.py (path:/tmp/pip-EiUfDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:19:13 INFO - Running setup.py (path:/tmp/pip-9f0zDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:19:13 INFO - Running setup.py (path:/tmp/pip-U5lu7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:19:13 INFO - Running setup.py (path:/tmp/pip-v8MqSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:19:13 INFO - Running setup.py (path:/tmp/pip-Qp_iKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:13 INFO - Running setup.py (path:/tmp/pip-x_wzaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:19:13 INFO - Running setup.py (path:/tmp/pip-xSLO4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:19:13 INFO - Running setup.py (path:/tmp/pip-p4NpCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:19:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:19:13 INFO - Running setup.py install for manifestparser 08:19:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:19:13 INFO - Running setup.py install for mozcrash 08:19:13 INFO - Running setup.py install for mozdebug 08:19:13 INFO - Running setup.py install for mozdevice 08:19:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:19:14 INFO - Running setup.py install for mozfile 08:19:14 INFO - Running setup.py install for mozhttpd 08:19:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:19:14 INFO - Running setup.py install for mozinfo 08:19:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:19:14 INFO - Running setup.py install for mozInstall 08:19:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:19:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:19:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:19:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:19:14 INFO - Running setup.py install for mozleak 08:19:14 INFO - Running setup.py install for mozlog 08:19:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:19:14 INFO - Running setup.py install for moznetwork 08:19:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:19:14 INFO - Running setup.py install for mozprocess 08:19:14 INFO - Running setup.py install for mozprofile 08:19:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:19:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:19:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:19:15 INFO - Running setup.py install for mozrunner 08:19:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:19:15 INFO - Running setup.py install for mozscreenshot 08:19:15 INFO - Running setup.py install for moztest 08:19:15 INFO - Running setup.py install for mozversion 08:19:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:19:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:19:15 INFO - Cleaning up... 08:19:15 INFO - Return code: 0 08:19:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:19:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:15 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 0x1f2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2027a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ccb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ca290>, '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 0x21cab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cb040>, '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': '652eb03db935cfc1c15ebda0000001ad-1490195320.931823-1506931366', '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 08:19:15 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 08:19:15 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 08:19:15 INFO - Using env: {'DISPLAY': ':0', 08:19:15 INFO - 'HOME': '/home/cltbld', 08:19:15 INFO - 'LANG': 'en_US.UTF-8', 08:19:15 INFO - 'LANGUAGE': 'en_US:en', 08:19:15 INFO - 'LOGNAME': 'cltbld', 08:19:15 INFO - 'MAIL': '/var/mail/cltbld', 08:19:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:15 INFO - 'MOZ_NO_REMOTE': '1', 08:19:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:15 INFO - 'NO_EM_RESTART': '1', 08:19:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:15 INFO - 'PWD': '/builds/slave/test', 08:19:15 INFO - 'SHELL': '/bin/bash', 08:19:15 INFO - 'SHLVL': '1', 08:19:15 INFO - 'TERM': 'linux', 08:19:15 INFO - 'TMOUT': '86400', 08:19:15 INFO - 'USER': 'cltbld', 08:19:15 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1490195320.931823-1506931366', 08:19:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:15 INFO - '_': '/tools/buildbot/bin/python'} 08:19:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:19:15 INFO - Running setup.py (path:/tmp/pip-cD8THW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:19:15 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)) 08:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:19:15 INFO - Running setup.py (path:/tmp/pip-zWcabT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:19:15 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)) 08:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:19:15 INFO - Running setup.py (path:/tmp/pip-cf8aCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:19:15 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)) 08:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:19:15 INFO - Running setup.py (path:/tmp/pip-2Qas_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:19:15 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)) 08:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:19:15 INFO - Running setup.py (path:/tmp/pip-HipsW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:19:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:19:16 INFO - Running setup.py (path:/tmp/pip-onti5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:19:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:19:16 INFO - Running setup.py (path:/tmp/pip-VMdMK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:19:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:19:16 INFO - Running setup.py (path:/tmp/pip-2BP0bF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:19:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:19:16 INFO - Running setup.py (path:/tmp/pip-3OwC_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:19:16 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)) 08:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:19:16 INFO - Running setup.py (path:/tmp/pip-QwoHkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:19:16 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)) 08:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:19:16 INFO - Running setup.py (path:/tmp/pip-aJKh82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:19:16 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)) 08:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:19:16 INFO - Running setup.py (path:/tmp/pip-GgDGGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:19:16 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)) 08:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:19:16 INFO - Running setup.py (path:/tmp/pip-Cqel2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:19:16 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)) 08:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:19:16 INFO - Running setup.py (path:/tmp/pip-HExPwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:19:16 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)) 08:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:16 INFO - Running setup.py (path:/tmp/pip-rLGHba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:16 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)) 08:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:19:16 INFO - Running setup.py (path:/tmp/pip-t9F80B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:19:16 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)) 08:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:19:16 INFO - Running setup.py (path:/tmp/pip-ZrTcki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:19:16 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)) 08:19:16 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)) 08:19:16 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)) 08:19:16 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)) 08:19:16 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)) 08:19:16 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)) 08:19:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:16 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 08:19:16 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 08:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:18 INFO - Downloading blessings-1.6.tar.gz 08:19:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:19:19 INFO - Installing collected packages: blessings 08:19:19 INFO - Running setup.py install for blessings 08:19:19 INFO - Successfully installed blessings 08:19:19 INFO - Cleaning up... 08:19:19 INFO - Return code: 0 08:19:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:19:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:19:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:19:19 INFO - Reading from file tmpfile_stdout 08:19:19 INFO - Current package versions: 08:19:19 INFO - argparse == 1.2.1 08:19:19 INFO - blessings == 1.6 08:19:19 INFO - blobuploader == 1.2.4 08:19:19 INFO - docopt == 0.6.1 08:19:19 INFO - functools32 == 3.2.3-2 08:19:19 INFO - jsonschema == 2.5.1 08:19:19 INFO - manifestparser == 1.1 08:19:19 INFO - mozInstall == 1.12 08:19:19 INFO - mozcrash == 1.0 08:19:19 INFO - mozdebug == 0.1 08:19:19 INFO - mozdevice == 0.49 08:19:19 INFO - mozfile == 1.2 08:19:19 INFO - mozhttpd == 0.7 08:19:19 INFO - mozinfo == 0.9 08:19:19 INFO - mozleak == 0.1 08:19:19 INFO - mozlog == 3.4 08:19:19 INFO - moznetwork == 0.27 08:19:19 INFO - mozprocess == 0.25 08:19:19 INFO - mozprofile == 0.28 08:19:19 INFO - mozrunner == 6.13 08:19:19 INFO - mozscreenshot == 0.1 08:19:19 INFO - mozsystemmonitor == 0.3 08:19:19 INFO - moztest == 0.8 08:19:19 INFO - mozversion == 1.4 08:19:19 INFO - psutil == 3.1.1 08:19:19 INFO - requests == 1.2.3 08:19:19 INFO - wsgiref == 0.1.2 08:19:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:19:19 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')]} 08:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:19 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')]} 08:19:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x1f2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2027a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ccb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ca290>, '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 0x21cab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cb040>, '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': '652eb03db935cfc1c15ebda0000001ad-1490195320.931823-1506931366', '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 08:19:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 08:19:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.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 08:19:19 INFO - Using env: {'DISPLAY': ':0', 08:19:19 INFO - 'HOME': '/home/cltbld', 08:19:19 INFO - 'LANG': 'en_US.UTF-8', 08:19:19 INFO - 'LANGUAGE': 'en_US:en', 08:19:19 INFO - 'LOGNAME': 'cltbld', 08:19:19 INFO - 'MAIL': '/var/mail/cltbld', 08:19:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:19 INFO - 'MOZ_NO_REMOTE': '1', 08:19:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:19 INFO - 'NO_EM_RESTART': '1', 08:19:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:19 INFO - 'PWD': '/builds/slave/test', 08:19:19 INFO - 'SHELL': '/bin/bash', 08:19:19 INFO - 'SHLVL': '1', 08:19:19 INFO - 'TERM': 'linux', 08:19:19 INFO - 'TMOUT': '86400', 08:19:19 INFO - 'USER': 'cltbld', 08:19:19 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1490195320.931823-1506931366', 08:19:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:19 INFO - '_': '/tools/buildbot/bin/python'} 08:19:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:19:19 INFO - Cleaning up... 08:19:19 INFO - Return code: 0 08:19:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:19:19 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')]} 08:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:19 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')]} 08:19:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x1f2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2027a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ccb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ca290>, '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 0x21cab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cb040>, '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': '652eb03db935cfc1c15ebda0000001ad-1490195320.931823-1506931366', '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 08:19:19 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 08:19:19 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 08:19:19 INFO - Using env: {'DISPLAY': ':0', 08:19:19 INFO - 'HOME': '/home/cltbld', 08:19:19 INFO - 'LANG': 'en_US.UTF-8', 08:19:19 INFO - 'LANGUAGE': 'en_US:en', 08:19:19 INFO - 'LOGNAME': 'cltbld', 08:19:19 INFO - 'MAIL': '/var/mail/cltbld', 08:19:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:19 INFO - 'MOZ_NO_REMOTE': '1', 08:19:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:19 INFO - 'NO_EM_RESTART': '1', 08:19:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:19 INFO - 'PWD': '/builds/slave/test', 08:19:19 INFO - 'SHELL': '/bin/bash', 08:19:19 INFO - 'SHLVL': '1', 08:19:19 INFO - 'TERM': 'linux', 08:19:19 INFO - 'TMOUT': '86400', 08:19:19 INFO - 'USER': 'cltbld', 08:19:19 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1490195320.931823-1506931366', 08:19:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:19 INFO - '_': '/tools/buildbot/bin/python'} 08:19:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:19:19 INFO - Cleaning up... 08:19:19 INFO - Return code: 0 08:19:19 INFO - Running post-action listener: _resource_record_post_action 08:19:19 INFO - Running post-action listener: _start_resource_monitoring 08:19:19 INFO - Starting resource monitoring. 08:19:19 INFO - [mozharness: 2017-03-22 15:19:19.924247Z] Finished create-virtualenv step (success) 08:19:19 INFO - [mozharness: 2017-03-22 15:19:19.924767Z] Running install step. 08:19:19 INFO - Running pre-action listener: _resource_record_pre_action 08:19:19 INFO - Running main action method: install 08:19:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:19:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:19:20 INFO - Reading from file tmpfile_stdout 08:19:20 INFO - Detecting whether we're running mozinstall >=1.0... 08:19:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:19:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:19:20 INFO - Reading from file tmpfile_stdout 08:19:20 INFO - Output received: 08:19:20 INFO - Usage: mozinstall [options] installer 08:19:20 INFO - Options: 08:19:20 INFO - -h, --help show this help message and exit 08:19:20 INFO - -d DEST, --destination=DEST 08:19:20 INFO - Directory to install application into. [default: 08:19:20 INFO - "/builds/slave/test"] 08:19:20 INFO - --app=APP Application being installed. [default: firefox] 08:19:20 INFO - mkdir: /builds/slave/test/build/application 08:19:20 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'] 08:19:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:19:35 INFO - Reading from file tmpfile_stdout 08:19:35 INFO - Output received: 08:19:35 INFO - /builds/slave/test/build/application/firefox/firefox 08:19:35 INFO - Running post-action listener: _resource_record_post_action 08:19:35 INFO - [mozharness: 2017-03-22 15:19:35.788420Z] Finished install step (success) 08:19:35 INFO - [mozharness: 2017-03-22 15:19:35.788687Z] Running run-tests step. 08:19:35 INFO - Running pre-action listener: _resource_record_pre_action 08:19:35 INFO - Running main action method: run_tests 08:19:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:19:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:19:35 INFO - Python 2.7.3 08:19:35 INFO - Return code: 0 08:19:35 INFO - grabbing minidump binary from tooltool 08:19:35 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')]} 08:19:35 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 0x21ca290>, '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 0x21cab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21cb040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:19:35 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 08:19:35 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 08:19:35 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 08:19:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:19:35 INFO - Return code: 0 08:19:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:19:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:19:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:19:35 INFO - ENV: RUST_BACKTRACE is now 1 08:19:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:19:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:19:35 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/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 08:19:35 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/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 08:19:35 INFO - Using env: {'DISPLAY': ':0', 08:19:35 INFO - 'HOME': '/home/cltbld', 08:19:35 INFO - 'LANG': 'en_US.UTF-8', 08:19:35 INFO - 'LANGUAGE': 'en_US:en', 08:19:35 INFO - 'LOGNAME': 'cltbld', 08:19:35 INFO - 'MAIL': '/var/mail/cltbld', 08:19:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:19:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:19:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:35 INFO - 'MOZ_NO_REMOTE': '1', 08:19:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:19:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:35 INFO - 'NO_EM_RESTART': '1', 08:19:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:35 INFO - 'PWD': '/builds/slave/test', 08:19:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:19:35 INFO - 'RUST_BACKTRACE': '1', 08:19:35 INFO - 'SHELL': '/bin/bash', 08:19:35 INFO - 'SHLVL': '1', 08:19:35 INFO - 'TERM': 'linux', 08:19:35 INFO - 'TMOUT': '86400', 08:19:35 INFO - 'USER': 'cltbld', 08:19:35 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1490195320.931823-1506931366', 08:19:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:35 INFO - '_': '/tools/buildbot/bin/python'} 08:19:35 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/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 08:19:36 INFO - mozversion application_buildid: 20170322145025 08:19:36 INFO - mozversion application_changeset: 00c595de162736689a83e894a84f9eb99a5fa6ac 08:19:36 INFO - mozversion application_display_name: Nightly 08:19:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:19:36 INFO - mozversion application_name: Firefox 08:19:36 INFO - mozversion application_remotingname: firefox 08:19:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:19:36 INFO - mozversion application_vendor: Mozilla 08:19:36 INFO - mozversion application_version: 55.0a1 08:19:36 INFO - mozversion platform_buildid: 20170322145025 08:19:36 INFO - mozversion platform_changeset: 00c595de162736689a83e894a84f9eb99a5fa6ac 08:19:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:19:36 INFO - mozversion platform_version: 55.0a1 08:19:36 INFO - using testdate: 1490195976 08:19:36 INFO - actual date: 1490195976 08:19:36 INFO - starting webserver on 'localhost:53619' 08:19:36 INFO - SUITE-START | Running 2 tests 08:19:36 INFO - TEST-START | dromaeo_css 08:19:36 INFO - operating with platform_type : linux_ 08:19:36 INFO - Initialising browser for dromaeo_css test... 08:19:36 INFO - TEST-INFO | started process 1621 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz4eC2s/profile http://localhost:53619/getInfo.html) 08:19:40 INFO - PID 1621 | __metrics Screen width/height:1600/1200 08:19:40 INFO - PID 1621 | colorDepth:24 08:19:40 INFO - PID 1621 | Browser inner width/height: 1024/697 08:19:40 INFO - PID 1621 | __metrics 08:19:41 ERROR - PID 1621 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 08:19:42 INFO - TEST-INFO | 1621: exit 0 08:19:42 INFO - Browser initialized. 08:19:42 INFO - Running cycle 1/1 for dromaeo_css test... 08:19:42 INFO - TEST-INFO | started process 1754 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz4eC2s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:19:55 INFO - PID 1754 | RSS: Main: 155332608 08:19:55 INFO - PID 1754 | 08:22:58 INFO - PID 1754 | Cycle 1(1): loaded http://localhost:53619/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53619/tests/dromaeo/cssquery-ext.html) 08:23:01 INFO - PID 1754 | RSS: Main: 165605376 08:23:01 INFO - PID 1754 | 08:24:43 INFO - PID 1754 | ************************* 08:24:43 INFO - PID 1754 | A coding exception was thrown and uncaught in a Task. 08:24:43 INFO - PID 1754 | 08:24:43 ERROR - PID 1754 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:24:43 INFO - PID 1754 | Full stack: 08:24:43 INFO - PID 1754 | ************************* 08:26:04 INFO - PID 1754 | Cycle 1(1): loaded http://localhost:53619/tests/dromaeo/cssquery-ext.html (next: http://localhost:53619/tests/dromaeo/cssquery-jquery.html) 08:26:04 INFO - PID 1754 | RSS: Main: 160661504 08:26:04 INFO - PID 1754 | 08:29:06 INFO - PID 1754 | Cycle 1(1): loaded http://localhost:53619/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53619/tests/dromaeo/cssquery-mootools.html) 08:29:07 INFO - PID 1754 | RSS: Main: 168402944 08:29:07 INFO - PID 1754 | 08:32:09 INFO - PID 1754 | Cycle 1(1): loaded http://localhost:53619/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53619/tests/dromaeo/cssquery-prototype.html) 08:32:09 INFO - PID 1754 | RSS: Main: 161112064 08:32:09 INFO - PID 1754 | 08:35:12 INFO - PID 1754 | Cycle 1(1): loaded http://localhost:53619/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53619/tests/dromaeo/cssquery-yui.html) 08:35:13 INFO - PID 1754 | RSS: Main: 169414656 08:35:13 INFO - PID 1754 | 08:38:16 INFO - PID 1754 | Cycle 1(1): loaded http://localhost:53619/tests/dromaeo/cssquery-yui.html (next: http://localhost:53619/tests/dromaeo/cssquery-dojo.html) 08:38:16 INFO - PID 1754 | RSS: Main: 161656832 08:38:16 INFO - PID 1754 | 08:38:16 INFO - PID 1754 | __start_tp_report 08:38:16 INFO - PID 1754 | _x_x_mozilla_page_load 08:38:16 INFO - PID 1754 | _x_x_mozilla_page_load_details 08:38:16 INFO - PID 1754 | |i|pagename|runs| 08:38:16 INFO - PID 1754 | |0;dojo.html;2665.9866700666494;2678.1028355500907;2695.609136675182;2700.0144947094304;2707.634469346638;5141.0232055909355;5157.690538567688;5187.870303242416;5204.817831375903;5213.426523082458;5210.2445145453885;5255.632105752599;5260.210968354749;5316.946830531693;5334.146536554152;4764.714117152973;4809.278608208761;4822.831200907969;4838.588719958808;4843.321934929113;4838.322634831126;4842.951570484285;4843.273508973664;4851.927221091686;4879.170541008037;4688.648351373627;4702.835400760991;4723.834665786715;4737.668363214576;4741.454732705749;4747.7388743619085;4772.665913386064;4787.425508938914;4831.22700367943;4846.297286893416;4721.504242054569;4752.358431611758;4760.833370832039;4764.761761911891;4794.712317260975;5111.667741596784;5164.819231326923;5212.113940630102;5222.973885130588;5247.16045432729;5652.689102099383;5663.49028587425;5676.489115979541;5706.514946229576;5731.426857314277;5676.375598684142;5687.374388817227;5689.146628005791;5689.800856969986;5696.060150075233;5115.258287548285;5174.586033117342;5265.341832270966;5287.550558202519;5326.97336513315;5614.494695477427;5643.040683083886;5688.033034384164;5700.3444603871085;5710.543156547466;5423.83728488146;5471.644343117685;5534.86162845924;5552.167174923713;5588.441155884379;5567.66594004361;5644.294463192101;5646.604737668324;5650.378458369576;5668.51817595509;5491.450854914477;5544.750486228129;5597.44025597437;5598.076317407664;5599.664020158803;5557.5553955683445;5581.944180558143;5616.213730077792;5640.238567793295;5642.605017648807;4650.325702773147;4668.579827815445;4677.766111694402;4678.368420263221;4718.103560323596;4012.197560487914;4016.156607112539;4031.4355990161403;4033.1933613276874;4078.286299897506;4754.07295577366;4803.087413391444;4859.781309841065;4893.657443978887;4894.094592500399;5677.489025987598;5685.061964775766;5699.544036477072;5715.571332150105;5749.137629355547;4859.441164266084;4862.975685121552;4869.659123861366;4881.609471242292;4899.706017638953;4867.9269810952865;4890.315355850184;4907.87730306738;4913.852584422473;4969.478204788517;5197.870053248699;5231.372235331784;5233.790648374023;5234.424213336454;5235.110031294613;5599.664020158803;5621.690807005491;5624.831255062355;5628.746706398304;5652.123920792284;5211.140161873249;5213;5227.085260079547;5228.555572776357;5281.841544753664;5539.947409992089;5565.749541270734;5585.659441734036;5599.496045355938;5614.382417934105;5669.716514174357;5674.2623458950075;5681.375048744552;5685.886282274414;5691.7438715257085;5390.892182156414;5406.621536492407;5412.972935135299;5414.0525408052645;5459.918101228564;5440.129579267298;5453.972730136324;5457.645253058538;5461.617686762047;5463.972680136574;5244.187150991603;5296.099663057213;5346;5379.757910893941;5391.272178255886;5506.779728810803;5520.447955204448;5562.499375056264;5569.944300556943;5581.023320918742;5360.785568577213;5374.811881584125;5378.058839703114;5380.11228147367;5388.838334849961 08:38:16 INFO - PID 1754 | |1;ext.html;675.9019942108393;1080.2978064258232;1094.4527736131934;1200.4237965776433;1214.67811030077;32363.838180809093;33589.66410335899;33608.831955840185;33653.326933461314;33662.831685841535;31168.844155779247;31290.374192516138;31295.217619559524;31403.84298078512;31440;5697.487226149646;5840.912386314209;6676.632785196813;6826.795196144124;7204.675789589455;7351.595662238575;7461.813454663623;7464.589447580381;7476.14024387197;7481.8877716834295;7572.697092116308;7657.310842024217;7667.501612395205;7689.423293253;7692.730754423596;7521.774346769551;7610.238976102401;7611.314981651651;7627.466077374614;7636.732714354971;7401.851962960711;7509.511881727725;7523.742877136891;7533;7533.284337987882;33353.49969750456;33424.83287583571;33676.494852577234;33713;33723.15692107692;2256.4697296135396;2266.8639881607155;2289.0614847912275;2289.6222123349626;2290.667853161299;21028.684569731467;21044.894775526176;21107;21236.575268494697;21293.14827406902;2447.5349683560066;2459.6802415686025;2461.963070553943;2480.593823990726;2518.7229404765462;152313;154212;154896;154999;155090;32677.836610816794;33138.66861331404;37490.62509374926;37781.81109094437;43082.78458607687;39505.60494395077;43283.350749738776;43286;43368;43409.13181736348;12259.387030648431;12313;12434.689132771753;12443.066769992287;12456.501739930301;9606.039396060338;9629.855552166724;9635.759106022406;9665.516724163763;9725.319227654138;12373.577038640491;12388.212652153194;12429.37853107341;12439.813402798965;12569.622911312676;5058.266551350033;5100.285959965608;5147.485251474897;5151.5106064923775;5194.662346947436;855.1021427501099;869.2394155114275;884.8055125580415;891.790429249126;911.4394647292;20343.69484457734;21338.359849204237;21356.78643213548;21468.141274349164;21528;955.1642312976146;969.1810420194925;982.6708052802392;983.5524836199512;988.6094992477931;10978.945105274583;10998.560057597766;11167.106631469464;11255;11299.152563557602;210858;213082;213351;214419;214429;43053.56946430558;43193;43196.3520547192;43234.567654323684;43308;1195.4405106473457;1203.867574566797;1227.969300767488;1232.1128787273149;1234.6851552853964;19996;20134.59730805405;20796.1681532737;20921.581568368852;21010.26464073811;30777.846110769304;30826.383472330876;30878.845605772727;30903.38193236078;30921.381572367976;209402;210071;210197;210771;211202;22135;22136.778632214115;26045.088421905144;29622.555661665523;29863.85068074646;30106.69893301039;30465.695343046285;30524.84737576298;30813.691863081083;31053.534196987515;28011.859940700167;28051.43897122087;28219.858900705363;28440.57339139873;28841.42317153687;28224.29439264035;28283.717162828107;28506.42987140204;29352.706472935;29650.258743531584;27931;27953.021644242355;28084.71915280821;28641.856790715912;28957.276068098465;22426.215082472034;24972.625410618493;25100.874495627406;25401.618975715748;27258.863705681346;20966.16135354569;20971.8951405242;21042.15831366728;21071.57856842824;21184.364469065953 08:38:16 INFO - PID 1754 | |2;jquery.html;417.1739954889321;431.7011911570884;435.10151537075933;439.26861775144386;451.4717780197171;16815.327386904526;16949.406770763027;17679.29282828687;18653.53366165843;18829.90585047076;18269.817301826977;18439.262429502836;18508.2596696132;18547.721784173213;18675.906620466878;5488.1493368527945;5488.615796894219;5623.775048998055;5645.774169033234;5655.4910058094765;5668.348139963916;5811.215485909412;5845.357010728816;5847.298324201101;5847.41525847414;5491.972540137293;5498;5506.944930550703;5527.447255274481;5529.612927095105;5569.248151499536;5584.692841893714;5614;5636.915446268309;5673.092305231185;5081.542661160476;5166.767495462713;5173.3533308336455;5185.429602743695;5206.921896171561;18249.817501824946;18262.634747305114;18309.816901830945;22227.110915563357;22489.325320240256;1464.809574755275;1496.9550913472613;1505.4204131409376;1512.4177191781243;1546.9071855688694;13376.799348009788;13687.452501899912;13883.236421996786;14207.928960355131;14215.928920355436;1555.4089446010557;1573.9842601573953;1602.8877978541507;1608.388812251337;1608.4290077022606;84598;86506;87014.5649271756;88592.55703721504;89282;10723.30298530593;11042.392668403154;11198.832017519744;11278.774424511628;11523.423828808525;15777.68444631101;15826.366945322288;15852.920735396248;15918.602034948988;15937.840621593867;7345.595992220479;7350.63246837656;7488.625568721543;7555.433342499225;7638.69445222196;6602.7689030883685;6695.12963314766;6798.66006699663;6838.1794184697155;6870.587764734132;6860.451163906875;6934.375906168469;7016.158061032709;7040.225575186725;7152.141742990771;2107.2097963263777;2126.277065797636;2142.30375128084;2143.2927134045726;2280.680704701343;825.8430898129336;851.5188918261163;857.5112186054014;865.3336930563431;869.1569177897429;16080.919595402182;16232.513024609281;16945.32218711238;17220.741688874677;17279.74080388795;849.7748096754365;858.9398742087994;859.0936561927102;859.5702148925537;874.6588830356167;8620.13798620133;9213.81572368549;9272.165505104573;9337.393069450463;9405.43567385959;459224;466180;466841;470761;515288;90940;96136.11591652261;96190.51904740572;97039.51480242694;97935;1067.4876059491487;1098.2202636128438;1105.7180418993105;1113.704868209925;1113.7661091170783;16492.587685307964;16689.415870444474;17013.57466063358;17263;17778.11109444497;31359.21601959969;38295.23409531738;41135.58864411317;41722.791386042874;42005.78997104995;55477.44522554884;55505.1674224895;56147.71926140343;57197;58507.707461464124;8207.58962051907;8265.800649512865;8318.417710760188;8370.958145209479;8522.48865068098;12343.444544995677;12805.359732013176;12909;12929.54746583865;13079.346032698517;10607.31052481617;10617.416042117758;10737.677869663923;10993.395363255098;11261.324320540794;10449.634262800766;10703.678889633324;10756.354618722902;10847.837282440612;10852.294600851235;11172.385518796544;11207.551697931991;11290.661280161608;11347.773044538897;11701.414929253333;8155.306798922158;8222.301104405953;8361.372897032625;8371;8668;10371.755389353326;10423.374597524173;10608.363498190134;10747.838782418426;10819.621313253998 08:38:16 INFO - PID 1754 | |3;mootools.html;1253.1353366177339;1312.7308901675158;1324.3113580937918;1329.0829327763843;1334.6062911441124;9336.393134446256;9714.61991812006;9720.611175552978;9799.559019844106;9935.155511781508;9817.165540929012;9952.751181220474;9960.701178964642;9975;9984.351017183879;2148.054855863419;2184.726909136358;2189.3431970408815;2194.9890250548724;2196.3191410662666;2116.5661039486868;2140.4327853118934;2153.967690484644;2155.385715071205;2160.2331172433796;2079.5009197792574;2102.1066046929996;2125.5855108253895;2129.0951345678104;2133.5946170227608;2087.561612061469;2101.63221436248;2101.674240492726;2106.1575369852103;2109.1879626343966;1813.936512222079;1861.91621377037;2017.5412338731421;2045.5704302096578;2072.6890966355018;9617.90382096177;9887.209023278192;9888.406695598287;9958.502074896227;9960.402375857399;5274.4198138204765;5419.160030195326;5461.0716178249795;5467.699276539789;5535;3123.1723593247807;3141.7165668662674;3174.0953828158863;3179.5230715392645;3261.7553683473598;953.2802733935904;954.2230818826619;961.6489981156898;964.3394274921701;996.0985308296003;14688.706225875423;14699.338529766079;14713.485028024075;14808.185549794756;14812.555623331318;4497.730136191839;4654.604358629555;4768.666193366431;4778.092162489116;4801.51984801517;10875.564977400816;10928.945355273172;10938.179636527293;10946;10946.945265273622;5516.282883225235;5516.696581688046;5522.088855338904;5533.7786488540005;5535.197396377503;4790.257510085942;4816.373871396696;4932.235503496964;4971.701697898137;4995.550400463976;3870.1098747288283;3929.214157168578;3953.446517487554;4017.2367250222364;4027.0939038716056;1181.373871847922;1182.1016027818919;1183.219075410225;1199.8440202773584;1206.7586482703493;626.5488848029412;653.5686446944993;654.3783405764543;661.9441990025902;664;5103.336566246364;5176.430592634807;5216.973915130476;5254.842354729364;5274.736263186825;489.28564296128053;496.53325873678625;498.8553319537294;501.6588719670659;508.6769901112746;3078;3097.969020309813;3103.4879244924787;3103.6120484939383;3213.8071715697133;12770.744585108247;13318;13323.267220302976;13330.600081997556;13372.732545349234;13030.674233144247;13198.73602527944;13206.537771178155;13216.207027578375;13270.336483175995;9234.584443700049;9338.27241960226;9367.484788336571;9487.33588648788;9594.18449431806;5400.4059553448305;5423.810166644149;5462.186973708623;5601.29983752031;5656.490915817596;11437.599684011353;11518.136139789382;11518.654440366803;11546.480408381474;11563.248388854698;12015.879841201477;12042;12204.145709800228;12287.139900207258;12289.1397602167;7342.3758980487255;7490.288422599844;7558.13081495635;7570;7590.620468976419;9333.533323333942;9427.387219830689;9515.476648784383;9545;9564.330496865152;7896.763097107096;7948.40386970991;8044.115147333671;8051.637676304697;8108.2297181767635;8049.637766300648;8093.5953202340825;8188.222118898695;8230.670773169006;8314.79213019655;6634.800955971328;6786.626735529396;6791.286914873867;6791.864162716817;6794.66026698673;4901.117798796251;5015.423226329019;5053.469385714447;5065.189569668835;5164.870878228075;4817.614590832795;4940.6788558743565;4960.280759289811;4969.875753106201;4975.751212439436 08:38:16 INFO - PID 1754 | |4;prototype.html;378.3794576893894;402.44261697548893;403.3586597310276;403.46540833395755;407.559835377792;5431.972840135793;5599.608027438081;5614.803481878135;5638.379778224392;5678.659280443177;5400.648957817739;5477;5481.616286859921;5486.326670365547;5506.5870059745475;4267.765272909989;4267.8079486423185;4269.5943885331;4279.978600106995;4283.807228674702;4171.979140104295;4227.895577627172;4232.132412855357;4270.679699022586;4303.462067241595;4209.221294060593;4210.073783767566;4216.219999300124;4217.768022758747;4224.767637779921;4209.494860616745;4226.788660566959;4231.386448964899;4241.87274381769;4245.2783026885345;3710.2208536207427;3722.0694826293425;3723.925521489582;3742.7380083394173;3743.2887751327435;5218.921716174261;5294.6029047821185;5336.332958380202;5350.946490535084;5389.973050134763;4887.437944636341;4890.413150421937;4902.754862256908;4911.94393205459;4925.950740492621;5510.283663123768;5802.651840889518;5818.301803783573;5820.592558520905;5826.475617194473;4060.8375664973364;4075.6943229257627;4103.876883693494;4106.7125301228925;4125.834966601333;5899.705014749288;6080.422359875804;6107.175531303306;6150.446459818593;6166.630002199838;4169.687273454442;4186.764904353223;4188.4136220929095;4194.538600753915;4207.76857272853;4253.787310634456;4295.763732994653;4300.785095675729;4316.309390497506;4318.805653745589;4805.735684537384;4896.167651499253;4898.853034408973;4915.11527924977;4919.138476296091;5763.106718458645;5783.363829978699;5836;5839.124131380242;5847.56143289255;1458.4968185975822;1471.418789578132;1471.5805995291291;1481.3704175725275;1487.3381345301455;943.3490891284991;994.0655783563572;994.4977786217913;1009.4649835587151;1018.4468685254898;5101.51535604117;5107.591392688576;5117.110995643264;5126.154184559506;5133.897322053613;6023.765128148719;6055.820694135614;6066.9048392335;6117.663528505886;6121.387861213843;4834.274858771142;5041.840376713377;5075.974620126875;5106.489351064938;5108.489151084936;3176.491761318178;3214.61424629046;3218.565493658326;3219.5653586765957;3233.4826427771445;5457.317835270591;5608.4111168326735;5622.91565626516;5623.775048997994;5637.43625637433;6122;6159.784407545714;6160.1375807387;6176.4441200292185;6199.814005579839;5547.25112109868;5597.048501754712;5609.663420194802;5619.297587801525;5620.241267429008;5684.914726279192;6004.369541198112;6043.697815109139;6051.243594550681;6083.209182806207;5933.1396947443245;5961.970190149195;5962.344142144274;5999.820005399845;6002.579819412599;5327.147656374961;5409.2427060212385;5506.697131657797;5586.357568879468;5612.438756124355;4174.916501669889;4191.958080419156;4206.600372964564;4209;4219.3249080147025;5939;5993.400659933972;6044.184035155197;6048.395160484092;6050.909236361546;5794.478496935296;5801.6519008859605;5802.82591522255;5805.680687562056;5820.476157145878;5799.507041901317;5801.969310741207;5806.361300257053;5845.88928103659;5853.707314634166;5598.384177740364;5749.54003679713;5762.7694892203845;5770.682612456355;5779.624324418899;5868.530517558671;5872;5889.263842019747;5892.469677728854;5893.204417403767;5396.622236443568;5699.487046165865;5710.771569137188;5744.5117165039765;5765.4811067004175 08:38:16 INFO - PID 1754 | |5;yui.html;647.2330288607997;650.4763665249475;652.1977967100466;663.1776597019696;678.4267294136453;12176.08679349049;12749.681257968556;12777.680557986043;12778.10553261272;12826.871731282685;12758.234505929651;13401.731965360686;13621.795673064888;13646.931765341184;14235.572932812007;841.0874201491374;841.4194205997873;866.8266346730647;871.2376670413388;875.5315905990296;867.7700409391516;870.2081106193365;879.0901417033372;879.7272845417909;880.0495464897895;884.9734507964771;896.2292428511475;897.878786363839;898.7258886039755;899.0425197165031;876.6186708781669;886.2156991062956;892.205936716323;893.6916763716507;895.5387975192781;659.5877576514679;662.053263832719;663.2770280394345;664.8404382948106;666.7899611622323;14346.067505612205;14366.497172599013;14409.279536023158;14517.564473065824;15022.323995420233;12190.39048047594;12544.09918080159;12623.810642840273;12972.351382430936;12988.28564428956;9653.90346096537;9737.707868763877;9961.800763984753;9980.80038399228;10475.633352832614;2558.104663367825;2574.691037075563;2581.6127580862835;2653.3366658335417;2673.4920365130565;64288.67855660739;65907.67046164739;66059.3394066058;66865.33134668639;66885;9997.450140242356;10047.547860346302;10235.437050962268;10297.073263406179;10392.220583456272;21807.563848723254;21892;21915.67126493104;21924.23265185711;21968.780312196992;6202.596831205957;6386.201724784402;6506.186726659168;6626;6642;3017.9547306790414;3028.7274145326587;3066.4020515999614;3072.5698402223707;3105.7515398768046;3369.4103531881824;3505.4391297392804;3511.17487390463;3522.295540891832;3559.0924314299687;598.2462097756858;600.0579090827447;601.7081715368043;617.3702823120392;619.3775255867914;489.64500736966124;499.1439680947193;509.4472497340427;516.7597067363694;532.0556013076742;7501.174870764212;7631.3513351364645;7647.426443016796;7661.6552255147535;7723.7682869514;477.21736352382123;488.82646660435745;496.9776360063806;500.474501773144;511.0443470709722;3174.634916984576;3177.380410819868;3189.9362012759616;3217.51737239416;3273.3289675616443;56911.43088569144;59833.401665983656;60162.699186503785;63048.68475657592;63446;40461.19077618431;48284.275735863994;50490;50852.745736271085;53959.19061214085;40350.192996139915;43165.35251971223;44863.327050094274;45166;45634;8437;8873.378863479495;9091.454512729257;9146.008246807982;9181.403208791407;23640.645390318816;24422.26733198007;25004.874975625007;25324.620130697687;25824.354391140372;32630.289699303;44931.32603011023;46297.3055404176;47001.529984699715;47493.52506475029;11621.593244236412;11781.234219775688;11922.642320730392;12012.579559715368;12169.574064907685;11310.321380717183;11579.536818527502;11687.649370518899;11757.529698811952;11815;10400.271980961563;10504.212184086071;10595.523201455799;10718.303310284806;10793.568257269935;11193.216474846682;11234.382108984084;11345.943270283926;11463.598774042868;11562.710932226426;11246.606368777053;11548.884511154782;11580.189386743185;11798.764024719287;12044.457999390224;9660.3548234591;9910.15763660097;9929.702108936743;10066.597336106766;10340.638077667547;9200.263978881807;9213.355065145375;9229.676961306322;9238.399504032217;9258.398204116711 08:38:16 INFO - PID 1754 | __end_tp_report 08:38:16 INFO - PID 1754 | __start_cc_report 08:38:16 INFO - PID 1754 | _x_x_mozilla_cycle_collect,385 08:38:16 INFO - PID 1754 | __end_cc_report 08:38:16 INFO - PID 1754 | __startTimestamp1490197096324__endTimestamp 08:38:16 INFO - PID 1754 | 08:38:16 INFO - PID 1754 | ------- Summary: start ------- 08:38:16 INFO - PID 1754 | Number of tests: 6 08:38:16 INFO - PID 1754 | 08:38:16 INFO - PID 1754 | [#0] dojo.html Cycles:165 Average:5163.64 Median:5287.55 stddev:591.92 (11.2%) stddev-sans-first:560.37 08:38:16 INFO - PID 1754 | Values: 2666.0 2678.1 2695.6 2700.0 2707.6 5141.0 5157.7 5187.9 5204.8 5213.4 5210.2 5255.6 5260.2 5316.9 5334.1 4764.7 4809.3 4822.8 4838.6 4843.3 4838.3 4843.0 4843.3 4851.9 4879.2 4688.6 4702.8 4723.8 4737.7 4741.5 4747.7 4772.7 4787.4 4831.2 4846.3 4721.5 4752.4 4760.8 4764.8 4794.7 5111.7 5164.8 5212.1 5223.0 5247.2 5652.7 5663.5 5676.5 5706.5 5731.4 5676.4 5687.4 5689.1 5689.8 5696.1 5115.3 5174.6 5265.3 5287.6 5327.0 5614.5 5643.0 5688.0 5700.3 5710.5 5423.8 5471.6 5534.9 5552.2 5588.4 5567.7 5644.3 5646.6 5650.4 5668.5 5491.5 5544.8 5597.4 5598.1 5599.7 5557.6 5581.9 5616.2 5640.2 5642.6 4650.3 4668.6 4677.8 4678.4 4718.1 4012.2 4016.2 4031.4 4033.2 4078.3 4754.1 4803.1 4859.8 4893.7 4894.1 5677.5 5685.1 5699.5 5715.6 5749.1 4859.4 4863.0 4869.7 4881.6 4899.7 4867.9 4890.3 4907.9 4913.9 4969.5 5197.9 5231.4 5233.8 5234.4 5235.1 5599.7 5621.7 5624.8 5628.7 5652.1 5211.1 5213.0 5227.1 5228.6 5281.8 5539.9 5565.7 5585.7 5599.5 5614.4 5669.7 5674.3 5681.4 5685.9 5691.7 5390.9 5406.6 5413.0 5414.1 5459.9 5440.1 5454.0 5457.6 5461.6 5464.0 5244.2 5296.1 5346.0 5379.8 5391.3 5506.8 5520.4 5562.5 5569.9 5581.0 5360.8 5374.8 5378.1 5380.1 5388.8 08:38:16 INFO - PID 1754 | 08:38:16 INFO - PID 1754 | [#1] ext.html Cycles:180 Average:32690.55 Median:29487.63 stddev:50570.97 (171.5%) stddev-sans-first:50655.71 08:38:16 INFO - PID 1754 | Values: 675.9 1080.3 1094.5 1200.4 1214.7 32363.8 33589.7 33608.8 33653.3 33662.8 31168.8 31290.4 31295.2 31403.8 31440.0 5697.5 5840.9 6676.6 6826.8 7204.7 7351.6 7461.8 7464.6 7476.1 7481.9 7572.7 7657.3 7667.5 7689.4 7692.7 7521.8 7610.2 7611.3 7627.5 7636.7 7401.9 7509.5 7523.7 7533.0 7533.3 33353.5 33424.8 33676.5 33713.0 33723.2 2256.5 2266.9 2289.1 2289.6 2290.7 21028.7 21044.9 21107.0 21236.6 21293.1 2447.5 2459.7 2462.0 2480.6 2518.7 152313.0 154212.0 154896.0 154999.0 155090.0 32677.8 33138.7 37490.6 37781.8 43082.8 39505.6 43283.4 43286.0 43368.0 43409.1 12259.4 12313.0 12434.7 12443.1 12456.5 9606.0 9629.9 9635.8 9665.5 9725.3 12373.6 12388.2 12429.4 12439.8 12569.6 5058.3 5100.3 5147.5 5151.5 5194.7 855.1 869.2 884.8 891.8 911.4 20343.7 21338.4 21356.8 21468.1 21528.0 955.2 969.2 982.7 983.6 988.6 10978.9 10998.6 11167.1 11255.0 11299.2 210858.0 213082.0 213351.0 214419.0 214429.0 43053.6 43193.0 43196.4 43234.6 43308.0 1195.4 1203.9 1228.0 1232.1 1234.7 19996.0 20134.6 20796.2 20921.6 21010.3 30777.8 30826.4 30878.8 30903.4 30921.4 209402.0 210071.0 210197.0 210771.0 211202.0 22135.0 22136.8 26045.1 29622.6 29863.9 30106.7 30465.7 30524.8 30813.7 31053.5 28011.9 28051.4 28219.9 28440.6 28841.4 28224.3 28283.7 28506.4 29352.7 29650.3 27931.0 27953.0 28084.7 28641.9 28957.3 22426.2 24972.6 25100.9 25401.6 27258.9 20966.2 20971.9 21042.2 21071.6 21184.4 08:38:16 INFO - PID 1754 | 08:38:16 INFO - PID 1754 | [#2] jquery.html Cycles:180 Average:28456.71 Median:21218.75 stddev:78813.53 (371.4%) stddev-sans-first:79006.50 08:38:16 INFO - PID 1754 | Values: 417.2 431.7 435.1 439.3 451.5 16815.3 16949.4 17679.3 18653.5 18829.9 18269.8 18439.3 18508.3 18547.7 18675.9 5488.1 5488.6 5623.8 5645.8 5655.5 5668.3 5811.2 5845.4 5847.3 5847.4 5492.0 5498.0 5506.9 5527.4 5529.6 5569.2 5584.7 5614.0 5636.9 5673.1 5081.5 5166.8 5173.4 5185.4 5206.9 18249.8 18262.6 18309.8 22227.1 22489.3 1464.8 1497.0 1505.4 1512.4 1546.9 13376.8 13687.5 13883.2 14207.9 14215.9 1555.4 1574.0 1602.9 1608.4 1608.4 84598.0 86506.0 87014.6 88592.6 89282.0 10723.3 11042.4 11198.8 11278.8 11523.4 15777.7 15826.4 15852.9 15918.6 15937.8 7345.6 7350.6 7488.6 7555.4 7638.7 6602.8 6695.1 6798.7 6838.2 6870.6 6860.5 6934.4 7016.2 7040.2 7152.1 2107.2 2126.3 2142.3 2143.3 2280.7 825.8 851.5 857.5 865.3 869.2 16080.9 16232.5 16945.3 17220.7 17279.7 849.8 858.9 859.1 859.6 874.7 8620.1 9213.8 9272.2 9337.4 9405.4 459224.0 466180.0 466841.0 470761.0 515288.0 90940.0 96136.1 96190.5 97039.5 97935.0 1067.5 1098.2 1105.7 1113.7 1113.8 16492.6 16689.4 17013.6 17263.0 17778.1 31359.2 38295.2 41135.6 41722.8 42005.8 55477.4 55505.2 56147.7 57197.0 58507.7 8207.6 8265.8 8318.4 8371.0 8522.5 12343.4 12805.4 12909.0 12929.5 13079.3 10607.3 10617.4 10737.7 10993.4 11261.3 10449.6 10703.7 10756.4 10847.8 10852.3 11172.4 11207.6 11290.7 11347.8 11701.4 8155.3 8222.3 8361.4 8371.0 8668.0 10371.8 10423.4 10608.4 10747.8 10819.6 08:38:16 INFO - PID 1754 | 08:38:16 INFO - PID 1754 | [#3] mootools.html Cycles:180 Average:6145.16 Median:4936.46 stddev:4039.32 (81.8%) stddev-sans-first:4033.93 08:38:16 INFO - PID 1754 | Values: 1253.1 1312.7 1324.3 1329.1 1334.6 9336.4 9714.6 9720.6 9799.6 9935.2 9817.2 9952.8 9960.7 9975.0 9984.4 2148.1 2184.7 2189.3 2195.0 2196.3 2116.6 2140.4 2154.0 2155.4 2160.2 2079.5 2102.1 2125.6 2129.1 2133.6 2087.6 2101.6 2101.7 2106.2 2109.2 1813.9 1861.9 2017.5 2045.6 2072.7 9617.9 9887.2 9888.4 9958.5 9960.4 5274.4 5419.2 5461.1 5467.7 5535.0 3123.2 3141.7 3174.1 3179.5 3261.8 953.3 954.2 961.6 964.3 996.1 14688.7 14699.3 14713.5 14808.2 14812.6 4497.7 4654.6 4768.7 4778.1 4801.5 10875.6 10928.9 10938.2 10946.0 10946.9 5516.3 5516.7 5522.1 5533.8 5535.2 4790.3 4816.4 4932.2 4971.7 4995.6 3870.1 3929.2 3953.4 4017.2 4027.1 1181.4 1182.1 1183.2 1199.8 1206.8 626.5 653.6 654.4 661.9 664.0 5103.3 5176.4 5217.0 5254.8 5274.7 489.3 496.5 498.9 501.7 508.7 3078.0 3098.0 3103.5 3103.6 3213.8 12770.7 13318.0 13323.3 13330.6 13372.7 13030.7 13198.7 13206.5 13216.2 13270.3 9234.6 9338.3 9367.5 9487.3 9594.2 5400.4 5423.8 5462.2 5601.3 5656.5 11437.6 11518.1 11518.7 11546.5 11563.2 12015.9 12042.0 12204.1 12287.1 12289.1 7342.4 7490.3 7558.1 7570.0 7590.6 9333.5 9427.4 9515.5 9545.0 9564.3 7896.8 7948.4 8044.1 8051.6 8108.2 8049.6 8093.6 8188.2 8230.7 8314.8 6634.8 6786.6 6791.3 6791.9 6794.7 4901.1 5015.4 5053.5 5065.2 5164.9 4817.6 4940.7 4960.3 4969.9 4975.8 08:38:16 INFO - PID 1754 | 08:38:16 INFO - PID 1754 | [#4] prototype.html Cycles:180 Average:4814.05 Median:5420.61 stddev:1406.76 (26.0%) stddev-sans-first:1370.75 08:38:16 INFO - PID 1754 | Values: 378.4 402.4 403.4 403.5 407.6 5432.0 5599.6 5614.8 5638.4 5678.7 5400.6 5477.0 5481.6 5486.3 5506.6 4267.8 4267.8 4269.6 4280.0 4283.8 4172.0 4227.9 4232.1 4270.7 4303.5 4209.2 4210.1 4216.2 4217.8 4224.8 4209.5 4226.8 4231.4 4241.9 4245.3 3710.2 3722.1 3723.9 3742.7 3743.3 5218.9 5294.6 5336.3 5350.9 5390.0 4887.4 4890.4 4902.8 4911.9 4926.0 5510.3 5802.7 5818.3 5820.6 5826.5 4060.8 4075.7 4103.9 4106.7 4125.8 5899.7 6080.4 6107.2 6150.4 6166.6 4169.7 4186.8 4188.4 4194.5 4207.8 4253.8 4295.8 4300.8 4316.3 4318.8 4805.7 4896.2 4898.9 4915.1 4919.1 5763.1 5783.4 5836.0 5839.1 5847.6 1458.5 1471.4 1471.6 1481.4 1487.3 943.3 994.1 994.5 1009.5 1018.4 5101.5 5107.6 5117.1 5126.2 5133.9 6023.8 6055.8 6066.9 6117.7 6121.4 4834.3 5041.8 5076.0 5106.5 5108.5 3176.5 3214.6 3218.6 3219.6 3233.5 5457.3 5608.4 5622.9 5623.8 5637.4 6122.0 6159.8 6160.1 6176.4 6199.8 5547.3 5597.0 5609.7 5619.3 5620.2 5684.9 6004.4 6043.7 6051.2 6083.2 5933.1 5962.0 5962.3 5999.8 6002.6 5327.1 5409.2 5506.7 5586.4 5612.4 4174.9 4192.0 4206.6 4209.0 4219.3 5939.0 5993.4 6044.2 6048.4 6050.9 5794.5 5801.7 5802.8 5805.7 5820.5 5799.5 5802.0 5806.4 5845.9 5853.7 5598.4 5749.5 5762.8 5770.7 5779.6 5868.5 5872.0 5889.3 5892.5 5893.2 5396.6 5699.5 5710.8 5744.5 5765.5 08:38:16 INFO - PID 1754 | 08:38:16 INFO - PID 1754 | [#5] yui.html Cycles:180 Average:13930.74 Median:46649.42 stddev:17047.53 (36.5%) stddev-sans-first:17066.17 08:38:16 INFO - PID 1754 | Values: 647.2 650.5 652.2 663.2 678.4 12176.1 12749.7 12777.7 12778.1 12826.9 12758.2 13401.7 13621.8 13646.9 14235.6 841.1 841.4 866.8 871.2 875.5 867.8 870.2 879.1 879.7 880.0 885.0 896.2 897.9 898.7 899.0 876.6 886.2 892.2 893.7 895.5 659.6 662.1 663.3 664.8 666.8 14346.1 14366.5 14409.3 14517.6 15022.3 12190.4 12544.1 12623.8 12972.4 12988.3 9653.9 9737.7 9961.8 9980.8 10475.6 2558.1 2574.7 2581.6 2653.3 2673.5 64288.7 65907.7 66059.3 66865.3 66885.0 9997.5 10047.5 10235.4 10297.1 10392.2 21807.6 21892.0 21915.7 21924.2 21968.8 6202.6 6386.2 6506.2 6626.0 6642.0 3018.0 3028.7 3066.4 3072.6 3105.8 3369.4 3505.4 3511.2 3522.3 3559.1 598.2 600.1 601.7 617.4 619.4 489.6 499.1 509.4 516.8 532.1 7501.2 7631.4 7647.4 7661.7 7723.8 477.2 488.8 497.0 500.5 511.0 3174.6 3177.4 3189.9 3217.5 3273.3 56911.4 59833.4 60162.7 63048.7 63446.0 40461.2 48284.3 50490.0 50852.7 53959.2 40350.2 43165.4 44863.3 45166.0 45634.0 8437.0 8873.4 9091.5 9146.0 9181.4 23640.6 24422.3 25004.9 25324.6 25824.4 32630.3 44931.3 46297.3 47001.5 47493.5 11621.6 11781.2 11922.6 12012.6 12169.6 11310.3 11579.5 11687.6 11757.5 11815.0 10400.3 10504.2 10595.5 10718.3 10793.6 11193.2 11234.4 11345.9 11463.6 11562.7 11246.6 11548.9 11580.2 11798.8 12044.5 9660.4 9910.2 9929.7 10066.6 10340.6 9200.3 9213.4 9229.7 9238.4 9258.4 08:38:16 INFO - PID 1754 | -------- Summary: end -------- 08:38:16 INFO - PID 1754 | 08:38:17 INFO - TEST-INFO | 1754: exit 0 08:38:17 INFO - TEST-OK | dromaeo_css | took 1121131ms 08:38:17 INFO - TEST-START | kraken 08:38:17 INFO - operating with platform_type : linux_ 08:38:17 INFO - Initialising browser for kraken test... 08:38:17 INFO - TEST-INFO | started process 2130 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpewJVvS/profile http://localhost:53619/getInfo.html) 08:38:21 INFO - PID 2130 | __metrics Screen width/height:1600/1200 08:38:21 INFO - PID 2130 | colorDepth:24 08:38:21 INFO - PID 2130 | Browser inner width/height: 1024/697 08:38:21 INFO - PID 2130 | __metrics 08:38:22 ERROR - PID 2130 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 08:38:23 INFO - TEST-INFO | 2130: exit 0 08:38:23 INFO - Browser initialized. 08:38:23 INFO - Running cycle 1/1 for kraken test... 08:38:23 INFO - TEST-INFO | started process 2260 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpewJVvS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:38:35 INFO - PID 2260 | RSS: Main: 155541504 08:38:35 INFO - PID 2260 | 08:38:38 INFO - PID 2260 | Cycle 1(1): loaded http://localhost:53619/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53619/tests/kraken/driver.html?testName=audio-beat-detection) 08:38:39 INFO - PID 2260 | RSS: Main: 161370112 08:38:39 INFO - PID 2260 | 08:38:42 INFO - PID 2260 | Cycle 1(1): loaded http://localhost:53619/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53619/tests/kraken/driver.html?testName=audio-dft) 08:38:42 INFO - PID 2260 | RSS: Main: 160526336 08:38:42 INFO - PID 2260 | 08:38:45 INFO - PID 2260 | Cycle 1(1): loaded http://localhost:53619/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53619/tests/kraken/driver.html?testName=audio-fft) 08:38:46 INFO - PID 2260 | RSS: Main: 157147136 08:38:46 INFO - PID 2260 | 08:38:48 INFO - PID 2260 | Cycle 1(1): loaded http://localhost:53619/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53619/tests/kraken/driver.html?testName=audio-oscillator) 08:38:49 INFO - PID 2260 | RSS: Main: 158531584 08:38:49 INFO - PID 2260 | 08:38:51 INFO - PID 2260 | Cycle 1(1): loaded http://localhost:53619/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53619/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:38:51 INFO - PID 2260 | RSS: Main: 158244864 08:38:51 INFO - PID 2260 | 08:38:55 INFO - PID 2260 | Cycle 1(1): loaded http://localhost:53619/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53619/tests/kraken/driver.html?testName=imaging-darkroom) 08:38:55 INFO - PID 2260 | RSS: Main: 163209216 08:38:55 INFO - PID 2260 | 08:38:59 INFO - PID 2260 | Cycle 1(1): loaded http://localhost:53619/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53619/tests/kraken/driver.html?testName=imaging-desaturate) 08:38:59 INFO - PID 2260 | RSS: Main: 160837632 08:38:59 INFO - PID 2260 | 08:39:02 INFO - PID 2260 | Cycle 1(1): loaded http://localhost:53619/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53619/tests/kraken/driver.html?testName=json-parse-financial) 08:39:03 INFO - PID 2260 | RSS: Main: 162418688 08:39:03 INFO - PID 2260 | 08:39:05 INFO - PID 2260 | Cycle 1(1): loaded http://localhost:53619/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53619/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:39:05 INFO - PID 2260 | RSS: Main: 162209792 08:39:05 INFO - PID 2260 | 08:39:07 INFO - PID 2260 | Cycle 1(1): loaded http://localhost:53619/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53619/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:39:08 INFO - PID 2260 | RSS: Main: 162066432 08:39:08 INFO - PID 2260 | 08:39:10 INFO - PID 2260 | Cycle 1(1): loaded http://localhost:53619/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53619/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:39:11 INFO - PID 2260 | RSS: Main: 162226176 08:39:11 INFO - PID 2260 | 08:39:14 INFO - PID 2260 | Cycle 1(1): loaded http://localhost:53619/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53619/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:39:14 INFO - PID 2260 | RSS: Main: 163307520 08:39:14 INFO - PID 2260 | 08:39:18 INFO - PID 2260 | Cycle 1(1): loaded http://localhost:53619/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53619/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:39:18 INFO - PID 2260 | RSS: Main: 162439168 08:39:18 INFO - PID 2260 | 08:39:20 INFO - PID 2260 | Cycle 1(1): loaded http://localhost:53619/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53619/tests/kraken/driver.html?testName=ai-astar) 08:39:20 INFO - PID 2260 | RSS: Main: 164204544 08:39:20 INFO - PID 2260 | 08:39:20 INFO - PID 2260 | __start_tp_report 08:39:20 INFO - PID 2260 | _x_x_mozilla_page_load 08:39:20 INFO - PID 2260 | _x_x_mozilla_page_load_details 08:39:20 INFO - PID 2260 | |i|pagename|runs| 08:39:20 INFO - PID 2260 | |0;ai-astar;105;112;111;113;112;113;112;112;111;111 08:39:20 INFO - PID 2260 | |1;audio-beat-detection;155;128;128;164;126;127;128;125;156;129 08:39:20 INFO - PID 2260 | |2;audio-dft;165;167;172;169;171;168;164;162;166;163 08:39:20 INFO - PID 2260 | |3;audio-fft;75;75;76;113;76;75;75;75;93;75 08:39:20 INFO - PID 2260 | |4;audio-oscillator;84;84;124;86;85;85;99;85;87;108 08:39:20 INFO - PID 2260 | |5;imaging-gaussian-blur;115;114;114;115;116;117;114;116;118;115 08:39:20 INFO - PID 2260 | |6;imaging-darkroom;151;151;151;151;150;152;152;150;152;153 08:39:20 INFO - PID 2260 | |7;imaging-desaturate;95;95;95;94;94;96;95;95;94;94 08:39:20 INFO - PID 2260 | |8;json-parse-financial;72;69;69;71;71;70;72;70;70;73 08:39:20 INFO - PID 2260 | |9;json-stringify-tinderbox;56;57;56;56;57;59;56;57;56;56 08:39:20 INFO - PID 2260 | |10;stanford-crypto-aes;85;84;84;84;86;83;83;91;92;84 08:39:20 INFO - PID 2260 | |11;stanford-crypto-ccm;137;132;133;138;145;146;138;142;187;137 08:39:20 INFO - PID 2260 | |12;stanford-crypto-pbkdf2;192;195;197;197;186;193;193;192;193;196 08:39:20 INFO - PID 2260 | |13;stanford-crypto-sha256-iterative;71;74;72;72;73;71;71;71;71;76 08:39:20 INFO - PID 2260 | __end_tp_report 08:39:20 INFO - PID 2260 | __start_cc_report 08:39:20 INFO - PID 2260 | _x_x_mozilla_cycle_collect,872 08:39:20 INFO - PID 2260 | __end_cc_report 08:39:20 INFO - PID 2260 | __startTimestamp1490197160760__endTimestamp 08:39:20 INFO - PID 2260 | 08:39:20 INFO - PID 2260 | ------- Summary: start ------- 08:39:20 INFO - PID 2260 | Number of tests: 14 08:39:20 INFO - PID 2260 | 08:39:20 INFO - PID 2260 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:2.30 (2.1%) stddev-sans-first:0.78 08:39:20 INFO - PID 2260 | Values: 105.0 112.0 111.0 113.0 112.0 113.0 112.0 112.0 111.0 111.0 08:39:20 INFO - PID 2260 | 08:39:20 INFO - PID 2260 | [#1] audio-beat-detection Cycles:10 Average:136.60 Median:128.50 stddev:15.22 (11.8%) stddev-sans-first:14.61 08:39:20 INFO - PID 2260 | Values: 155.0 128.0 128.0 164.0 126.0 127.0 128.0 125.0 156.0 129.0 08:39:20 INFO - PID 2260 | 08:39:20 INFO - PID 2260 | [#2] audio-dft Cycles:10 Average:166.70 Median:167.50 stddev:3.33 (2.0%) stddev-sans-first:3.48 08:39:20 INFO - PID 2260 | Values: 165.0 167.0 172.0 169.0 171.0 168.0 164.0 162.0 166.0 163.0 08:39:20 INFO - PID 2260 | 08:39:20 INFO - PID 2260 | [#3] audio-fft Cycles:10 Average:80.80 Median:75.00 stddev:12.62 (16.8%) stddev-sans-first:13.21 08:39:20 INFO - PID 2260 | Values: 75.0 75.0 76.0 113.0 76.0 75.0 75.0 75.0 93.0 75.0 08:39:20 INFO - PID 2260 | 08:39:20 INFO - PID 2260 | [#4] audio-oscillator Cycles:10 Average:92.70 Median:85.00 stddev:13.58 (16.0%) stddev-sans-first:14.04 08:39:20 INFO - PID 2260 | Values: 84.0 84.0 124.0 86.0 85.0 85.0 99.0 85.0 87.0 108.0 08:39:20 INFO - PID 2260 | 08:39:20 INFO - PID 2260 | [#5] imaging-gaussian-blur Cycles:10 Average:115.40 Median:115.50 stddev:1.35 (1.2%) stddev-sans-first:1.42 08:39:20 INFO - PID 2260 | Values: 115.0 114.0 114.0 115.0 116.0 117.0 114.0 116.0 118.0 115.0 08:39:20 INFO - PID 2260 | 08:39:20 INFO - PID 2260 | [#6] imaging-darkroom Cycles:10 Average:151.30 Median:151.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 08:39:20 INFO - PID 2260 | Values: 151.0 151.0 151.0 151.0 150.0 152.0 152.0 150.0 152.0 153.0 08:39:20 INFO - PID 2260 | 08:39:20 INFO - PID 2260 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 08:39:20 INFO - PID 2260 | Values: 95.0 95.0 95.0 94.0 94.0 96.0 95.0 95.0 94.0 94.0 08:39:20 INFO - PID 2260 | 08:39:20 INFO - PID 2260 | [#8] json-parse-financial Cycles:10 Average:70.70 Median:71.00 stddev:1.34 (1.9%) stddev-sans-first:1.33 08:39:20 INFO - PID 2260 | Values: 72.0 69.0 69.0 71.0 71.0 70.0 72.0 70.0 70.0 73.0 08:39:20 INFO - PID 2260 | 08:39:20 INFO - PID 2260 | [#9] json-stringify-tinderbox Cycles:10 Average:56.60 Median:56.50 stddev:0.97 (1.7%) stddev-sans-first:1.00 08:39:20 INFO - PID 2260 | Values: 56.0 57.0 56.0 56.0 57.0 59.0 56.0 57.0 56.0 56.0 08:39:20 INFO - PID 2260 | 08:39:20 INFO - PID 2260 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:84.50 stddev:3.24 (3.8%) stddev-sans-first:3.43 08:39:20 INFO - PID 2260 | Values: 85.0 84.0 84.0 84.0 86.0 83.0 83.0 91.0 92.0 84.0 08:39:20 INFO - PID 2260 | 08:39:20 INFO - PID 2260 | [#11] stanford-crypto-ccm Cycles:10 Average:143.50 Median:140.00 stddev:15.95 (11.4%) stddev-sans-first:16.75 08:39:20 INFO - PID 2260 | Values: 137.0 132.0 133.0 138.0 145.0 146.0 138.0 142.0 187.0 137.0 08:39:20 INFO - PID 2260 | 08:39:20 INFO - PID 2260 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.40 Median:194.00 stddev:3.24 (1.7%) stddev-sans-first:3.40 08:39:20 INFO - PID 2260 | Values: 192.0 195.0 197.0 197.0 186.0 193.0 193.0 192.0 193.0 196.0 08:39:20 INFO - PID 2260 | 08:39:20 INFO - PID 2260 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.20 Median:72.00 stddev:1.69 (2.3%) stddev-sans-first:1.73 08:39:20 INFO - PID 2260 | Values: 71.0 74.0 72.0 72.0 73.0 71.0 71.0 71.0 71.0 76.0 08:39:20 INFO - PID 2260 | -------- Summary: end -------- 08:39:20 INFO - PID 2260 | 08:39:22 INFO - TEST-INFO | 2260: exit 0 08:39:22 INFO - TEST-OK | kraken | took 64968ms 08:39:22 INFO - SUITE-END | took 1186s 08:39:22 INFO - Completed test suite (00:19:46) 08:39:22 INFO - javascript benchmark 08:39:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6558.942515638437, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2665.9866700666494, 2678.1028355500907, 2695.609136675182, 2700.0144947094304, 2707.634469346638, 5141.0232055909355, 5157.690538567688, 5187.870303242416, 5204.817831375903, 5213.426523082458, 5210.2445145453885, 5255.632105752599, 5260.210968354749, 5316.946830531693, 5334.146536554152, 4764.714117152973, 4809.278608208761, 4822.831200907969, 4838.588719958808, 4843.321934929113, 4838.322634831126, 4842.951570484285, 4843.273508973664, 4851.927221091686, 4879.170541008037, 4688.648351373627, 4702.835400760991, 4723.834665786715, 4737.668363214576, 4741.454732705749, 4747.7388743619085, 4772.665913386064, 4787.425508938914, 4831.22700367943, 4846.297286893416, 4721.504242054569, 4752.358431611758, 4760.833370832039, 4764.761761911891, 4794.712317260975, 5111.667741596784, 5164.819231326923, 5212.113940630102, 5222.973885130588, 5247.16045432729, 5652.689102099383, 5663.49028587425, 5676.489115979541, 5706.514946229576, 5731.426857314277, 5676.375598684142, 5687.374388817227, 5689.146628005791, 5689.800856969986, 5696.060150075233, 5115.258287548285, 5174.586033117342, 5265.341832270966, 5287.550558202519, 5326.97336513315, 5614.494695477427, 5643.040683083886, 5688.033034384164, 5700.3444603871085, 5710.543156547466, 5423.83728488146, 5471.644343117685, 5534.86162845924, 5552.167174923713, 5588.441155884379, 5567.66594004361, 5644.294463192101, 5646.604737668324, 5650.378458369576, 5668.51817595509, 5491.450854914477, 5544.750486228129, 5597.44025597437, 5598.076317407664, 5599.664020158803, 5557.5553955683445, 5581.944180558143, 5616.213730077792, 5640.238567793295, 5642.605017648807, 4650.325702773147, 4668.579827815445, 4677.766111694402, 4678.368420263221, 4718.103560323596, 4012.197560487914, 4016.156607112539, 4031.4355990161403, 4033.1933613276874, 4078.286299897506, 4754.07295577366, 4803.087413391444, 4859.781309841065, 4893.657443978887, 4894.094592500399, 5677.489025987598, 5685.061964775766, 5699.544036477072, 5715.571332150105, 5749.137629355547, 4859.441164266084, 4862.975685121552, 4869.659123861366, 4881.609471242292, 4899.706017638953, 4867.9269810952865, 4890.315355850184, 4907.87730306738, 4913.852584422473, 4969.478204788517, 5197.870053248699, 5231.372235331784, 5233.790648374023, 5234.424213336454, 5235.110031294613, 5599.664020158803, 5621.690807005491, 5624.831255062355, 5628.746706398304, 5652.123920792284, 5211.140161873249, 5213.0, 5227.085260079547, 5228.555572776357, 5281.841544753664, 5539.947409992089, 5565.749541270734, 5585.659441734036, 5599.496045355938, 5614.382417934105, 5669.716514174357, 5674.2623458950075, 5681.375048744552, 5685.886282274414, 5691.7438715257085, 5390.892182156414, 5406.621536492407, 5412.972935135299, 5414.0525408052645, 5459.918101228564, 5440.129579267298, 5453.972730136324, 5457.645253058538, 5461.617686762047, 5463.972680136574, 5244.187150991603, 5296.099663057213, 5346.0, 5379.757910893941, 5391.272178255886, 5506.779728810803, 5520.447955204448, 5562.499375056264, 5569.944300556943, 5581.023320918742, 5360.785568577213, 5374.811881584125, 5378.058839703114, 5380.11228147367, 5388.838334849961], "value": 5120.709751640557, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [675.9019942108393, 1080.2978064258232, 1094.4527736131934, 1200.4237965776433, 1214.67811030077, 32363.838180809093, 33589.66410335899, 33608.831955840185, 33653.326933461314, 33662.831685841535, 31168.844155779247, 31290.374192516138, 31295.217619559524, 31403.84298078512, 31440.0, 5697.487226149646, 5840.912386314209, 6676.632785196813, 6826.795196144124, 7204.675789589455, 7351.595662238575, 7461.813454663623, 7464.589447580381, 7476.14024387197, 7481.8877716834295, 7572.697092116308, 7657.310842024217, 7667.501612395205, 7689.423293253, 7692.730754423596, 7521.774346769551, 7610.238976102401, 7611.314981651651, 7627.466077374614, 7636.732714354971, 7401.851962960711, 7509.511881727725, 7523.742877136891, 7533.0, 7533.284337987882, 33353.49969750456, 33424.83287583571, 33676.494852577234, 33713.0, 33723.15692107692, 2256.4697296135396, 2266.8639881607155, 2289.0614847912275, 2289.6222123349626, 2290.667853161299, 21028.684569731467, 21044.894775526176, 21107.0, 21236.575268494697, 21293.14827406902, 2447.5349683560066, 2459.6802415686025, 2461.963070553943, 2480.593823990726, 2518.7229404765462, 152313.0, 154212.0, 154896.0, 154999.0, 155090.0, 32677.836610816794, 33138.66861331404, 37490.62509374926, 37781.81109094437, 43082.78458607687, 39505.60494395077, 43283.350749738776, 43286.0, 43368.0, 43409.13181736348, 12259.387030648431, 12313.0, 12434.689132771753, 12443.066769992287, 12456.501739930301, 9606.039396060338, 9629.855552166724, 9635.759106022406, 9665.516724163763, 9725.319227654138, 12373.577038640491, 12388.212652153194, 12429.37853107341, 12439.813402798965, 12569.622911312676, 5058.266551350033, 5100.285959965608, 5147.485251474897, 5151.5106064923775, 5194.662346947436, 855.1021427501099, 869.2394155114275, 884.8055125580415, 891.790429249126, 911.4394647292, 20343.69484457734, 21338.359849204237, 21356.78643213548, 21468.141274349164, 21528.0, 955.1642312976146, 969.1810420194925, 982.6708052802392, 983.5524836199512, 988.6094992477931, 10978.945105274583, 10998.560057597766, 11167.106631469464, 11255.0, 11299.152563557602, 210858.0, 213082.0, 213351.0, 214419.0, 214429.0, 43053.56946430558, 43193.0, 43196.3520547192, 43234.567654323684, 43308.0, 1195.4405106473457, 1203.867574566797, 1227.969300767488, 1232.1128787273149, 1234.6851552853964, 19996.0, 20134.59730805405, 20796.1681532737, 20921.581568368852, 21010.26464073811, 30777.846110769304, 30826.383472330876, 30878.845605772727, 30903.38193236078, 30921.381572367976, 209402.0, 210071.0, 210197.0, 210771.0, 211202.0, 22135.0, 22136.778632214115, 26045.088421905144, 29622.555661665523, 29863.85068074646, 30106.69893301039, 30465.695343046285, 30524.84737576298, 30813.691863081083, 31053.534196987515, 28011.859940700167, 28051.43897122087, 28219.858900705363, 28440.57339139873, 28841.42317153687, 28224.29439264035, 28283.717162828107, 28506.42987140204, 29352.706472935, 29650.258743531584, 27931.0, 27953.021644242355, 28084.71915280821, 28641.856790715912, 28957.276068098465, 22426.215082472034, 24972.625410618493, 25100.874495627406, 25401.618975715748, 27258.863705681346, 20966.16135354569, 20971.8951405242, 21042.15831366728, 21071.57856842824, 21184.364469065953], "value": 14401.471440114075, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.1739954889321, 431.7011911570884, 435.10151537075933, 439.26861775144386, 451.4717780197171, 16815.327386904526, 16949.406770763027, 17679.29282828687, 18653.53366165843, 18829.90585047076, 18269.817301826977, 18439.262429502836, 18508.2596696132, 18547.721784173213, 18675.906620466878, 5488.1493368527945, 5488.615796894219, 5623.775048998055, 5645.774169033234, 5655.4910058094765, 5668.348139963916, 5811.215485909412, 5845.357010728816, 5847.298324201101, 5847.41525847414, 5491.972540137293, 5498.0, 5506.944930550703, 5527.447255274481, 5529.612927095105, 5569.248151499536, 5584.692841893714, 5614.0, 5636.915446268309, 5673.092305231185, 5081.542661160476, 5166.767495462713, 5173.3533308336455, 5185.429602743695, 5206.921896171561, 18249.817501824946, 18262.634747305114, 18309.816901830945, 22227.110915563357, 22489.325320240256, 1464.809574755275, 1496.9550913472613, 1505.4204131409376, 1512.4177191781243, 1546.9071855688694, 13376.799348009788, 13687.452501899912, 13883.236421996786, 14207.928960355131, 14215.928920355436, 1555.4089446010557, 1573.9842601573953, 1602.8877978541507, 1608.388812251337, 1608.4290077022606, 84598.0, 86506.0, 87014.5649271756, 88592.55703721504, 89282.0, 10723.30298530593, 11042.392668403154, 11198.832017519744, 11278.774424511628, 11523.423828808525, 15777.68444631101, 15826.366945322288, 15852.920735396248, 15918.602034948988, 15937.840621593867, 7345.595992220479, 7350.63246837656, 7488.625568721543, 7555.433342499225, 7638.69445222196, 6602.7689030883685, 6695.12963314766, 6798.66006699663, 6838.1794184697155, 6870.587764734132, 6860.451163906875, 6934.375906168469, 7016.158061032709, 7040.225575186725, 7152.141742990771, 2107.2097963263777, 2126.277065797636, 2142.30375128084, 2143.2927134045726, 2280.680704701343, 825.8430898129336, 851.5188918261163, 857.5112186054014, 865.3336930563431, 869.1569177897429, 16080.919595402182, 16232.513024609281, 16945.32218711238, 17220.741688874677, 17279.74080388795, 849.7748096754365, 858.9398742087994, 859.0936561927102, 859.5702148925537, 874.6588830356167, 8620.13798620133, 9213.81572368549, 9272.165505104573, 9337.393069450463, 9405.43567385959, 459224.0, 466180.0, 466841.0, 470761.0, 515288.0, 90940.0, 96136.11591652261, 96190.51904740572, 97039.51480242694, 97935.0, 1067.4876059491487, 1098.2202636128438, 1105.7180418993105, 1113.704868209925, 1113.7661091170783, 16492.587685307964, 16689.415870444474, 17013.57466063358, 17263.0, 17778.11109444497, 31359.21601959969, 38295.23409531738, 41135.58864411317, 41722.791386042874, 42005.78997104995, 55477.44522554884, 55505.1674224895, 56147.71926140343, 57197.0, 58507.707461464124, 8207.58962051907, 8265.800649512865, 8318.417710760188, 8370.958145209479, 8522.48865068098, 12343.444544995677, 12805.359732013176, 12909.0, 12929.54746583865, 13079.346032698517, 10607.31052481617, 10617.416042117758, 10737.677869663923, 10993.395363255098, 11261.324320540794, 10449.634262800766, 10703.678889633324, 10756.354618722902, 10847.837282440612, 10852.294600851235, 11172.385518796544, 11207.551697931991, 11290.661280161608, 11347.773044538897, 11701.414929253333, 8155.306798922158, 8222.301104405953, 8361.372897032625, 8371.0, 8668.0, 10371.755389353326, 10423.374597524173, 10608.363498190134, 10747.838782418426, 10819.621313253998], "value": 8904.270166973574, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1253.1353366177339, 1312.7308901675158, 1324.3113580937918, 1329.0829327763843, 1334.6062911441124, 9336.393134446256, 9714.61991812006, 9720.611175552978, 9799.559019844106, 9935.155511781508, 9817.165540929012, 9952.751181220474, 9960.701178964642, 9975.0, 9984.351017183879, 2148.054855863419, 2184.726909136358, 2189.3431970408815, 2194.9890250548724, 2196.3191410662666, 2116.5661039486868, 2140.4327853118934, 2153.967690484644, 2155.385715071205, 2160.2331172433796, 2079.5009197792574, 2102.1066046929996, 2125.5855108253895, 2129.0951345678104, 2133.5946170227608, 2087.561612061469, 2101.63221436248, 2101.674240492726, 2106.1575369852103, 2109.1879626343966, 1813.936512222079, 1861.91621377037, 2017.5412338731421, 2045.5704302096578, 2072.6890966355018, 9617.90382096177, 9887.209023278192, 9888.406695598287, 9958.502074896227, 9960.402375857399, 5274.4198138204765, 5419.160030195326, 5461.0716178249795, 5467.699276539789, 5535.0, 3123.1723593247807, 3141.7165668662674, 3174.0953828158863, 3179.5230715392645, 3261.7553683473598, 953.2802733935904, 954.2230818826619, 961.6489981156898, 964.3394274921701, 996.0985308296003, 14688.706225875423, 14699.338529766079, 14713.485028024075, 14808.185549794756, 14812.555623331318, 4497.730136191839, 4654.604358629555, 4768.666193366431, 4778.092162489116, 4801.51984801517, 10875.564977400816, 10928.945355273172, 10938.179636527293, 10946.0, 10946.945265273622, 5516.282883225235, 5516.696581688046, 5522.088855338904, 5533.7786488540005, 5535.197396377503, 4790.257510085942, 4816.373871396696, 4932.235503496964, 4971.701697898137, 4995.550400463976, 3870.1098747288283, 3929.214157168578, 3953.446517487554, 4017.2367250222364, 4027.0939038716056, 1181.373871847922, 1182.1016027818919, 1183.219075410225, 1199.8440202773584, 1206.7586482703493, 626.5488848029412, 653.5686446944993, 654.3783405764543, 661.9441990025902, 664.0, 5103.336566246364, 5176.430592634807, 5216.973915130476, 5254.842354729364, 5274.736263186825, 489.28564296128053, 496.53325873678625, 498.8553319537294, 501.6588719670659, 508.6769901112746, 3078.0, 3097.969020309813, 3103.4879244924787, 3103.6120484939383, 3213.8071715697133, 12770.744585108247, 13318.0, 13323.267220302976, 13330.600081997556, 13372.732545349234, 13030.674233144247, 13198.73602527944, 13206.537771178155, 13216.207027578375, 13270.336483175995, 9234.584443700049, 9338.27241960226, 9367.484788336571, 9487.33588648788, 9594.18449431806, 5400.4059553448305, 5423.810166644149, 5462.186973708623, 5601.29983752031, 5656.490915817596, 11437.599684011353, 11518.136139789382, 11518.654440366803, 11546.480408381474, 11563.248388854698, 12015.879841201477, 12042.0, 12204.145709800228, 12287.139900207258, 12289.1397602167, 7342.3758980487255, 7490.288422599844, 7558.13081495635, 7570.0, 7590.620468976419, 9333.533323333942, 9427.387219830689, 9515.476648784383, 9545.0, 9564.330496865152, 7896.763097107096, 7948.40386970991, 8044.115147333671, 8051.637676304697, 8108.2297181767635, 8049.637766300648, 8093.5953202340825, 8188.222118898695, 8230.670773169006, 8314.79213019655, 6634.800955971328, 6786.626735529396, 6791.286914873867, 6791.864162716817, 6794.66026698673, 4901.117798796251, 5015.423226329019, 5053.469385714447, 5065.189569668835, 5164.870878228075, 4817.614590832795, 4940.6788558743565, 4960.280759289811, 4969.875753106201, 4975.751212439436], "value": 4534.387079208567, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.3794576893894, 402.44261697548893, 403.3586597310276, 403.46540833395755, 407.559835377792, 5431.972840135793, 5599.608027438081, 5614.803481878135, 5638.379778224392, 5678.659280443177, 5400.648957817739, 5477.0, 5481.616286859921, 5486.326670365547, 5506.5870059745475, 4267.765272909989, 4267.8079486423185, 4269.5943885331, 4279.978600106995, 4283.807228674702, 4171.979140104295, 4227.895577627172, 4232.132412855357, 4270.679699022586, 4303.462067241595, 4209.221294060593, 4210.073783767566, 4216.219999300124, 4217.768022758747, 4224.767637779921, 4209.494860616745, 4226.788660566959, 4231.386448964899, 4241.87274381769, 4245.2783026885345, 3710.2208536207427, 3722.0694826293425, 3723.925521489582, 3742.7380083394173, 3743.2887751327435, 5218.921716174261, 5294.6029047821185, 5336.332958380202, 5350.946490535084, 5389.973050134763, 4887.437944636341, 4890.413150421937, 4902.754862256908, 4911.94393205459, 4925.950740492621, 5510.283663123768, 5802.651840889518, 5818.301803783573, 5820.592558520905, 5826.475617194473, 4060.8375664973364, 4075.6943229257627, 4103.876883693494, 4106.7125301228925, 4125.834966601333, 5899.705014749288, 6080.422359875804, 6107.175531303306, 6150.446459818593, 6166.630002199838, 4169.687273454442, 4186.764904353223, 4188.4136220929095, 4194.538600753915, 4207.76857272853, 4253.787310634456, 4295.763732994653, 4300.785095675729, 4316.309390497506, 4318.805653745589, 4805.735684537384, 4896.167651499253, 4898.853034408973, 4915.11527924977, 4919.138476296091, 5763.106718458645, 5783.363829978699, 5836.0, 5839.124131380242, 5847.56143289255, 1458.4968185975822, 1471.418789578132, 1471.5805995291291, 1481.3704175725275, 1487.3381345301455, 943.3490891284991, 994.0655783563572, 994.4977786217913, 1009.4649835587151, 1018.4468685254898, 5101.51535604117, 5107.591392688576, 5117.110995643264, 5126.154184559506, 5133.897322053613, 6023.765128148719, 6055.820694135614, 6066.9048392335, 6117.663528505886, 6121.387861213843, 4834.274858771142, 5041.840376713377, 5075.974620126875, 5106.489351064938, 5108.489151084936, 3176.491761318178, 3214.61424629046, 3218.565493658326, 3219.5653586765957, 3233.4826427771445, 5457.317835270591, 5608.4111168326735, 5622.91565626516, 5623.775048997994, 5637.43625637433, 6122.0, 6159.784407545714, 6160.1375807387, 6176.4441200292185, 6199.814005579839, 5547.25112109868, 5597.048501754712, 5609.663420194802, 5619.297587801525, 5620.241267429008, 5684.914726279192, 6004.369541198112, 6043.697815109139, 6051.243594550681, 6083.209182806207, 5933.1396947443245, 5961.970190149195, 5962.344142144274, 5999.820005399845, 6002.579819412599, 5327.147656374961, 5409.2427060212385, 5506.697131657797, 5586.357568879468, 5612.438756124355, 4174.916501669889, 4191.958080419156, 4206.600372964564, 4209.0, 4219.3249080147025, 5939.0, 5993.400659933972, 6044.184035155197, 6048.395160484092, 6050.909236361546, 5794.478496935296, 5801.6519008859605, 5802.82591522255, 5805.680687562056, 5820.476157145878, 5799.507041901317, 5801.969310741207, 5806.361300257053, 5845.88928103659, 5853.707314634166, 5598.384177740364, 5749.54003679713, 5762.7694892203845, 5770.682612456355, 5779.624324418899, 5868.530517558671, 5872.0, 5889.263842019747, 5892.469677728854, 5893.204417403767, 5396.622236443568, 5699.487046165865, 5710.771569137188, 5744.5117165039765, 5765.4811067004175], "value": 4383.692050381996, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.2330288607997, 650.4763665249475, 652.1977967100466, 663.1776597019696, 678.4267294136453, 12176.08679349049, 12749.681257968556, 12777.680557986043, 12778.10553261272, 12826.871731282685, 12758.234505929651, 13401.731965360686, 13621.795673064888, 13646.931765341184, 14235.572932812007, 841.0874201491374, 841.4194205997873, 866.8266346730647, 871.2376670413388, 875.5315905990296, 867.7700409391516, 870.2081106193365, 879.0901417033372, 879.7272845417909, 880.0495464897895, 884.9734507964771, 896.2292428511475, 897.878786363839, 898.7258886039755, 899.0425197165031, 876.6186708781669, 886.2156991062956, 892.205936716323, 893.6916763716507, 895.5387975192781, 659.5877576514679, 662.053263832719, 663.2770280394345, 664.8404382948106, 666.7899611622323, 14346.067505612205, 14366.497172599013, 14409.279536023158, 14517.564473065824, 15022.323995420233, 12190.39048047594, 12544.09918080159, 12623.810642840273, 12972.351382430936, 12988.28564428956, 9653.90346096537, 9737.707868763877, 9961.800763984753, 9980.80038399228, 10475.633352832614, 2558.104663367825, 2574.691037075563, 2581.6127580862835, 2653.3366658335417, 2673.4920365130565, 64288.67855660739, 65907.67046164739, 66059.3394066058, 66865.33134668639, 66885.0, 9997.450140242356, 10047.547860346302, 10235.437050962268, 10297.073263406179, 10392.220583456272, 21807.563848723254, 21892.0, 21915.67126493104, 21924.23265185711, 21968.780312196992, 6202.596831205957, 6386.201724784402, 6506.186726659168, 6626.0, 6642.0, 3017.9547306790414, 3028.7274145326587, 3066.4020515999614, 3072.5698402223707, 3105.7515398768046, 3369.4103531881824, 3505.4391297392804, 3511.17487390463, 3522.295540891832, 3559.0924314299687, 598.2462097756858, 600.0579090827447, 601.7081715368043, 617.3702823120392, 619.3775255867914, 489.64500736966124, 499.1439680947193, 509.4472497340427, 516.7597067363694, 532.0556013076742, 7501.174870764212, 7631.3513351364645, 7647.426443016796, 7661.6552255147535, 7723.7682869514, 477.21736352382123, 488.82646660435745, 496.9776360063806, 500.474501773144, 511.0443470709722, 3174.634916984576, 3177.380410819868, 3189.9362012759616, 3217.51737239416, 3273.3289675616443, 56911.43088569144, 59833.401665983656, 60162.699186503785, 63048.68475657592, 63446.0, 40461.19077618431, 48284.275735863994, 50490.0, 50852.745736271085, 53959.19061214085, 40350.192996139915, 43165.35251971223, 44863.327050094274, 45166.0, 45634.0, 8437.0, 8873.378863479495, 9091.454512729257, 9146.008246807982, 9181.403208791407, 23640.645390318816, 24422.26733198007, 25004.874975625007, 25324.620130697687, 25824.354391140372, 32630.289699303, 44931.32603011023, 46297.3055404176, 47001.529984699715, 47493.52506475029, 11621.593244236412, 11781.234219775688, 11922.642320730392, 12012.579559715368, 12169.574064907685, 11310.321380717183, 11579.536818527502, 11687.649370518899, 11757.529698811952, 11815.0, 10400.271980961563, 10504.212184086071, 10595.523201455799, 10718.303310284806, 10793.568257269935, 11193.216474846682, 11234.382108984084, 11345.943270283926, 11463.598774042868, 11562.710932226426, 11246.606368777053, 11548.884511154782, 11580.189386743185, 11798.764024719287, 12044.457999390224, 9660.3548234591, 9910.15763660097, 9929.702108936743, 10066.597336106766, 10340.638077667547, 9200.263978881807, 9213.355065145375, 9229.676961306322, 9238.399504032217, 9258.398204116711], "value": 6099.25038704734, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1571.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 111.0, 113.0, 112.0, 113.0, 112.0, 112.0, 111.0, 111.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 128.0, 128.0, 164.0, 126.0, 127.0, 128.0, 125.0, 156.0, 129.0], "value": 136.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 167.0, 172.0, 169.0, 171.0, 168.0, 164.0, 162.0, 166.0, 163.0], "value": 166.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 113.0, 76.0, 75.0, 75.0, 75.0, 93.0, 75.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 124.0, 86.0, 85.0, 85.0, 99.0, 85.0, 87.0, 108.0], "value": 92.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 115.0, 116.0, 117.0, 114.0, 116.0, 118.0, 115.0], "value": 115.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 151.0, 151.0, 150.0, 152.0, 152.0, 150.0, 152.0, 153.0], "value": 151.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 94.0, 96.0, 95.0, 95.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 69.0, 69.0, 71.0, 71.0, 70.0, 72.0, 70.0, 70.0, 73.0], "value": 70.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 56.0, 56.0, 57.0, 59.0, 56.0, 57.0, 56.0, 56.0], "value": 56.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 84.0, 86.0, 83.0, 83.0, 91.0, 92.0, 84.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 132.0, 133.0, 138.0, 145.0, 146.0, 138.0, 142.0, 187.0, 137.0], "value": 143.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 195.0, 197.0, 197.0, 186.0, 193.0, 193.0, 192.0, 193.0, 196.0], "value": 193.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 74.0, 72.0, 72.0, 73.0, 71.0, 71.0, 71.0, 71.0, 76.0], "value": 72.2, "unit": "score"}]}]} 08:39:22 INFO - Return code: 0 08:39:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:39:22 ERROR - # TBPL SUCCESS # 08:39:22 INFO - Running post-action listener: _resource_record_post_action 08:39:22 INFO - [mozharness: 2017-03-22 15:39:22.543089Z] Finished run-tests step (success) 08:39:22 INFO - Running post-run listener: _resource_record_post_run 08:39:22 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 8192; Write bytes: 363954176; Read time: 244; Write time: 247100 08:39:22 INFO - TinderboxPrint: CPU usage
13.3% 08:39:22 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 244 08:39:22 INFO - TinderboxPrint: I/O write bytes / time
363,954,176 / 247,100 08:39:22 INFO - TinderboxPrint: CPU idle
8,317.0 (86.7%) 08:39:22 INFO - TinderboxPrint: CPU user
1,218.5 (12.7%) 08:39:22 INFO - TinderboxPrint: Swap in / out
0 / 0 08:39:22 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 105152512; Read time: 0; Write time: 76572 08:39:22 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 8192; Write bytes: 258801664; Read time: 244; Write time: 170528 08:39:23 INFO - Running post-run listener: _upload_blobber_files 08:39:23 INFO - Blob upload gear active. 08:39:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:39:23 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:39:23 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'] 08:39:23 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 08:39:23 INFO - (blobuploader) - INFO - Open directory for files ... 08:39:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:39:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:39:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:39:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:39:24 INFO - (blobuploader) - INFO - Done attempting. 08:39:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:39:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:39:25 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:39:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:39:25 INFO - (blobuploader) - INFO - Done attempting. 08:39:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:39:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:39:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:39:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:39:26 INFO - (blobuploader) - INFO - Done attempting. 08:39:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:39:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:39:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:39:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:39:30 INFO - (blobuploader) - INFO - Done attempting. 08:39:30 INFO - (blobuploader) - INFO - Iteration through files over. 08:39:30 INFO - Return code: 0 08:39:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:39:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:39:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f1d9a9ec93401f6039404982bc9da6e2aec6b01340def7c1eb6f135e8145d96358991ed741868f965349efd4e52b47f9482b474e291dcc722aae1f46323d260", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cff674bef674933a5ed63bd752840d8edf9dd7ea62cc3aae51575369f0eab7c7d01e4300030ad2113f8f46ee8fa15b9115f80f10bafb39225c40014623245042", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0ce82da4c24585c47e0039f5c3cc0fdba9f148b70caa9bb7e3aae7b475864d422857eead692c5842b8514222868ae93706e1451233ec138149c3891f711000d2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7af94b7ed9d11abdac8b9355eeef3d395e1ac339e334756e83c84ad339e5a535de629ac0dc8f74c4289648389364879a0dd9050de10c6e2cdeda6d1b24f9dc64"} 08:39:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:39:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:39:30 INFO - Contents: 08:39:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f1d9a9ec93401f6039404982bc9da6e2aec6b01340def7c1eb6f135e8145d96358991ed741868f965349efd4e52b47f9482b474e291dcc722aae1f46323d260", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cff674bef674933a5ed63bd752840d8edf9dd7ea62cc3aae51575369f0eab7c7d01e4300030ad2113f8f46ee8fa15b9115f80f10bafb39225c40014623245042", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0ce82da4c24585c47e0039f5c3cc0fdba9f148b70caa9bb7e3aae7b475864d422857eead692c5842b8514222868ae93706e1451233ec138149c3891f711000d2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7af94b7ed9d11abdac8b9355eeef3d395e1ac339e334756e83c84ad339e5a535de629ac0dc8f74c4289648389364879a0dd9050de10c6e2cdeda6d1b24f9dc64"} 08:39:30 INFO - Running post-run listener: copy_logs_to_upload_dir 08:39:30 INFO - Copying logs to upload dir... 08:39:30 INFO - mkdir: /builds/slave/test/build/upload/logs 08:39:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.933506 ========= master_lag: -0.23 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-03-22 08:39:29.900759) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-22 08:39:29.904619) ========= 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=652eb03db935cfc1c15ebda0000001ad-1490195320.931823-1506931366 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/3f1d9a9ec93401f6039404982bc9da6e2aec6b01340def7c1eb6f135e8145d96358991ed741868f965349efd4e52b47f9482b474e291dcc722aae1f46323d260", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cff674bef674933a5ed63bd752840d8edf9dd7ea62cc3aae51575369f0eab7c7d01e4300030ad2113f8f46ee8fa15b9115f80f10bafb39225c40014623245042", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0ce82da4c24585c47e0039f5c3cc0fdba9f148b70caa9bb7e3aae7b475864d422857eead692c5842b8514222868ae93706e1451233ec138149c3891f711000d2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7af94b7ed9d11abdac8b9355eeef3d395e1ac339e334756e83c84ad339e5a535de629ac0dc8f74c4289648389364879a0dd9050de10c6e2cdeda6d1b24f9dc64"} build_url:https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011212 build_url: 'https://queue.taskcluster.net/v1/task/NCVlMVCEQb6oMUK_FqfiRg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f1d9a9ec93401f6039404982bc9da6e2aec6b01340def7c1eb6f135e8145d96358991ed741868f965349efd4e52b47f9482b474e291dcc722aae1f46323d260", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cff674bef674933a5ed63bd752840d8edf9dd7ea62cc3aae51575369f0eab7c7d01e4300030ad2113f8f46ee8fa15b9115f80f10bafb39225c40014623245042", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0ce82da4c24585c47e0039f5c3cc0fdba9f148b70caa9bb7e3aae7b475864d422857eead692c5842b8514222868ae93706e1451233ec138149c3891f711000d2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7af94b7ed9d11abdac8b9355eeef3d395e1ac339e334756e83c84ad339e5a535de629ac0dc8f74c4289648389364879a0dd9050de10c6e2cdeda6d1b24f9dc64"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-22 08:39:29.931283) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 08:39:29.931913) ========= 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=652eb03db935cfc1c15ebda0000001ad-1490195320.931823-1506931366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004423 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 08:39:30.013342) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-22 08:39:30.013666) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-22 08:39:30.013988) ========= ========= Total master_lag: -0.08 =========