builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-023 starttime: 1494287111.83 results: success (0) revision: b21b974d60d3075ae24f6fb1bae75d0f122f28fc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-08 16:45:11.826148) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-08 16:45:11.826721) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-08 16:45:11.826993) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-08 16:45:11.861950) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 16:45:11.862243) ========= 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=6d15e502d8e29d5d2676d664000001c3-1494286909.237107-2028962057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-08 16:45:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 87.5M=0s 2017-05-08 16:45:12 (87.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.167545 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 16:45:12.051457) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 16:45:12.051756) ========= 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=6d15e502d8e29d5d2676d664000001c3-1494286909.237107-2028962057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015501 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 16:45:12.101670) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-08 16:45:12.101999) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b21b974d60d3075ae24f6fb1bae75d0f122f28fc --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 b21b974d60d3075ae24f6fb1bae75d0f122f28fc --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=6d15e502d8e29d5d2676d664000001c3-1494286909.237107-2028962057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-08 16:45:12,190 truncating revision to first 12 chars 2017-05-08 16:45:12,190 Setting DEBUG logging. 2017-05-08 16:45:12,190 attempt 1/10 2017-05-08 16:45:12,190 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b21b974d60d3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-08 16:45:12,647 unpacking tar archive at: mozilla-central-b21b974d60d3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.205608 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-08 16:45:13.321843) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-08 16:45:13.322200) ========= script_repo_revision: b21b974d60d3075ae24f6fb1bae75d0f122f28fc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-08 16:45:13.322611) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-08 16:45:13.322900) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-08 16:45:13.334115) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-05-08 16:45:13.334407) ========= /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=6d15e502d8e29d5d2676d664000001c3-1494286909.237107-2028962057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:45:13 INFO - MultiFileLogger online at 20170508 16:45:13 in /builds/slave/test 16:45:13 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 16:45:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:45:13 INFO - {'append_to_log': False, 16:45:13 INFO - 'base_work_dir': '/builds/slave/test', 16:45:13 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:45:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:45:13 INFO - 'branch': 'Firefox-Non-PGO', 16:45:13 INFO - 'buildbot_json_path': 'buildprops.json', 16:45:13 INFO - 'config_files': ('talos/linux_config.py',), 16:45:13 INFO - 'default_actions': ('clobber', 16:45:13 INFO - 'read-buildbot-config', 16:45:13 INFO - 'download-and-extract', 16:45:13 INFO - 'populate-webroot', 16:45:13 INFO - 'create-virtualenv', 16:45:13 INFO - 'install', 16:45:13 INFO - 'run-tests'), 16:45:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:45:13 INFO - 'download_minidump_stackwalk': True, 16:45:13 INFO - 'download_symbols': 'ondemand', 16:45:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:45:13 INFO - 'tooltool.py': '/tools/tooltool.py', 16:45:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:45:13 INFO - '/tools/misc-python/virtualenv.py')}, 16:45:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:45:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:45:13 INFO - 'gecko_profile': False, 16:45:13 INFO - 'gecko_profile_interval': 0, 16:45:13 INFO - 'installer_path': 'installer.exe', 16:45:13 INFO - 'log_level': 'info', 16:45:13 INFO - 'log_name': 'talos', 16:45:13 INFO - 'log_to_console': True, 16:45:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:45:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:45:13 INFO - 'opt_config_files': (), 16:45:13 INFO - 'pip_index': False, 16:45:13 INFO - 'suite': 'dromaeojs-e10s', 16:45:13 INFO - 'system_bits': '32', 16:45:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:45:13 INFO - 'title': 'talos-linux64-ix-023', 16:45:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:45:13 INFO - 'use_talos_json': True, 16:45:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:45:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:45:13 INFO - 'work_dir': 'build'} 16:45:13 INFO - [mozharness: 2017-05-08 23:45:13.597315Z] Running clobber step. 16:45:13 INFO - Running pre-action listener: _resource_record_pre_action 16:45:13 INFO - Running main action method: clobber 16:45:13 INFO - rmtree: /builds/slave/test/build 16:45:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:45:14 INFO - Running post-action listener: _resource_record_post_action 16:45:14 INFO - [mozharness: 2017-05-08 23:45:14.527158Z] Finished clobber step (success) 16:45:14 INFO - [mozharness: 2017-05-08 23:45:14.527257Z] Running read-buildbot-config step. 16:45:14 INFO - Running pre-action listener: _resource_record_pre_action 16:45:14 INFO - Running main action method: read_buildbot_config 16:45:14 INFO - Using buildbot properties: 16:45:14 INFO - { 16:45:14 INFO - "project": "", 16:45:14 INFO - "product": "firefox", 16:45:14 INFO - "who": "kwierso@gmail.com", 16:45:14 INFO - "installer_path": "public/build/target.tar.bz2", 16:45:14 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:45:14 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 16:45:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 16:45:14 INFO - "stage_platform": "linux64", 16:45:14 INFO - "basedir": "/builds/slave/test", 16:45:14 INFO - "buildnumber": 860, 16:45:14 INFO - "platform": "ubuntu64_hw", 16:45:14 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:45:14 INFO - "slavebuilddir": "test", 16:45:14 INFO - "taskId": "aVXVnaoFQvOustyGaRp4zw", 16:45:14 INFO - "branch": "mozilla-central", 16:45:14 INFO - "script_repo_revision": "production", 16:45:14 INFO - "revision": "b21b974d60d3075ae24f6fb1bae75d0f122f28fc", 16:45:14 INFO - "slavename": "talos-linux64-ix-023", 16:45:14 INFO - "repo_path": "mozilla-central" 16:45:14 INFO - } 16:45:14 INFO - Finding installer, test and symbols from parent task. 16:45:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aVXVnaoFQvOustyGaRp4zw'}, attempt #1 16:45:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aVXVnaoFQvOustyGaRp4zw'}, attempt #1 16:45:15 INFO - Task dependencies: YB2o5iqdTgO8iKyjTRdTyA 16:45:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YB2o5iqdTgO8iKyjTRdTyA'}, attempt #1 16:45:15 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/YB2o5iqdTgO8iKyjTRdTyA/artifacts/public/build/target.tar.bz2 16:45:15 INFO - Set test_url: https://queue.taskcluster.net/v1/task/YB2o5iqdTgO8iKyjTRdTyA/artifacts/public/build/test_packages.json 16:45:15 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/YB2o5iqdTgO8iKyjTRdTyA/artifacts/public/build/target.crashreporter-symbols.zip 16:45:15 INFO - Running post-action listener: _resource_record_post_action 16:45:15 INFO - [mozharness: 2017-05-08 23:45:15.922943Z] Finished read-buildbot-config step (success) 16:45:15 INFO - [mozharness: 2017-05-08 23:45:15.923159Z] Running download-and-extract step. 16:45:15 INFO - Running pre-action listener: _resource_record_pre_action 16:45:15 INFO - Running main action method: download_and_extract 16:45:15 INFO - mkdir: /builds/slave/test/build/tests 16:45: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')]} 16:45:15 INFO - trying https://queue.taskcluster.net/v1/task/YB2o5iqdTgO8iKyjTRdTyA/artifacts/public/build/target.test_packages.json 16:45:15 INFO - Downloading https://queue.taskcluster.net/v1/task/YB2o5iqdTgO8iKyjTRdTyA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:45:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YB2o5iqdTgO8iKyjTRdTyA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:45:16 INFO - Downloaded 986 bytes. 16:45:16 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:45:16 INFO - Using the following test package requirements: 16:45:16 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:45:16 INFO - u'common': [u'target.common.tests.zip'], 16:45:16 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:45:16 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:45:16 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:45:16 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:45:16 INFO - u'mozbase': [u'target.common.tests.zip'], 16:45:16 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:45:16 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:45:16 INFO - u'web-platform': [u'target.common.tests.zip', 16:45:16 INFO - u'target.web-platform.tests.zip'], 16:45:16 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:45:16 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:45:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YB2o5iqdTgO8iKyjTRdTyA/artifacts/public/build/target.common.tests.zip 16:45:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YB2o5iqdTgO8iKyjTRdTyA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:45:16 INFO - Fetch https://queue.taskcluster.net/v1/task/YB2o5iqdTgO8iKyjTRdTyA/artifacts/public/build/target.common.tests.zip into memory 16:45:18 INFO - Content-Length response header: 58448122 16:45:18 INFO - Bytes received: 58448122 16:45:28 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:45:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YB2o5iqdTgO8iKyjTRdTyA/artifacts/public/build/target.common.tests.zip 16:45:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YB2o5iqdTgO8iKyjTRdTyA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:45:28 INFO - Fetch https://queue.taskcluster.net/v1/task/YB2o5iqdTgO8iKyjTRdTyA/artifacts/public/build/target.common.tests.zip into memory 16:45:30 INFO - Content-Length response header: 58448122 16:45:30 INFO - Bytes received: 58448122 16:45:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YB2o5iqdTgO8iKyjTRdTyA/artifacts/public/build/target.talos.tests.zip 16:45:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YB2o5iqdTgO8iKyjTRdTyA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:45:41 INFO - Fetch https://queue.taskcluster.net/v1/task/YB2o5iqdTgO8iKyjTRdTyA/artifacts/public/build/target.talos.tests.zip into memory 16:45:41 INFO - Content-Length response header: 14409362 16:45:41 INFO - Bytes received: 14409362 16:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:45:42 INFO - trying https://queue.taskcluster.net/v1/task/YB2o5iqdTgO8iKyjTRdTyA/artifacts/public/build/target.tar.bz2 16:45:42 INFO - Downloading https://queue.taskcluster.net/v1/task/YB2o5iqdTgO8iKyjTRdTyA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:45:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YB2o5iqdTgO8iKyjTRdTyA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:45:45 INFO - Downloaded 58133052 bytes. 16:45:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YB2o5iqdTgO8iKyjTRdTyA/artifacts/public/build/target.tar.bz2 16:45:45 INFO - mkdir: /builds/slave/test/properties 16:45:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:45:45 INFO - Writing to file /builds/slave/test/properties/build_url 16:45:45 INFO - Contents: 16:45:45 INFO - build_url:https://queue.taskcluster.net/v1/task/YB2o5iqdTgO8iKyjTRdTyA/artifacts/public/build/target.tar.bz2 16:45:45 INFO - Running post-action listener: _resource_record_post_action 16:45:45 INFO - Running post-action listener: set_extra_try_arguments 16:45:45 INFO - [mozharness: 2017-05-08 23:45:45.024519Z] Finished download-and-extract step (success) 16:45:45 INFO - [mozharness: 2017-05-08 23:45:45.024616Z] Running populate-webroot step. 16:45:45 INFO - Running pre-action listener: _resource_record_pre_action 16:45:45 INFO - Running main action method: populate_webroot 16:45:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:45:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:45:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:45:45 INFO - '--tppagecycles', 16:45:45 INFO - '7'], 16:45:45 INFO - 'tests': ['tsvgm']}}, 16:45:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:45:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:45:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:45:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:45:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:45:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:45:45 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:45:45 INFO - 'talos_options': ['--disable-e10s'], 16:45:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:45:45 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:45:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:45:45 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:45:45 INFO - 'talos_options': ['--disable-e10s'], 16:45:45 INFO - 'tests': ['damp', 'tps']}, 16:45:45 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:45:45 INFO - 'tests': ['damp', 'tps']}, 16:45:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:45:45 INFO - 'tests': ['dromaeo_dom']}, 16:45:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:45:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:45:45 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 16:45:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:45:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:45:45 INFO - 'tests': ['a11yr', 16:45:45 INFO - 'ts_paint', 16:45:45 INFO - 'tpaint', 16:45:45 INFO - 'sessionrestore', 16:45:45 INFO - 'sessionrestore_no_auto_restore', 16:45:45 INFO - 'tabpaint']}, 16:45:45 INFO - 'other-e10s': {'tests': ['a11yr', 16:45:45 INFO - 'ts_paint', 16:45:45 INFO - 'tpaint', 16:45:45 INFO - 'sessionrestore', 16:45:45 INFO - 'sessionrestore_no_auto_restore', 16:45:45 INFO - 'tabpaint']}, 16:45:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:45:45 INFO - 'ts_paint', 16:45:45 INFO - 'tpaint', 16:45:45 INFO - 'sessionrestore', 16:45:45 INFO - 'sessionrestore_no_auto_restore', 16:45:45 INFO - 'tabpaint']}, 16:45:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:45:45 INFO - 'ts_paint', 16:45:45 INFO - 'tpaint', 16:45:45 INFO - 'sessionrestore', 16:45:45 INFO - 'sessionrestore_no_auto_restore', 16:45:45 INFO - 'tabpaint']}, 16:45:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:45:45 INFO - 'tests': ['a11yr', 16:45:45 INFO - 'ts_paint', 16:45:45 INFO - 'tpaint', 16:45:45 INFO - 'sessionrestore', 16:45:45 INFO - 'sessionrestore_no_auto_restore', 16:45:45 INFO - 'tabpaint']}, 16:45:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:45:45 INFO - 'tests': ['a11yr', 16:45:45 INFO - 'ts_paint', 16:45:45 INFO - 'tpaint', 16:45:45 INFO - 'sessionrestore', 16:45:45 INFO - 'sessionrestore_no_auto_restore', 16:45:45 INFO - 'tabpaint']}, 16:45:45 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 16:45:45 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 16:45:45 INFO - 'bloom_basic_ref']}, 16:45:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:45:45 INFO - 'tests': ['tsvgx', 16:45:45 INFO - 'tsvgr_opacity', 16:45:45 INFO - 'tart', 16:45:45 INFO - 'tscrollx', 16:45:45 INFO - 'cart', 16:45:45 INFO - 'tsvg_static']}, 16:45:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:45:45 INFO - 'tsvgr_opacity', 16:45:45 INFO - 'tart', 16:45:45 INFO - 'tscrollx', 16:45:45 INFO - 'cart', 16:45:45 INFO - 'tsvg_static']}, 16:45:45 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:45:45 INFO - 'talos_options': ['--disable-e10s'], 16:45:45 INFO - 'tests': ['tp5o']}, 16:45:45 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:45:45 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:45:45 INFO - 'talos_options': ['--disable-e10s', 16:45:45 INFO - '--xperf_path', 16:45:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:45:45 INFO - 'tests': ['tp5n']}, 16:45:45 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:45:45 INFO - 'talos_options': ['--xperf_path', 16:45:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:45:45 INFO - 'tests': ['tp5n']}}, 16:45:45 INFO - 'talos.zip': {'path': '', 16:45:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:45:45 INFO - Running post-action listener: _resource_record_post_action 16:45:45 INFO - [mozharness: 2017-05-08 23:45:45.040126Z] Finished populate-webroot step (success) 16:45:45 INFO - [mozharness: 2017-05-08 23:45:45.040214Z] Running create-virtualenv step. 16:45:45 INFO - Running pre-action listener: _resource_record_pre_action 16:45:45 INFO - Running main action method: create_virtualenv 16:45:45 INFO - Creating virtualenv /builds/slave/test/build/venv 16:45:45 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 16:45:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:45:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:45:45 INFO - Using real prefix '/usr' 16:45:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:45:45 INFO - Installing distribute.............................................................................................................................................................................................done. 16:45:47 INFO - Installing pip.................done. 16:45:47 INFO - Return code: 0 16:45:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:45:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:45:48 INFO - Reading from file tmpfile_stdout 16:45:48 INFO - Output received: 16:45:48 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) 16:45:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:45:48 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')]} 16:45:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:48 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')]} 16:45:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:48 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 0x1e531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c2a30>, '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 0x21c37f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c3ca0>, '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': '6d15e502d8e29d5d2676d664000001c3-1494286909.237107-2028962057', '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 16:45:48 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 16:45:48 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 16:45:48 INFO - Using env: {'DISPLAY': ':0', 16:45:48 INFO - 'HOME': '/home/cltbld', 16:45:48 INFO - 'LANG': 'en_US.UTF-8', 16:45:48 INFO - 'LANGUAGE': 'en_US:en', 16:45:48 INFO - 'LOGNAME': 'cltbld', 16:45:48 INFO - 'MAIL': '/var/mail/cltbld', 16:45:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:48 INFO - 'MOZ_NO_REMOTE': '1', 16:45:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:48 INFO - 'NO_EM_RESTART': '1', 16:45:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:48 INFO - 'PWD': '/builds/slave/test', 16:45:48 INFO - 'SHELL': '/bin/bash', 16:45:48 INFO - 'SHLVL': '1', 16:45:48 INFO - 'TERM': 'linux', 16:45:48 INFO - 'TMOUT': '86400', 16:45:48 INFO - 'USER': 'cltbld', 16:45:48 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1494286909.237107-2028962057', 16:45:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:48 INFO - '_': '/tools/buildbot/bin/python'} 16:45:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:48 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 16:45:48 INFO - Cleaning up... 16:45:48 INFO - Return code: 0 16:45:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:45:48 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')]} 16:45:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:48 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')]} 16:45:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:48 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 0x1e531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c2a30>, '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 0x21c37f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c3ca0>, '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': '6d15e502d8e29d5d2676d664000001c3-1494286909.237107-2028962057', '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 16:45:48 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 16:45:48 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 16:45:48 INFO - Using env: {'DISPLAY': ':0', 16:45:48 INFO - 'HOME': '/home/cltbld', 16:45:48 INFO - 'LANG': 'en_US.UTF-8', 16:45:48 INFO - 'LANGUAGE': 'en_US:en', 16:45:48 INFO - 'LOGNAME': 'cltbld', 16:45:48 INFO - 'MAIL': '/var/mail/cltbld', 16:45:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:48 INFO - 'MOZ_NO_REMOTE': '1', 16:45:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:48 INFO - 'NO_EM_RESTART': '1', 16:45:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:48 INFO - 'PWD': '/builds/slave/test', 16:45:48 INFO - 'SHELL': '/bin/bash', 16:45:48 INFO - 'SHLVL': '1', 16:45:48 INFO - 'TERM': 'linux', 16:45:48 INFO - 'TMOUT': '86400', 16:45:48 INFO - 'USER': 'cltbld', 16:45:48 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1494286909.237107-2028962057', 16:45:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:48 INFO - '_': '/tools/buildbot/bin/python'} 16:45:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:48 INFO - Downloading/unpacking psutil>=3.1.1 16:45:48 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 16:45:48 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 16:45:48 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 16:45:48 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 16:45:48 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 16:45:48 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 16:45:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:45:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:45:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:45:49 INFO - Installing collected packages: psutil 16:45:49 INFO - Running setup.py install for psutil 16:45:49 INFO - building 'psutil._psutil_linux' extension 16:45:49 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 16:45:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:45:50 INFO - building 'psutil._psutil_posix' extension 16:45:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:45:51 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 16:45:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:45:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:45:51 INFO - Successfully installed psutil 16:45:51 INFO - Cleaning up... 16:45:51 INFO - Return code: 0 16:45:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:45:51 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')]} 16:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:51 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')]} 16:45:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:51 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 0x1e531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c2a30>, '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 0x21c37f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c3ca0>, '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': '6d15e502d8e29d5d2676d664000001c3-1494286909.237107-2028962057', '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 16:45:51 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 16:45:51 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 16:45:51 INFO - Using env: {'DISPLAY': ':0', 16:45:51 INFO - 'HOME': '/home/cltbld', 16:45:51 INFO - 'LANG': 'en_US.UTF-8', 16:45:51 INFO - 'LANGUAGE': 'en_US:en', 16:45:51 INFO - 'LOGNAME': 'cltbld', 16:45:51 INFO - 'MAIL': '/var/mail/cltbld', 16:45:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:51 INFO - 'MOZ_NO_REMOTE': '1', 16:45:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:51 INFO - 'NO_EM_RESTART': '1', 16:45:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:51 INFO - 'PWD': '/builds/slave/test', 16:45:51 INFO - 'SHELL': '/bin/bash', 16:45:51 INFO - 'SHLVL': '1', 16:45:51 INFO - 'TERM': 'linux', 16:45:51 INFO - 'TMOUT': '86400', 16:45:51 INFO - 'USER': 'cltbld', 16:45:51 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1494286909.237107-2028962057', 16:45:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:51 INFO - '_': '/tools/buildbot/bin/python'} 16:45:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:45:51 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 16:45:51 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 16:45:51 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 16:45:51 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 16:45:51 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 16:45:51 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 16:45:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:45:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:45:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:45:52 INFO - Installing collected packages: mozsystemmonitor 16:45:52 INFO - Running setup.py install for mozsystemmonitor 16:45:52 INFO - Successfully installed mozsystemmonitor 16:45:52 INFO - Cleaning up... 16:45:52 INFO - Return code: 0 16:45:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:45:52 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')]} 16:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:52 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')]} 16:45:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:52 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 0x1e531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c2a30>, '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 0x21c37f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c3ca0>, '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': '6d15e502d8e29d5d2676d664000001c3-1494286909.237107-2028962057', '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 16:45:52 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 16:45:52 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 16:45:52 INFO - Using env: {'DISPLAY': ':0', 16:45:52 INFO - 'HOME': '/home/cltbld', 16:45:52 INFO - 'LANG': 'en_US.UTF-8', 16:45:52 INFO - 'LANGUAGE': 'en_US:en', 16:45:52 INFO - 'LOGNAME': 'cltbld', 16:45:52 INFO - 'MAIL': '/var/mail/cltbld', 16:45:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:52 INFO - 'MOZ_NO_REMOTE': '1', 16:45:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:52 INFO - 'NO_EM_RESTART': '1', 16:45:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:52 INFO - 'PWD': '/builds/slave/test', 16:45:52 INFO - 'SHELL': '/bin/bash', 16:45:52 INFO - 'SHLVL': '1', 16:45:52 INFO - 'TERM': 'linux', 16:45:52 INFO - 'TMOUT': '86400', 16:45:52 INFO - 'USER': 'cltbld', 16:45:52 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1494286909.237107-2028962057', 16:45:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:52 INFO - '_': '/tools/buildbot/bin/python'} 16:45:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:53 INFO - Downloading/unpacking jsonschema==2.5.1 16:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:45:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:45:54 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 16:45:54 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 16:45:54 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 16:45:54 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 16:45:54 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 16:45:54 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 16:45:54 INFO - Downloading functools32-3.2.3-2.tar.gz 16:45:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:45:54 INFO - warning: no files found matching '*.txt' 16:45:54 INFO - no previously-included directories found matching 'build' 16:45:54 INFO - no previously-included directories found matching 'dist' 16:45:54 INFO - no previously-included directories found matching '.git*' 16:45:54 INFO - Installing collected packages: jsonschema, functools32 16:45:54 INFO - Running setup.py install for functools32 16:45:54 INFO - warning: no files found matching '*.txt' 16:45:54 INFO - no previously-included directories found matching 'build' 16:45:54 INFO - no previously-included directories found matching 'dist' 16:45:54 INFO - no previously-included directories found matching '.git*' 16:45:54 INFO - Successfully installed jsonschema functools32 16:45:54 INFO - Cleaning up... 16:45:54 INFO - Return code: 0 16:45:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:45:54 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')]} 16:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:54 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')]} 16:45:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:54 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 0x1e531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c2a30>, '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 0x21c37f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c3ca0>, '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': '6d15e502d8e29d5d2676d664000001c3-1494286909.237107-2028962057', '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 16:45:54 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 16:45:54 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 16:45:54 INFO - Using env: {'DISPLAY': ':0', 16:45:54 INFO - 'HOME': '/home/cltbld', 16:45:54 INFO - 'LANG': 'en_US.UTF-8', 16:45:54 INFO - 'LANGUAGE': 'en_US:en', 16:45:54 INFO - 'LOGNAME': 'cltbld', 16:45:54 INFO - 'MAIL': '/var/mail/cltbld', 16:45:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:54 INFO - 'MOZ_NO_REMOTE': '1', 16:45:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:54 INFO - 'NO_EM_RESTART': '1', 16:45:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:54 INFO - 'PWD': '/builds/slave/test', 16:45:54 INFO - 'SHELL': '/bin/bash', 16:45:54 INFO - 'SHLVL': '1', 16:45:54 INFO - 'TERM': 'linux', 16:45:54 INFO - 'TMOUT': '86400', 16:45:54 INFO - 'USER': 'cltbld', 16:45:54 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1494286909.237107-2028962057', 16:45:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:54 INFO - '_': '/tools/buildbot/bin/python'} 16:45:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:45:54 INFO - Cleaning up... 16:45:54 INFO - Return code: 0 16:45:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:45:54 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')]} 16:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:54 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')]} 16:45:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:54 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 0x1e531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c2a30>, '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 0x21c37f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c3ca0>, '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': '6d15e502d8e29d5d2676d664000001c3-1494286909.237107-2028962057', '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 16:45:54 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 16:45:54 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 16:45:54 INFO - Using env: {'DISPLAY': ':0', 16:45:54 INFO - 'HOME': '/home/cltbld', 16:45:54 INFO - 'LANG': 'en_US.UTF-8', 16:45:54 INFO - 'LANGUAGE': 'en_US:en', 16:45:54 INFO - 'LOGNAME': 'cltbld', 16:45:54 INFO - 'MAIL': '/var/mail/cltbld', 16:45:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:54 INFO - 'MOZ_NO_REMOTE': '1', 16:45:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:54 INFO - 'NO_EM_RESTART': '1', 16:45:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:54 INFO - 'PWD': '/builds/slave/test', 16:45:54 INFO - 'SHELL': '/bin/bash', 16:45:54 INFO - 'SHLVL': '1', 16:45:54 INFO - 'TERM': 'linux', 16:45:54 INFO - 'TMOUT': '86400', 16:45:54 INFO - 'USER': 'cltbld', 16:45:54 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1494286909.237107-2028962057', 16:45:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:54 INFO - '_': '/tools/buildbot/bin/python'} 16:45:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:55 INFO - Downloading/unpacking blobuploader==1.2.4 16:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:56 INFO - Downloading blobuploader-1.2.4.tar.gz 16:45:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:45:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:45:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:56 INFO - Downloading docopt-0.6.1.tar.gz 16:45:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:45:56 INFO - Installing collected packages: blobuploader, requests, docopt 16:45:56 INFO - Running setup.py install for blobuploader 16:45:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:45:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:45:57 INFO - Running setup.py install for requests 16:45:57 INFO - Running setup.py install for docopt 16:45:57 INFO - Successfully installed blobuploader requests docopt 16:45:57 INFO - Cleaning up... 16:45:57 INFO - Return code: 0 16:45:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:45:57 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')]} 16:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:57 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')]} 16:45:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:57 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 0x1e531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c2a30>, '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 0x21c37f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c3ca0>, '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': '6d15e502d8e29d5d2676d664000001c3-1494286909.237107-2028962057', '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 16:45:57 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 16:45:57 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 16:45:57 INFO - Using env: {'DISPLAY': ':0', 16:45:57 INFO - 'HOME': '/home/cltbld', 16:45:57 INFO - 'LANG': 'en_US.UTF-8', 16:45:57 INFO - 'LANGUAGE': 'en_US:en', 16:45:57 INFO - 'LOGNAME': 'cltbld', 16:45:57 INFO - 'MAIL': '/var/mail/cltbld', 16:45:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:57 INFO - 'MOZ_NO_REMOTE': '1', 16:45:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:57 INFO - 'NO_EM_RESTART': '1', 16:45:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:57 INFO - 'PWD': '/builds/slave/test', 16:45:57 INFO - 'SHELL': '/bin/bash', 16:45:57 INFO - 'SHLVL': '1', 16:45:57 INFO - 'TERM': 'linux', 16:45:57 INFO - 'TMOUT': '86400', 16:45:57 INFO - 'USER': 'cltbld', 16:45:57 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1494286909.237107-2028962057', 16:45:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:57 INFO - '_': '/tools/buildbot/bin/python'} 16:45:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:45:57 INFO - Running setup.py (path:/tmp/pip-WDZBST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:45:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:45:57 INFO - Running setup.py (path:/tmp/pip-DAwv5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:45:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:45:57 INFO - Running setup.py (path:/tmp/pip-AmDgrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:45:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:45:57 INFO - Running setup.py (path:/tmp/pip-WzJUDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:45:58 INFO - Running setup.py (path:/tmp/pip-s782R_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:45:58 INFO - Running setup.py (path:/tmp/pip-xG5DmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:45:58 INFO - Running setup.py (path:/tmp/pip-iNHKOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:45:58 INFO - Running setup.py (path:/tmp/pip-Zmvj6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:45:58 INFO - Running setup.py (path:/tmp/pip-0Ih9Lh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:45:58 INFO - Running setup.py (path:/tmp/pip-V1NY5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:45:58 INFO - Running setup.py (path:/tmp/pip-VVae5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:45:58 INFO - Running setup.py (path:/tmp/pip-qChgVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:45:58 INFO - Running setup.py (path:/tmp/pip-XJr1rT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:45:58 INFO - Running setup.py (path:/tmp/pip-iOylGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:45:58 INFO - Running setup.py (path:/tmp/pip-f3jaSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:45:58 INFO - Running setup.py (path:/tmp/pip-zmFvlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:45:58 INFO - Running setup.py (path:/tmp/pip-hiuYIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:45:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:45:58 INFO - Running setup.py install for manifestparser 16:45:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:45:59 INFO - Running setup.py install for mozcrash 16:45:59 INFO - Running setup.py install for mozdebug 16:45:59 INFO - Running setup.py install for mozdevice 16:45:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:45:59 INFO - Running setup.py install for mozfile 16:45:59 INFO - Running setup.py install for mozhttpd 16:45:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:45:59 INFO - Running setup.py install for mozinfo 16:45:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:45:59 INFO - Running setup.py install for mozInstall 16:45:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:45:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:45:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:45:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:45:59 INFO - Running setup.py install for mozleak 16:45:59 INFO - Running setup.py install for mozlog 16:45:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:46:00 INFO - Running setup.py install for moznetwork 16:46:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:46:00 INFO - Running setup.py install for mozprocess 16:46:00 INFO - Running setup.py install for mozprofile 16:46:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:46:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:46:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:46:00 INFO - Running setup.py install for mozrunner 16:46:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:46:00 INFO - Running setup.py install for mozscreenshot 16:46:00 INFO - Running setup.py install for moztest 16:46:00 INFO - Running setup.py install for mozversion 16:46:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:46:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:46:00 INFO - Cleaning up... 16:46:00 INFO - Return code: 0 16:46:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:46: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')]} 16:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:46:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46: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')]} 16:46:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:46:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:00 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 0x1e531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c2a30>, '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 0x21c37f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c3ca0>, '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': '6d15e502d8e29d5d2676d664000001c3-1494286909.237107-2028962057', '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 16:46:00 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 16:46:00 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 16:46:00 INFO - Using env: {'DISPLAY': ':0', 16:46:00 INFO - 'HOME': '/home/cltbld', 16:46:00 INFO - 'LANG': 'en_US.UTF-8', 16:46:00 INFO - 'LANGUAGE': 'en_US:en', 16:46:00 INFO - 'LOGNAME': 'cltbld', 16:46:00 INFO - 'MAIL': '/var/mail/cltbld', 16:46:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:46:00 INFO - 'MOZ_NO_REMOTE': '1', 16:46:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:46:00 INFO - 'NO_EM_RESTART': '1', 16:46:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:46:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:46:00 INFO - 'PWD': '/builds/slave/test', 16:46:00 INFO - 'SHELL': '/bin/bash', 16:46:00 INFO - 'SHLVL': '1', 16:46:00 INFO - 'TERM': 'linux', 16:46:00 INFO - 'TMOUT': '86400', 16:46:00 INFO - 'USER': 'cltbld', 16:46:00 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1494286909.237107-2028962057', 16:46:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:46:00 INFO - '_': '/tools/buildbot/bin/python'} 16:46:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:46:01 INFO - Running setup.py (path:/tmp/pip-HqeANN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:46:01 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)) 16:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:46:01 INFO - Running setup.py (path:/tmp/pip-m5okmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:46:01 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)) 16:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:46:01 INFO - Running setup.py (path:/tmp/pip-FUJLaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:46:01 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)) 16:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:46:01 INFO - Running setup.py (path:/tmp/pip-k66sE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:46:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:46:01 INFO - Running setup.py (path:/tmp/pip-j3Blnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:46:01 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)) 16:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:46:01 INFO - Running setup.py (path:/tmp/pip-1S1ig5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:46:01 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)) 16:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:46:01 INFO - Running setup.py (path:/tmp/pip-WYGcqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:46:01 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)) 16:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:46:01 INFO - Running setup.py (path:/tmp/pip-g1QYdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:46:01 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)) 16:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:46:01 INFO - Running setup.py (path:/tmp/pip-fjXLFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:46:01 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)) 16:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:46:01 INFO - Running setup.py (path:/tmp/pip-PZXMy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:46:01 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)) 16:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:46:01 INFO - Running setup.py (path:/tmp/pip-N7xMZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:46:01 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)) 16:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:46:01 INFO - Running setup.py (path:/tmp/pip-SCsDz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:46:01 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)) 16:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:46:01 INFO - Running setup.py (path:/tmp/pip-c7IGYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:46:01 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)) 16:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:46:01 INFO - Running setup.py (path:/tmp/pip-Lina5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:46:02 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)) 16:46:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:46:02 INFO - Running setup.py (path:/tmp/pip-55SYpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:46:02 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)) 16:46:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:46:02 INFO - Running setup.py (path:/tmp/pip-HMiDAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:46:02 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)) 16:46:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:46:02 INFO - Running setup.py (path:/tmp/pip-90Z9jO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:46:02 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)) 16:46:02 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)) 16:46:02 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)) 16:46:02 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)) 16:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:46:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:46:02 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 16:46:02 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 16:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:46:04 INFO - Downloading blessings-1.6.tar.gz 16:46:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:46:04 INFO - Installing collected packages: blessings 16:46:04 INFO - Running setup.py install for blessings 16:46:04 INFO - Successfully installed blessings 16:46:04 INFO - Cleaning up... 16:46:04 INFO - Return code: 0 16:46:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:46:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:46:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:46:04 INFO - Reading from file tmpfile_stdout 16:46:04 INFO - Current package versions: 16:46:04 INFO - argparse == 1.2.1 16:46:04 INFO - blessings == 1.6 16:46:04 INFO - blobuploader == 1.2.4 16:46:04 INFO - docopt == 0.6.1 16:46:04 INFO - functools32 == 3.2.3-2 16:46:04 INFO - jsonschema == 2.5.1 16:46:04 INFO - manifestparser == 1.1 16:46:04 INFO - mozInstall == 1.12 16:46:04 INFO - mozcrash == 1.0 16:46:04 INFO - mozdebug == 0.1 16:46:04 INFO - mozdevice == 0.50 16:46:04 INFO - mozfile == 1.2 16:46:04 INFO - mozhttpd == 0.7 16:46:04 INFO - mozinfo == 0.9 16:46:04 INFO - mozleak == 0.1 16:46:04 INFO - mozlog == 3.4 16:46:04 INFO - moznetwork == 0.27 16:46:04 INFO - mozprocess == 0.25 16:46:04 INFO - mozprofile == 0.28 16:46:04 INFO - mozrunner == 6.13 16:46:04 INFO - mozscreenshot == 0.1 16:46:04 INFO - mozsystemmonitor == 0.3 16:46:04 INFO - moztest == 0.8 16:46:04 INFO - mozversion == 1.4 16:46:04 INFO - psutil == 3.1.1 16:46:04 INFO - requests == 1.2.3 16:46:04 INFO - wsgiref == 0.1.2 16:46:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:46:04 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')]} 16:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:46:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:04 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')]} 16:46:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:46:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:04 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 0x1e531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c2a30>, '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 0x21c37f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c3ca0>, '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': '6d15e502d8e29d5d2676d664000001c3-1494286909.237107-2028962057', '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 16:46:04 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 16:46:04 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 16:46:04 INFO - Using env: {'DISPLAY': ':0', 16:46:04 INFO - 'HOME': '/home/cltbld', 16:46:04 INFO - 'LANG': 'en_US.UTF-8', 16:46:04 INFO - 'LANGUAGE': 'en_US:en', 16:46:04 INFO - 'LOGNAME': 'cltbld', 16:46:04 INFO - 'MAIL': '/var/mail/cltbld', 16:46:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:46:04 INFO - 'MOZ_NO_REMOTE': '1', 16:46:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:46:04 INFO - 'NO_EM_RESTART': '1', 16:46:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:46:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:46:04 INFO - 'PWD': '/builds/slave/test', 16:46:04 INFO - 'SHELL': '/bin/bash', 16:46:04 INFO - 'SHLVL': '1', 16:46:04 INFO - 'TERM': 'linux', 16:46:04 INFO - 'TMOUT': '86400', 16:46:04 INFO - 'USER': 'cltbld', 16:46:04 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1494286909.237107-2028962057', 16:46:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:46:04 INFO - '_': '/tools/buildbot/bin/python'} 16:46:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:46:05 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)) 16:46:05 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)) 16:46:05 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)) 16:46:05 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)) 16:46:05 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)) 16:46:05 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)) 16:46:05 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)) 16:46:05 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)) 16:46:05 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)) 16:46:05 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)) 16:46:05 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)) 16:46:05 INFO - Cleaning up... 16:46:05 INFO - Return code: 0 16:46:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:46: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')]} 16:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:46:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46: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')]} 16:46:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:46:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c2a30>, '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 0x21c37f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c3ca0>, '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': '6d15e502d8e29d5d2676d664000001c3-1494286909.237107-2028962057', '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 16:46: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'] in /builds/slave/test/build 16:46: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 16:46:05 INFO - Using env: {'DISPLAY': ':0', 16:46:05 INFO - 'HOME': '/home/cltbld', 16:46:05 INFO - 'LANG': 'en_US.UTF-8', 16:46:05 INFO - 'LANGUAGE': 'en_US:en', 16:46:05 INFO - 'LOGNAME': 'cltbld', 16:46:05 INFO - 'MAIL': '/var/mail/cltbld', 16:46:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:46:05 INFO - 'MOZ_NO_REMOTE': '1', 16:46:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:46:05 INFO - 'NO_EM_RESTART': '1', 16:46:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:46:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:46:05 INFO - 'PWD': '/builds/slave/test', 16:46:05 INFO - 'SHELL': '/bin/bash', 16:46:05 INFO - 'SHLVL': '1', 16:46:05 INFO - 'TERM': 'linux', 16:46:05 INFO - 'TMOUT': '86400', 16:46:05 INFO - 'USER': 'cltbld', 16:46:05 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1494286909.237107-2028962057', 16:46:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:46:05 INFO - '_': '/tools/buildbot/bin/python'} 16:46:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:46:05 INFO - Cleaning up... 16:46:05 INFO - Return code: 0 16:46:05 INFO - Running post-action listener: _resource_record_post_action 16:46:05 INFO - Running post-action listener: _start_resource_monitoring 16:46:05 INFO - Starting resource monitoring. 16:46:05 INFO - [mozharness: 2017-05-08 23:46:05.345376Z] Finished create-virtualenv step (success) 16:46:05 INFO - [mozharness: 2017-05-08 23:46:05.346370Z] Running install step. 16:46:05 INFO - Running pre-action listener: _resource_record_pre_action 16:46:05 INFO - Running main action method: install 16:46:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:46:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:46:05 INFO - Reading from file tmpfile_stdout 16:46:05 INFO - Detecting whether we're running mozinstall >=1.0... 16:46:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:46:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:46:05 INFO - Reading from file tmpfile_stdout 16:46:05 INFO - Output received: 16:46:05 INFO - Usage: mozinstall [options] installer 16:46:05 INFO - Options: 16:46:05 INFO - -h, --help show this help message and exit 16:46:05 INFO - -d DEST, --destination=DEST 16:46:05 INFO - Directory to install application into. [default: 16:46:05 INFO - "/builds/slave/test"] 16:46:05 INFO - --app=APP Application being installed. [default: firefox] 16:46:05 INFO - mkdir: /builds/slave/test/build/application 16:46:05 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'] 16:46:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:46:20 INFO - Reading from file tmpfile_stdout 16:46:20 INFO - Output received: 16:46:20 INFO - /builds/slave/test/build/application/firefox/firefox 16:46:20 INFO - Running post-action listener: _resource_record_post_action 16:46:20 INFO - [mozharness: 2017-05-08 23:46:20.491008Z] Finished install step (success) 16:46:20 INFO - [mozharness: 2017-05-08 23:46:20.491280Z] Running run-tests step. 16:46:20 INFO - Running pre-action listener: _resource_record_pre_action 16:46:20 INFO - Running main action method: run_tests 16:46:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:46:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:46:20 INFO - Python 2.7.3 16:46:20 INFO - Return code: 0 16:46:20 INFO - grabbing minidump binary from tooltool 16:46:20 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')]} 16:46:20 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 0x21c2a30>, '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 0x21c37f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c3ca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:46:20 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 16:46:20 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 16:46:20 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 16:46:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:46:20 INFO - Return code: 0 16:46:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:46:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:46:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:46:20 INFO - ENV: RUST_BACKTRACE is now 1 16:46:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:46:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:46:20 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/YB2o5iqdTgO8iKyjTRdTyA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 16:46:20 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/YB2o5iqdTgO8iKyjTRdTyA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 16:46:20 INFO - Using env: {'DISPLAY': ':0', 16:46:20 INFO - 'HOME': '/home/cltbld', 16:46:20 INFO - 'LANG': 'en_US.UTF-8', 16:46:20 INFO - 'LANGUAGE': 'en_US:en', 16:46:20 INFO - 'LOGNAME': 'cltbld', 16:46:20 INFO - 'MAIL': '/var/mail/cltbld', 16:46:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:46:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:46:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:46:20 INFO - 'MOZ_NO_REMOTE': '1', 16:46:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:46:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:46:20 INFO - 'NO_EM_RESTART': '1', 16:46:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:46:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:46:20 INFO - 'PWD': '/builds/slave/test', 16:46:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:46:20 INFO - 'RUST_BACKTRACE': '1', 16:46:20 INFO - 'SHELL': '/bin/bash', 16:46:20 INFO - 'SHLVL': '1', 16:46:20 INFO - 'TERM': 'linux', 16:46:20 INFO - 'TMOUT': '86400', 16:46:20 INFO - 'USER': 'cltbld', 16:46:20 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1494286909.237107-2028962057', 16:46:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:46:20 INFO - '_': '/tools/buildbot/bin/python'} 16:46:20 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/YB2o5iqdTgO8iKyjTRdTyA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 16:46:20 INFO - mozversion application_buildid: 20170508230735 16:46:20 INFO - mozversion application_changeset: b21b974d60d3075ae24f6fb1bae75d0f122f28fc 16:46:20 INFO - mozversion application_display_name: Nightly 16:46:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:46:20 INFO - mozversion application_name: Firefox 16:46:20 INFO - mozversion application_remotingname: firefox 16:46:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:46:20 INFO - mozversion application_vendor: Mozilla 16:46:20 INFO - mozversion application_version: 55.0a1 16:46:20 INFO - mozversion platform_buildid: 20170508230735 16:46:20 INFO - mozversion platform_changeset: b21b974d60d3075ae24f6fb1bae75d0f122f28fc 16:46:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:46:20 INFO - mozversion platform_version: 55.0a1 16:46:20 INFO - using testdate: 1494287180 16:46:20 INFO - actual date: 1494287180 16:46:20 INFO - starting webserver on 'localhost:56271' 16:46:20 INFO - SUITE-START | Running 2 tests 16:46:20 INFO - TEST-START | dromaeo_css 16:46:20 INFO - operating with platform_type : linux_ 16:46:20 INFO - Initialising browser for dromaeo_css test... 16:46:20 INFO - TEST-INFO | started process 3311 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzxGlR3/profile http://localhost:56271/getInfo.html) 16:46:25 INFO - PID 3311 | __metrics Screen width/height:1600/1200 16:46:25 INFO - PID 3311 | colorDepth:24 16:46:25 INFO - PID 3311 | Browser inner width/height: 1024/695 16:46:25 INFO - PID 3311 | __metrics 16:46:27 INFO - TEST-INFO | 3311: exit 0 16:46:27 INFO - Browser initialized. 16:46:27 INFO - Running cycle 1/1 for dromaeo_css test... 16:46:27 INFO - TEST-INFO | started process 3479 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzxGlR3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:46:39 INFO - PID 3479 | RSS: Main: 160124928 16:46:39 INFO - PID 3479 | 16:49:45 INFO - PID 3479 | Cycle 1(1): loaded http://localhost:56271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56271/tests/dromaeo/cssquery-ext.html) 16:49:48 INFO - PID 3479 | RSS: Main: 163278848 16:49:48 INFO - PID 3479 | 16:52:50 INFO - PID 3479 | Cycle 1(1): loaded http://localhost:56271/tests/dromaeo/cssquery-ext.html (next: http://localhost:56271/tests/dromaeo/cssquery-jquery.html) 16:52:51 INFO - PID 3479 | RSS: Main: 159006720 16:52:51 INFO - PID 3479 | 16:55:53 INFO - PID 3479 | Cycle 1(1): loaded http://localhost:56271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56271/tests/dromaeo/cssquery-mootools.html) 16:55:53 INFO - PID 3479 | RSS: Main: 167186432 16:55:53 INFO - PID 3479 | 16:58:55 INFO - PID 3479 | Cycle 1(1): loaded http://localhost:56271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56271/tests/dromaeo/cssquery-prototype.html) 16:58:56 INFO - PID 3479 | RSS: Main: 157888512 16:58:56 INFO - PID 3479 | 17:01:59 INFO - PID 3479 | Cycle 1(1): loaded http://localhost:56271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56271/tests/dromaeo/cssquery-yui.html) 17:02:00 INFO - PID 3479 | RSS: Main: 162279424 17:02:00 INFO - PID 3479 | 17:05:01 INFO - PID 3479 | Cycle 1(1): loaded http://localhost:56271/tests/dromaeo/cssquery-yui.html (next: http://localhost:56271/tests/dromaeo/cssquery-dojo.html) 17:05:02 INFO - PID 3479 | RSS: Main: 166076416 17:05:02 INFO - PID 3479 | 17:05:02 INFO - PID 3479 | __start_tp_report 17:05:02 INFO - PID 3479 | _x_x_mozilla_page_load 17:05:02 INFO - PID 3479 | _x_x_mozilla_page_load_details 17:05:02 INFO - PID 3479 | |i|pagename|runs| 17:05:02 INFO - PID 3479 | |0;dojo.html;2743.2318950693807;2746.5880117982288;2760.171948415476;2764.4194719108987;2771.750542451178;5194.818181363653;5289.391719952207;5304.6286759926825;5324.920126198101;5342.358916929969;5298.841034768953;5300.761465734042;5327.840164795052;5381.54256888164;5389.353277606692;4427.651694051545;4712.505186955372;4717.410323709536;4733.384659994196;4747.287906813971;4756.595689366391;4778.283257511366;4814.518548145193;4818.10864989978;4825.710457372551;4648.930266046012;4694.155052090622;4720.645951553647;4731.408573928259;4779.569838714532;4718.363020992157;4718.551737584959;4744.786484608201;4785.114753770529;4785.976070119662;4609.838655647036;4629.930551041737;4635.397398338195;4663.114008338405;4678.7426691531955;5187.144121220032;5223.112070947948;5259.368875734936;5262.05283049051;5315.7873685052555;5685.488306052475;5686.914696279559;5690.943090569124;5694.430556944314;5694.743736531825;5722.055860782966;5734.713264336767;5736.426357364272;5737.713114344266;5741.971290143564;5245.7114858683135;5295.761690723926;5302.151655735141;5304.071787437183;5310.203469479609;5791.276090488689;5832.591718579659;5841.036229022248;5844.766209351664;5852.414758524199;5573.331200255995;5587.916181257285;5600.691961942132;5681.091025435993;5683.516901063456;5680.750234948305;5691.715414229272;5700.771969121189;5709.68596727184;5717.342505611825;5605.943940560624;5608.551315894719;5629.7185140742795;5630;5649.830505084854;5550.72246387679;5600.663960162403;5612.915806262828;5625.549956003591;5730.484256416942;4787.808487660454;4794.640401969867;4795.088933102699;4801.063792560487;4845.030993801183;4099.426080348753;4134.421181034658;4150.730202536825;4154.169166166779;4216.7259128156575;4819.59033482151;4838.225883858566;4895.804167833318;4895.804167833318;4926.605871530341;5761.596688231783;5764.769409223584;5775.16260142277;5777.364489906107;5802.3037235531165;4913;4923.556879880756;4925.21196608541;4925.630577706686;4973.626977976666;5002.89994200114;5070.492950705047;5085.186370180753;5131.4868513148385;5131.486851314913;5266.499682530153;5301.807093403953;5315.0964336063735;5335;5344.812931547377;5694.430556944272;5695;5713.657180569179;5723.971380143073;5805.361410244954;5292.920606190987;5341.771392579806;5356.3572371315695;5375.758090885998;5383.973080134574;5606.131049687305;5631.521320687787;5632;5653.717314134195;5653.802116925888;5666.716664166857;5720.427957204246;5741.224934633771;5750.932556701469;5806.9419305806405;5533.031719449;5535.25274087993;5536.501714845522;5536.806211782568;5537;5445.156000819879;5497.45025497447;5508.421615730291;5513.062779327443;5529.640573362719;5415.431379705232;5420.430854760193;5446.618736688394;5446.754896029609;5448.645838020516;5504.972475137599;5518.978988887069;5557.805476808292;5560.888782224414;5563.749631266522;5381.892362152813;5456.127019676833;5486.1222204447095;5504.146857237135;5517.889642207214 17:05:02 INFO - PID 3479 | |1;ext.html;600.5915977135548;622.1569772957642;987.1017374189489;1007.2445665750691;1075.2526993739355;33075.66924330756;33993.66006339936;34039.82980085096;34146;34153.82923085387;31337.686623133763;31549.211269718267;31560.68439315606;31811.840940795322;31815.681843181563;6335.841603959915;6403.327650596691;6440;6453.064305675674;7154.8569028619395;7095.503314767969;7191.9640401797915;7193.208747037822;7196.676149573255;7197.208307086243;7159.24827893069;7217.711291548332;7237.529560578546;7237.963810180941;7238.891416628755;7088.326608972139;7175.784726458189;7187.137543494762;7196.676149573282;7209.243029481881;7031.718731250744;7079;7132.643367831588;7134.108236470442;7134.464915131386;32223.83888080568;32291.51562726561;32408.18979525507;32518.83740581282;32674.608689566194;3106.1458099022725;3129.217695576106;3132.5144602586633;3139.6703346148784;3145.402373549018;24805.13182038638;24965.375865603324;24988.12541561055;25001.4999700005;25162.748372516224;3212.4538828399227;3231.482962725976;3245.1562593725566;3247.318063206729;3248.7563432742404;142214;142994;143030.28484857612;143067;143589;33180.50229246563;33934.83032584821;39428.80285598554;41524.79237603793;41551.7922410386;41525.37711934323;41554.79222603868;41612.58387416148;41669;42046.78976605159;12557.309347985949;12681.429335679917;12690.873091269154;12693.809592856114;12694.555690550786;10076.294659373774;10144.188464922789;10144.391336519833;10158.949205254074;10170.440625765506;12005.399730013465;12046.698832529082;12057.336846473352;12062.336571488653;12192.512299508098;5038.521340472649;5110.26600768587;5125.384953805493;5249.084084309276;5255.08036093682;861.6510313323114;912.28385717213;915.1077699243185;921.3504479342048;944.3200895355333;20577.794222057888;20907.37277881666;21453.141874325163;22055.779442205694;22060.448488787908;980.5636491761098;991.2961797124123;996.6461906023402;1008.5058321422597;1010.1363334349172;11090.5563777448;11222.438878056064;11527.884721152848;11529.250598711225;11665.475053622607;170267;170380;170863;170869;171118;40798.38802417966;41070;41127.7943610286;41302.1739565207;41423.378649320286;1197.024425093546;1238.6160290310033;1246.5387806511467;1249.5189352099508;1262.4129779652505;19999.20003199914;20725.79274207299;21248.893755531124;21469.785302146778;21703.457413564156;29512.409751805273;29571.704282956896;29587.112386628436;29592;29675.55486667745;150116;151499;152291.238543811;152330;152537;27446.313842154104;27865.721342786313;27943.441131177668;29677.5548366779;29726.25684357908;36950.07624809401;36973.63026369702;37292.813535932146;37337.0665733348;37434.25131497409;26087.869560652074;27493.587596185673;27676.861615691792;27844.30389240285;28355.291117722223;27309.86345068262;27894.44211115807;28503.14490565286;28776.992805251717;29142.708572913998;30712.089779799368;30894;30982.84508577443;31093.8445307772;31118.22204444907;26221.868890655423;26430.86784566065;26581.867090664422;27174.72825271801;28214.71785282121;20036.69944950856;22553.436164095372;22740.545189096458;22839.972201251316;23038.193663222377 17:05:02 INFO - PID 3479 | |2;jquery.html;389.0008038026815;397.3027337023523;411.8105671391161;416.9791510424478;432.15082363156404;17705.203265853037;18400.987945662982;18410.723839142425;18673.719894201597;19437.70843437346;16983.57541061474;17175.227114779835;17213;18038.098095095258;18212.362567310145;5416.837494875141;5609.831705048855;5629.549636029128;5633.887322253552;5809.215755872945;5544.77820887164;5548.195511650808;5557.416471270499;5562.721863906809;5570.3315602127805;5418.431064738204;5481.972590137044;5509.696966666832;5510.504054635082;5545.085060964936;5543.77824887004;5544.944550554504;5561.443855614447;5575.470330318633;5577.163425486169;4967.776450059756;5074.517920797518;5136.486351364871;5141.126008578551;5141.562967147797;22151.667724984138;22545.549089018292;22626.88686556573;22649.2072777452;22799.886000570055;1642.8192898781124;1680.4454530005069;1691.4249155287139;1696.762453256545;1696.9745453818202;14737;14917.776233356508;15366.692666146726;15377.692446151126;15585.220738963006;2025.2709024751077;2122.1935664447565;2132.2750264910005;2137.5190582119053;2144.710464087344;88709.55645221798;93929;94252.0574794257;94518.52740736322;95148;11104.111671066295;11225.117074072641;11365.204435689588;11450.312981221154;11577.768444631229;15756.448524301824;15835.762463563056;15862.365505379887;15879.841201588068;15881.205939702968;7419;7645.311921926942;7728.149903510609;7802.68789248435;7821.6089195541135;6807.965960170168;6814.659267036727;6906.723731050803;7097.183823860219;7129.536580122275;6972;7052.9647351762915;7057.541259818096;7130.679119439637;7148.428125749928;2134.10223536983;2151.946201344979;2152.483403983033;2166.274298110119;2273.9204127855446;848.4485084694875;878.1832895407332;883.1036497954581;886.5124181700039;909.1136142261374;16811.41160059392;16945.830541694424;17058.31766729317;17357.826421735874;18067.819321806615;882.9911700883038;891.585412783059;898.9370744047985;905.103947092387;918.2745630951473;9139.543022848831;9526.095020972996;9598.808023839623;9682.854757178648;9741.464219467856;343863;353508;356623;358082;359239;69802.3019769806;70953;71076.64461677658;71890.64054679693;72852.63573682097;1045.900639439252;1073.3667136389568;1110.655696734015;1142.8628564572305;1143.588308209044;17748.20133093988;18102.275908963493;18608;18750.531236718645;18909.054547272855;39306;39363.015924602114;40503.392449112696;40592.594074058885;41150.176996460505;47163.528364717284;47225;47566.524334757596;47603.28595071146;49555.75222123866;8278.958605206935;8310.168983101641;8575.656973720981;8815.338849586178;8829.823403531766;13044.608661740163;13249.271290079138;13394.397252123483;13502.797458038334;13636.727265454834;11265.605703800327;11415.315081095161;11632.53469861196;11778.646640600795;11949.402529873645;10579.576816927236;10719.517621707198;10810;10945.124390048937;11160.10719142483;11568.305901645928;11588.536458541565;11749.412529373669;11785.233959792586;12190.6952326189;8371;8472.110428404929;8508.40441169137;8642.611082501428;8730.869036964323;11011.83482247783;11019.614313498989;11469.770604588028;11478.827817582576;11586.362750048827 17:05:02 INFO - PID 3479 | |3;mootools.html;1224.5958833584916;1274.9872501274986;1283.4417028592568;1283.454531823974;1293.5213970830791;9080.318976076796;9402.529873506315;9418.905810941897;9423.010583888687;9708.466034368106;9477.336586438953;9614.615415383394;9620.086091821284;9646.180074693642;9654.034596540343;2146.6994620753067;2193.6270833958265;2195.4401627584944;2199.593075281078;2200.427888748921;2098.842586805988;2146.034284571941;2147.38799442159;2163.642998905179;2165.5127596290868;2109.050927082811;2125.5642593268344;2152.87082775034;2154.256781410411;2160.2115227941767;2075.4915045813723;2089.0703636881594;2092.654711972523;2092.843036772233;2110.4407332057017;2002.3592450415872;2017.576308975117;2050.261905713942;2058.310465993894;2141.507453285753;9310.162085412345;9428.575714092814;9463.905360946372;9481.099295566979;9494.098060684224;5288.0745869472685;5482.753276102585;5489.6980666063355;5494.423085575997;5498.80754173602;3325.5177999190223;3378.7803792753393;3466.2027733621408;3506.0533655913014;3514.5782506099176;1177.211268450132;1210.1710328425056;1229.6126720083234;1241.2862604002735;1261.4954018392625;13397;13468.595942121752;13546.93226533861;13598.796018059737;13675.521356752466;4959.752012399365;5005.799768009311;5117.283580298761;5118.283440318359;5140.640155189176;11449.141314401453;11558.479868405942;11563.248388854698;11578.594749183907;11614;5445.156000819879;5447.836564903059;5500.257465242221;5508.91736623951;5513.255710479114;4713.410823647044;4790.353302304145;4853.830115945925;4902.460729319772;4984.22744474607;3667.5598928128798;3866.149447121629;3885.1452680410266;3932.9016774580864;3955.92088158241;1096.0847692176962;1111.4664960818852;1124.145649306533;1125.994370028161;1135.1316243074054;687.8211664967145;711.1608302203347;712.8467379513326;726.6040008195546;728.621117019147;5153.227015947563;5286.048511268009;5296.549793267615;5331.4935081168005;5381.569474442035;570.8258981010748;572.0475408444893;575.4130786597647;578.4938179093293;580.94771470567;3398.252384475461;3455.2398472336045;3636.7999760013454;3756.4365345197893;3824.1204522959874;11599.76800464003;12116.939415303043;12250.203736757083;12262.20295680778;12276.508939642494;11761.588344407905;11961.760764784656;12019.819702704466;12203.389830508439;12236.204646697935;6931;6955.582665040114;7070.646467676595;7103.289671032855;7123.643817809192;5974.2233509643465;6090.634561926298;6124.601900876429;6130.6628135452975;6145.877082458415;10684.358938463716;10915.727106822393;11063.229883218646;11204.383758893338;11263.66209013731;11198.83201751958;11203.21577489568;11334.829977550178;11386.259893106922;11393.715157121138;7546.9245307546225;7930.206979302255;7947.125816160102;7949.960250198712;8029.277365037175;8918.331125165509;8961.193492585699;9021;9032.86450703227;9091.045440228681;7566.508176968479;7726.497777644435;7809.101953275219;7816.6091695416135;7953.164917683791;7302.671379788028;7722.922770772445;7740.7677769667;7742.303192712683;7879.172686867796;6935.618540980295;7134.464915131282;7149.82125446868;7150.678219480032;7160.57036577807;4670.855640368131;5112.130937740519;5165.354330708661;5187.688738675692;5192.480751924777;5038.974805125951;5050.671706339076;5143.305653736697;5151;5217.295665085165 17:05:02 INFO - PID 3479 | |4;prototype.html;374.2234862659978;385.0047626884505;386.10616422980814;390.91009067914376;394.0601665028906;5451.727413629317;5574.331080270368;5581.944180558193;5589.552835773138;5600.831975040745;5315.468453154683;5441.068420710641;5441.59188060895;5445.945540544593;5458.590605704569;4243.596858298472;4247.469066366704;4249.893752656178;4268.509121451027;4277.08042770805;4244.151169766059;4256.4253825733595;4265;4268.637165840907;4269.231538323101;4121.4848143982;4203.327467605184;4232.449781528412;4253.1706317268145;4257.19113368459;4203.327467605199;4221.472315960505;4223.746575205498;4251.511076226243;4263.445752052229;3816.751911125768;3818.5608655004476;3828.157805282833;3845.0964023454467;3845.1732877431205;5205.089109405877;5424.1321388577635;5433.1035379162395;5452.727363631802;5462.863428414282;4844.103840789465;4858.955324605226;4865.19724245499;4876.853694389139;4898.853034408973;5858.707064646751;5866.530677545786;5874.73563689635;5891.705414729289;5892.793752218695;3907.4529565860803;3977.9204415911518;4046.9392959105635;4058.5129784425762;4060.2488539620263;6033.577649564532;6132.386761323832;6177.81466556004;6214.906776398358;6272.9336012878375;4544.954550454519;4632.606228470618;4636.953630463652;4640.95359046412;4646.976765116153;4677.579017888338;4687.8670205056615;4696.319033740088;4727.149113159596;4733.597644200281;5052.393712754493;5159.884447376558;5172.27588137661;5218.947810521922;5220.034293655686;5849.415058494116;5874.41390824475;5880.794172204038;5892.469677728939;5897.203877476486;1618.6924484347937;1618.8785841061967;1641.4501142117285;1647.62104715916;1655.4785242648527;1108.2242430298822;1158.2124155574122;1179.4161889864572;1181.6868529839599;1208.3112625803383;5082.440931497532;5083.74581270935;5106.821261255913;5118.97440512795;5119.48805119485;6041.939580604226;6070.362611925684;6086.695665216722;6090.208272924491;6098.444896551439;4960.975195124001;5076.466970968069;5098.796048158032;5130.230465430141;5138.897222055538;3193.696598823108;3222.38774632819;3239.627442844056;3245.496947973068;3249.268914494267;5517.834464966058;5555.777768889199;5589.74846131925;5606.962711898312;5680.715964201773;6181.002213926242;6193.349698281706;6194.845128871724;6224.906626400608;6248.343923888017;5531.478843318119;5622.437756224426;5637.408072152447;5649.519790817744;5655.660660360391;6039.577229593886;6086.573939824347;6092.482139018233;6107.541934354852;6114.419130182626;5851.64890106595;5985.491233245223;5995.61028533144;5997.760089596542;6001.699915004319;5651.6043876928225;5677.5457963362005;5680.801171958961;5681.17622944679;5702.6293290935955;4121.216968775923;4164.916701665889;4167.74993500391;4171.499420069611;4174.91650167001;6005.666854895575;6088.360722124113;6123.357047509948;6159.121467952317;6161.15165450372;5891.351951285269;5914.792982245601;5921.936744083746;5942.227510423791;5952;5706.657600543981;5857.765689372548;5912.733926973383;5915.31413547137;5924.31870334917;5748.827535173951;5764.308283006066;5803.8549036274435;5805.680687562224;5819.738111785065;5911.024680927599;5916.467517923235;5920.549465381009;5927.407259274038;5951.940480595312;5568.972155139199;5692.658440493584;5759.107338362561;5765.106408506688;5774.133879918046 17:05:02 INFO - PID 3479 | |5;yui.html;695.6208866167939;699.0353312428846;708.9397401220896;752.4695089961577;776.6699152860036;12312.261264324146;12859.742805143891;13552.18686878788;14488.130712157277;14491;15083.472078477256;15097.245137743124;15686.13726245056;15732.84267157328;15796.973196742203;894.1773568317132;908.9181973622373;917.8026724254285;917.9770505737343;920.5259291464901;919.7148883845996;920.4017388697367;925.7315378540216;926.1294383279695;926.1386910173536;955.8375076237022;962.5476026267643;962.9807403851919;965.3194497878978;968.4673429613684;943.664998925382;946.4888959961612;947.209080417852;950.2777888804524;953.7043516509904;700.1318365227132;706.1455638677206;706.4807366585555;706.731442052017;706.8162277807755;14820.184889831055;14969.850301496954;15413.922930385388;15535.844641553553;15555.922220388939;15712.135832529206;15779.92110039454;15807.130607816565;15893.364265429369;15901.1254381009;11231.438428078563;11495.1378646601;11499.942500287529;11559.711007224803;11611.187216894821;2937.8971735989353;2940.426616809723;2958.3787404644836;2958.60058892049;2970.212893583202;71313.64343178303;71904.2809571908;72031;72282;73835.63082184609;12240.877591224153;12337.013038956862;12373.381330933418;12437.564685235973;12474.18917770342;22409.439764005703;22984.885075574515;23064.654030189562;23167.53664926726;23201.53596928052;5910.379410161871;6240;6251.281102673251;6299.748010079637;6330.208723909512;3052.4047810676707;3118.937621247562;3138.8901388451295;3146.354997225609;3146.606674165729;3462.272922686214;3538.4515400113023;3557.3418917500344;3574.5353104096303;3698.8335524900904;755.1202848681224;761.4365369626547;767.4742801181209;773.961301934901;775.0079897730801;621.7844114755642;635.5011316116919;641.5252712992352;642.5309524047472;657.2802780954847;10034.147097496649;10320.019598138166;10460.790784184426;10915.345079295268;11072.61938683187;637.2894222941387;642.408983734965;646.1051443750439;646.6734299178885;650.1937597379216;4419.160359531678;4574.108048930427;4635.675502714777;4764.666473346832;4792;62190;63657.68171159115;64489.35510644927;67166.32833671698;67611.88657361148;56325.7183714087;56398.1540276888;56666.43333566694;57248.141277880866;58325.416745832845;52623.21065184102;53041.7347913258;53286.20777571735;53316.46683533193;53743.46256537385;9000.36997410175;9133.086691330815;9312.394694344846;9464.716058518256;9577.23382129414;27624.585631215145;28236.71763282341;28340.433191335644;28392.290192745346;28845.134645960654;33018.33963320768;33062.5040624386;44680.55319446894;44757.776211120035;45754;14045.929770351082;14212.715745685235;14324.713505730035;14463.421463141356;14514.056586321854;13657.795133072814;14175.787363189354;14479.855201448272;14615.707685846011;14737.557873263819;13487.05590608648;13580.25308608036;13796.586102416944;14394.352254148798;14691.55925322242;13759.380827862971;14346.354414051184;14664.266786660412;14787.186704731343;14826;12962.416691248727;12995.350232488527;13051.477940882258;13318.134321269086;13634;9690;9698.70903872885;9724.611015559298;9868.97685974388;9947.751306217402;10942.671719848417;11089.667309980714;11329.943350283196;11485.942570287096;11585.594504192313 17:05:02 INFO - PID 3479 | __end_tp_report 17:05:02 INFO - PID 3479 | __start_cc_report 17:05:02 INFO - PID 3479 | _x_x_mozilla_cycle_collect,356 17:05:02 INFO - PID 3479 | __end_cc_report 17:05:02 INFO - PID 3479 | __startTimestamp1494288302063__endTimestamp 17:05:02 INFO - PID 3479 | 17:05:02 INFO - PID 3479 | ------- Summary: start ------- 17:05:02 INFO - PID 3479 | Number of tests: 6 17:05:02 INFO - PID 3479 | 17:05:02 INFO - PID 3479 | [#0] dojo.html Cycles:165 Average:5218.26 Median:5381.54 stddev:604.06 (11.2%) stddev-sans-first:573.86 17:05:02 INFO - PID 3479 | Values: 2743.2 2746.6 2760.2 2764.4 2771.8 5194.8 5289.4 5304.6 5324.9 5342.4 5298.8 5300.8 5327.8 5381.5 5389.4 4427.7 4712.5 4717.4 4733.4 4747.3 4756.6 4778.3 4814.5 4818.1 4825.7 4648.9 4694.2 4720.6 4731.4 4779.6 4718.4 4718.6 4744.8 4785.1 4786.0 4609.8 4629.9 4635.4 4663.1 4678.7 5187.1 5223.1 5259.4 5262.1 5315.8 5685.5 5686.9 5690.9 5694.4 5694.7 5722.1 5734.7 5736.4 5737.7 5742.0 5245.7 5295.8 5302.2 5304.1 5310.2 5791.3 5832.6 5841.0 5844.8 5852.4 5573.3 5587.9 5600.7 5681.1 5683.5 5680.8 5691.7 5700.8 5709.7 5717.3 5605.9 5608.6 5629.7 5630.0 5649.8 5550.7 5600.7 5612.9 5625.5 5730.5 4787.8 4794.6 4795.1 4801.1 4845.0 4099.4 4134.4 4150.7 4154.2 4216.7 4819.6 4838.2 4895.8 4895.8 4926.6 5761.6 5764.8 5775.2 5777.4 5802.3 4913.0 4923.6 4925.2 4925.6 4973.6 5002.9 5070.5 5085.2 5131.5 5131.5 5266.5 5301.8 5315.1 5335.0 5344.8 5694.4 5695.0 5713.7 5724.0 5805.4 5292.9 5341.8 5356.4 5375.8 5384.0 5606.1 5631.5 5632.0 5653.7 5653.8 5666.7 5720.4 5741.2 5750.9 5806.9 5533.0 5535.3 5536.5 5536.8 5537.0 5445.2 5497.5 5508.4 5513.1 5529.6 5415.4 5420.4 5446.6 5446.8 5448.6 5505.0 5519.0 5557.8 5560.9 5563.7 5381.9 5456.1 5486.1 5504.1 5517.9 17:05:02 INFO - PID 3479 | 17:05:02 INFO - PID 3479 | [#1] ext.html Cycles:180 Average:29995.14 Median:30938.42 stddev:40070.01 (129.5%) stddev-sans-first:40121.63 17:05:02 INFO - PID 3479 | Values: 600.6 622.2 987.1 1007.2 1075.3 33075.7 33993.7 34039.8 34146.0 34153.8 31337.7 31549.2 31560.7 31811.8 31815.7 6335.8 6403.3 6440.0 6453.1 7154.9 7095.5 7192.0 7193.2 7196.7 7197.2 7159.2 7217.7 7237.5 7238.0 7238.9 7088.3 7175.8 7187.1 7196.7 7209.2 7031.7 7079.0 7132.6 7134.1 7134.5 32223.8 32291.5 32408.2 32518.8 32674.6 3106.1 3129.2 3132.5 3139.7 3145.4 24805.1 24965.4 24988.1 25001.5 25162.7 3212.5 3231.5 3245.2 3247.3 3248.8 142214.0 142994.0 143030.3 143067.0 143589.0 33180.5 33934.8 39428.8 41524.8 41551.8 41525.4 41554.8 41612.6 41669.0 42046.8 12557.3 12681.4 12690.9 12693.8 12694.6 10076.3 10144.2 10144.4 10158.9 10170.4 12005.4 12046.7 12057.3 12062.3 12192.5 5038.5 5110.3 5125.4 5249.1 5255.1 861.7 912.3 915.1 921.4 944.3 20577.8 20907.4 21453.1 22055.8 22060.4 980.6 991.3 996.6 1008.5 1010.1 11090.6 11222.4 11527.9 11529.3 11665.5 170267.0 170380.0 170863.0 170869.0 171118.0 40798.4 41070.0 41127.8 41302.2 41423.4 1197.0 1238.6 1246.5 1249.5 1262.4 19999.2 20725.8 21248.9 21469.8 21703.5 29512.4 29571.7 29587.1 29592.0 29675.6 150116.0 151499.0 152291.2 152330.0 152537.0 27446.3 27865.7 27943.4 29677.6 29726.3 36950.1 36973.6 37292.8 37337.1 37434.3 26087.9 27493.6 27676.9 27844.3 28355.3 27309.9 27894.4 28503.1 28777.0 29142.7 30712.1 30894.0 30982.8 31093.8 31118.2 26221.9 26430.9 26581.9 27174.7 28214.7 20036.7 22553.4 22740.5 22840.0 23038.2 17:05:02 INFO - PID 3479 | 17:05:02 INFO - PID 3479 | [#2] jquery.html Cycles:180 Average:24650.00 Median:19847.50 stddev:59096.05 (297.8%) stddev-sans-first:59233.76 17:05:02 INFO - PID 3479 | Values: 389.0 397.3 411.8 417.0 432.2 17705.2 18401.0 18410.7 18673.7 19437.7 16983.6 17175.2 17213.0 18038.1 18212.4 5416.8 5609.8 5629.5 5633.9 5809.2 5544.8 5548.2 5557.4 5562.7 5570.3 5418.4 5482.0 5509.7 5510.5 5545.1 5543.8 5544.9 5561.4 5575.5 5577.2 4967.8 5074.5 5136.5 5141.1 5141.6 22151.7 22545.5 22626.9 22649.2 22799.9 1642.8 1680.4 1691.4 1696.8 1697.0 14737.0 14917.8 15366.7 15377.7 15585.2 2025.3 2122.2 2132.3 2137.5 2144.7 88709.6 93929.0 94252.1 94518.5 95148.0 11104.1 11225.1 11365.2 11450.3 11577.8 15756.4 15835.8 15862.4 15879.8 15881.2 7419.0 7645.3 7728.1 7802.7 7821.6 6808.0 6814.7 6906.7 7097.2 7129.5 6972.0 7053.0 7057.5 7130.7 7148.4 2134.1 2151.9 2152.5 2166.3 2273.9 848.4 878.2 883.1 886.5 909.1 16811.4 16945.8 17058.3 17357.8 18067.8 883.0 891.6 898.9 905.1 918.3 9139.5 9526.1 9598.8 9682.9 9741.5 343863.0 353508.0 356623.0 358082.0 359239.0 69802.3 70953.0 71076.6 71890.6 72852.6 1045.9 1073.4 1110.7 1142.9 1143.6 17748.2 18102.3 18608.0 18750.5 18909.1 39306.0 39363.0 40503.4 40592.6 41150.2 47163.5 47225.0 47566.5 47603.3 49555.8 8279.0 8310.2 8575.7 8815.3 8829.8 13044.6 13249.3 13394.4 13502.8 13636.7 11265.6 11415.3 11632.5 11778.6 11949.4 10579.6 10719.5 10810.0 10945.1 11160.1 11568.3 11588.5 11749.4 11785.2 12190.7 8371.0 8472.1 8508.4 8642.6 8730.9 11011.8 11019.6 11469.8 11478.8 11586.4 17:05:02 INFO - PID 3479 | 17:05:02 INFO - PID 3479 | [#3] mootools.html Cycles:180 Average:5981.61 Median:4971.99 stddev:3720.66 (74.8%) stddev-sans-first:3713.92 17:05:02 INFO - PID 3479 | Values: 1224.6 1275.0 1283.4 1283.5 1293.5 9080.3 9402.5 9418.9 9423.0 9708.5 9477.3 9614.6 9620.1 9646.2 9654.0 2146.7 2193.6 2195.4 2199.6 2200.4 2098.8 2146.0 2147.4 2163.6 2165.5 2109.1 2125.6 2152.9 2154.3 2160.2 2075.5 2089.1 2092.7 2092.8 2110.4 2002.4 2017.6 2050.3 2058.3 2141.5 9310.2 9428.6 9463.9 9481.1 9494.1 5288.1 5482.8 5489.7 5494.4 5498.8 3325.5 3378.8 3466.2 3506.1 3514.6 1177.2 1210.2 1229.6 1241.3 1261.5 13397.0 13468.6 13546.9 13598.8 13675.5 4959.8 5005.8 5117.3 5118.3 5140.6 11449.1 11558.5 11563.2 11578.6 11614.0 5445.2 5447.8 5500.3 5508.9 5513.3 4713.4 4790.4 4853.8 4902.5 4984.2 3667.6 3866.1 3885.1 3932.9 3955.9 1096.1 1111.5 1124.1 1126.0 1135.1 687.8 711.2 712.8 726.6 728.6 5153.2 5286.0 5296.5 5331.5 5381.6 570.8 572.0 575.4 578.5 580.9 3398.3 3455.2 3636.8 3756.4 3824.1 11599.8 12116.9 12250.2 12262.2 12276.5 11761.6 11961.8 12019.8 12203.4 12236.2 6931.0 6955.6 7070.6 7103.3 7123.6 5974.2 6090.6 6124.6 6130.7 6145.9 10684.4 10915.7 11063.2 11204.4 11263.7 11198.8 11203.2 11334.8 11386.3 11393.7 7546.9 7930.2 7947.1 7950.0 8029.3 8918.3 8961.2 9021.0 9032.9 9091.0 7566.5 7726.5 7809.1 7816.6 7953.2 7302.7 7722.9 7740.8 7742.3 7879.2 6935.6 7134.5 7149.8 7150.7 7160.6 4670.9 5112.1 5165.4 5187.7 5192.5 5039.0 5050.7 5143.3 5151.0 5217.3 17:05:02 INFO - PID 3479 | 17:05:02 INFO - PID 3479 | [#4] prototype.html Cycles:180 Average:4882.64 Median:5443.77 stddev:1397.74 (25.7%) stddev-sans-first:1360.08 17:05:02 INFO - PID 3479 | Values: 374.2 385.0 386.1 390.9 394.1 5451.7 5574.3 5581.9 5589.6 5600.8 5315.5 5441.1 5441.6 5445.9 5458.6 4243.6 4247.5 4249.9 4268.5 4277.1 4244.2 4256.4 4265.0 4268.6 4269.2 4121.5 4203.3 4232.4 4253.2 4257.2 4203.3 4221.5 4223.7 4251.5 4263.4 3816.8 3818.6 3828.2 3845.1 3845.2 5205.1 5424.1 5433.1 5452.7 5462.9 4844.1 4859.0 4865.2 4876.9 4898.9 5858.7 5866.5 5874.7 5891.7 5892.8 3907.5 3977.9 4046.9 4058.5 4060.2 6033.6 6132.4 6177.8 6214.9 6272.9 4545.0 4632.6 4637.0 4641.0 4647.0 4677.6 4687.9 4696.3 4727.1 4733.6 5052.4 5159.9 5172.3 5218.9 5220.0 5849.4 5874.4 5880.8 5892.5 5897.2 1618.7 1618.9 1641.5 1647.6 1655.5 1108.2 1158.2 1179.4 1181.7 1208.3 5082.4 5083.7 5106.8 5119.0 5119.5 6041.9 6070.4 6086.7 6090.2 6098.4 4961.0 5076.5 5098.8 5130.2 5138.9 3193.7 3222.4 3239.6 3245.5 3249.3 5517.8 5555.8 5589.7 5607.0 5680.7 6181.0 6193.3 6194.8 6224.9 6248.3 5531.5 5622.4 5637.4 5649.5 5655.7 6039.6 6086.6 6092.5 6107.5 6114.4 5851.6 5985.5 5995.6 5997.8 6001.7 5651.6 5677.5 5680.8 5681.2 5702.6 4121.2 4164.9 4167.7 4171.5 4174.9 6005.7 6088.4 6123.4 6159.1 6161.2 5891.4 5914.8 5921.9 5942.2 5952.0 5706.7 5857.8 5912.7 5915.3 5924.3 5748.8 5764.3 5803.9 5805.7 5819.7 5911.0 5916.5 5920.5 5927.4 5951.9 5569.0 5692.7 5759.1 5765.1 5774.1 17:05:02 INFO - PID 3479 | 17:05:02 INFO - PID 3479 | [#5] yui.html Cycles:180 Average:15608.27 Median:3636.68 stddev:18647.98 (512.8%) stddev-sans-first:18666.66 17:05:02 INFO - PID 3479 | Values: 695.6 699.0 708.9 752.5 776.7 12312.3 12859.7 13552.2 14488.1 14491.0 15083.5 15097.2 15686.1 15732.8 15797.0 894.2 908.9 917.8 918.0 920.5 919.7 920.4 925.7 926.1 926.1 955.8 962.5 963.0 965.3 968.5 943.7 946.5 947.2 950.3 953.7 700.1 706.1 706.5 706.7 706.8 14820.2 14969.9 15413.9 15535.8 15555.9 15712.1 15779.9 15807.1 15893.4 15901.1 11231.4 11495.1 11499.9 11559.7 11611.2 2937.9 2940.4 2958.4 2958.6 2970.2 71313.6 71904.3 72031.0 72282.0 73835.6 12240.9 12337.0 12373.4 12437.6 12474.2 22409.4 22984.9 23064.7 23167.5 23201.5 5910.4 6240.0 6251.3 6299.7 6330.2 3052.4 3118.9 3138.9 3146.4 3146.6 3462.3 3538.5 3557.3 3574.5 3698.8 755.1 761.4 767.5 774.0 775.0 621.8 635.5 641.5 642.5 657.3 10034.1 10320.0 10460.8 10915.3 11072.6 637.3 642.4 646.1 646.7 650.2 4419.2 4574.1 4635.7 4764.7 4792.0 62190.0 63657.7 64489.4 67166.3 67611.9 56325.7 56398.2 56666.4 57248.1 58325.4 52623.2 53041.7 53286.2 53316.5 53743.5 9000.4 9133.1 9312.4 9464.7 9577.2 27624.6 28236.7 28340.4 28392.3 28845.1 33018.3 33062.5 44680.6 44757.8 45754.0 14045.9 14212.7 14324.7 14463.4 14514.1 13657.8 14175.8 14479.9 14615.7 14737.6 13487.1 13580.3 13796.6 14394.4 14691.6 13759.4 14346.4 14664.3 14787.2 14826.0 12962.4 12995.4 13051.5 13318.1 13634.0 9690.0 9698.7 9724.6 9869.0 9947.8 10942.7 11089.7 11329.9 11485.9 11585.6 17:05:02 INFO - PID 3479 | -------- Summary: end -------- 17:05:02 INFO - PID 3479 | 17:05:02 INFO - TEST-INFO | 3479: exit 0 17:05:02 INFO - TEST-OK | dromaeo_css | took 1122065ms 17:05:02 INFO - TEST-START | kraken 17:05:02 INFO - operating with platform_type : linux_ 17:05:02 INFO - Initialising browser for kraken test... 17:05:02 INFO - TEST-INFO | started process 3901 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmeK9lW/profile http://localhost:56271/getInfo.html) 17:05:07 INFO - PID 3901 | __metrics Screen width/height:1600/1200 17:05:07 INFO - PID 3901 | colorDepth:24 17:05:07 INFO - PID 3901 | Browser inner width/height: 1024/695 17:05:07 INFO - PID 3901 | __metrics 17:05:09 INFO - TEST-INFO | 3901: exit 0 17:05:09 INFO - Browser initialized. 17:05:09 INFO - Running cycle 1/1 for kraken test... 17:05:09 INFO - TEST-INFO | started process 4073 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmeK9lW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:05:21 INFO - PID 4073 | RSS: Main: 159973376 17:05:21 INFO - PID 4073 | 17:05:23 INFO - PID 4073 | Cycle 1(1): loaded http://localhost:56271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56271/tests/kraken/driver.html?testName=audio-beat-detection) 17:05:24 INFO - PID 4073 | RSS: Main: 166572032 17:05:24 INFO - PID 4073 | 17:05:27 INFO - PID 4073 | Cycle 1(1): loaded http://localhost:56271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56271/tests/kraken/driver.html?testName=audio-dft) 17:05:28 INFO - PID 4073 | RSS: Main: 164962304 17:05:28 INFO - PID 4073 | 17:05:31 INFO - PID 4073 | Cycle 1(1): loaded http://localhost:56271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56271/tests/kraken/driver.html?testName=audio-fft) 17:05:31 INFO - PID 4073 | RSS: Main: 161443840 17:05:31 INFO - PID 4073 | 17:05:33 INFO - PID 4073 | Cycle 1(1): loaded http://localhost:56271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56271/tests/kraken/driver.html?testName=audio-oscillator) 17:05:34 INFO - PID 4073 | RSS: Main: 161959936 17:05:34 INFO - PID 4073 | 17:05:36 INFO - PID 4073 | Cycle 1(1): loaded http://localhost:56271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:05:37 INFO - PID 4073 | RSS: Main: 162607104 17:05:37 INFO - PID 4073 | 17:05:40 INFO - PID 4073 | Cycle 1(1): loaded http://localhost:56271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56271/tests/kraken/driver.html?testName=imaging-darkroom) 17:05:40 INFO - PID 4073 | RSS: Main: 168206336 17:05:40 INFO - PID 4073 | 17:05:44 INFO - PID 4073 | Cycle 1(1): loaded http://localhost:56271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56271/tests/kraken/driver.html?testName=imaging-desaturate) 17:05:45 INFO - PID 4073 | RSS: Main: 165662720 17:05:45 INFO - PID 4073 | 17:05:47 INFO - PID 4073 | Cycle 1(1): loaded http://localhost:56271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56271/tests/kraken/driver.html?testName=json-parse-financial) 17:05:48 INFO - PID 4073 | RSS: Main: 166662144 17:05:48 INFO - PID 4073 | 17:05:50 INFO - PID 4073 | Cycle 1(1): loaded http://localhost:56271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:05:50 INFO - PID 4073 | RSS: Main: 167608320 17:05:50 INFO - PID 4073 | 17:05:52 INFO - PID 4073 | Cycle 1(1): loaded http://localhost:56271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56271/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:05:53 INFO - PID 4073 | RSS: Main: 167059456 17:05:53 INFO - PID 4073 | 17:05:55 INFO - PID 4073 | Cycle 1(1): loaded http://localhost:56271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:05:55 INFO - PID 4073 | RSS: Main: 167018496 17:05:55 INFO - PID 4073 | 17:05:58 INFO - PID 4073 | Cycle 1(1): loaded http://localhost:56271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:05:59 INFO - PID 4073 | RSS: Main: 167096320 17:05:59 INFO - PID 4073 | 17:06:02 INFO - PID 4073 | Cycle 1(1): loaded http://localhost:56271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:06:03 INFO - PID 4073 | RSS: Main: 167346176 17:06:03 INFO - PID 4073 | 17:06:05 INFO - PID 4073 | Cycle 1(1): loaded http://localhost:56271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56271/tests/kraken/driver.html?testName=ai-astar) 17:06:05 INFO - PID 4073 | RSS: Main: 168960000 17:06:05 INFO - PID 4073 | 17:06:05 INFO - PID 4073 | __start_tp_report 17:06:05 INFO - PID 4073 | _x_x_mozilla_page_load 17:06:05 INFO - PID 4073 | _x_x_mozilla_page_load_details 17:06:05 INFO - PID 4073 | |i|pagename|runs| 17:06:05 INFO - PID 4073 | |0;ai-astar;104;113;113;113;112;111;111;111;111;112 17:06:05 INFO - PID 4073 | |1;audio-beat-detection;159;123;124;180;126;124;123;123;147;126 17:06:05 INFO - PID 4073 | |2;audio-dft;165;163;164;166;166;176;163;164;165;168 17:06:05 INFO - PID 4073 | |3;audio-fft;74;75;74;100;77;74;74;76;97;78 17:06:05 INFO - PID 4073 | |4;audio-oscillator;84;85;104;84;83;83;98;85;84;109 17:06:05 INFO - PID 4073 | |5;imaging-gaussian-blur;114;115;114;114;113;114;115;117;113;114 17:06:05 INFO - PID 4073 | |6;imaging-darkroom;151;152;152;154;152;151;151;150;150;150 17:06:05 INFO - PID 4073 | |7;imaging-desaturate;95;95;95;94;94;95;94;94;94;94 17:06:05 INFO - PID 4073 | |8;json-parse-financial;54;53;54;54;55;55;55;53;55;54 17:06:05 INFO - PID 4073 | |9;json-stringify-tinderbox;56;57;57;56;55;56;56;56;55;55 17:06:05 INFO - PID 4073 | |10;stanford-crypto-aes;82;91;81;83;81;82;80;83;81;83 17:06:05 INFO - PID 4073 | |11;stanford-crypto-ccm;136;137;140;130;141;134;135;132;226;131 17:06:05 INFO - PID 4073 | |12;stanford-crypto-pbkdf2;185;195;200;189;194;192;191;197;191;198 17:06:05 INFO - PID 4073 | |13;stanford-crypto-sha256-iterative;72;73;72;70;73;71;73;76;71;71 17:06:05 INFO - PID 4073 | __end_tp_report 17:06:05 INFO - PID 4073 | __start_cc_report 17:06:05 INFO - PID 4073 | _x_x_mozilla_cycle_collect,837 17:06:05 INFO - PID 4073 | __end_cc_report 17:06:05 INFO - PID 4073 | __startTimestamp1494288365397__endTimestamp 17:06:05 INFO - PID 4073 | 17:06:05 INFO - PID 4073 | ------- Summary: start ------- 17:06:05 INFO - PID 4073 | Number of tests: 14 17:06:05 INFO - PID 4073 | 17:06:05 INFO - PID 4073 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:2.64 (2.4%) stddev-sans-first:0.93 17:06:05 INFO - PID 4073 | Values: 104.0 113.0 113.0 113.0 112.0 111.0 111.0 111.0 111.0 112.0 17:06:05 INFO - PID 4073 | 17:06:05 INFO - PID 4073 | [#1] audio-beat-detection Cycles:10 Average:135.50 Median:126.00 stddev:19.94 (15.8%) stddev-sans-first:19.25 17:06:05 INFO - PID 4073 | Values: 159.0 123.0 124.0 180.0 126.0 124.0 123.0 123.0 147.0 126.0 17:06:05 INFO - PID 4073 | 17:06:05 INFO - PID 4073 | [#2] audio-dft Cycles:10 Average:166.00 Median:165.50 stddev:3.83 (2.3%) stddev-sans-first:4.04 17:06:05 INFO - PID 4073 | Values: 165.0 163.0 164.0 166.0 166.0 176.0 163.0 164.0 165.0 168.0 17:06:05 INFO - PID 4073 | 17:06:05 INFO - PID 4073 | [#3] audio-fft Cycles:10 Average:79.90 Median:75.50 stddev:9.93 (13.1%) stddev-sans-first:10.30 17:06:05 INFO - PID 4073 | Values: 74.0 75.0 74.0 100.0 77.0 74.0 74.0 76.0 97.0 78.0 17:06:05 INFO - PID 4073 | 17:06:05 INFO - PID 4073 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:84.00 stddev:9.87 (11.8%) stddev-sans-first:10.24 17:06:05 INFO - PID 4073 | Values: 84.0 85.0 104.0 84.0 83.0 83.0 98.0 85.0 84.0 109.0 17:06:05 INFO - PID 4073 | 17:06:05 INFO - PID 4073 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:1.16 (1.0%) stddev-sans-first:1.22 17:06:05 INFO - PID 4073 | Values: 114.0 115.0 114.0 114.0 113.0 114.0 115.0 117.0 113.0 114.0 17:06:05 INFO - PID 4073 | 17:06:05 INFO - PID 4073 | [#6] imaging-darkroom Cycles:10 Average:151.30 Median:151.50 stddev:1.25 (0.8%) stddev-sans-first:1.32 17:06:05 INFO - PID 4073 | Values: 151.0 152.0 152.0 154.0 152.0 151.0 151.0 150.0 150.0 150.0 17:06:05 INFO - PID 4073 | 17:06:05 INFO - PID 4073 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 17:06:05 INFO - PID 4073 | Values: 95.0 95.0 95.0 94.0 94.0 95.0 94.0 94.0 94.0 94.0 17:06:05 INFO - PID 4073 | 17:06:05 INFO - PID 4073 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.50 stddev:0.79 (1.4%) stddev-sans-first:0.83 17:06:05 INFO - PID 4073 | Values: 54.0 53.0 54.0 54.0 55.0 55.0 55.0 53.0 55.0 54.0 17:06:05 INFO - PID 4073 | 17:06:05 INFO - PID 4073 | [#9] json-stringify-tinderbox Cycles:10 Average:55.90 Median:56.00 stddev:0.74 (1.3%) stddev-sans-first:0.78 17:06:05 INFO - PID 4073 | Values: 56.0 57.0 57.0 56.0 55.0 56.0 56.0 56.0 55.0 55.0 17:06:05 INFO - PID 4073 | 17:06:05 INFO - PID 4073 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:82.50 stddev:3.09 (3.7%) stddev-sans-first:3.27 17:06:05 INFO - PID 4073 | Values: 82.0 91.0 81.0 83.0 81.0 82.0 80.0 83.0 81.0 83.0 17:06:05 INFO - PID 4073 | 17:06:05 INFO - PID 4073 | [#11] stanford-crypto-ccm Cycles:10 Average:144.20 Median:136.50 stddev:28.97 (21.2%) stddev-sans-first:30.57 17:06:05 INFO - PID 4073 | Values: 136.0 137.0 140.0 130.0 141.0 134.0 135.0 132.0 226.0 131.0 17:06:05 INFO - PID 4073 | 17:06:05 INFO - PID 4073 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.20 Median:194.50 stddev:4.52 (2.3%) stddev-sans-first:3.69 17:06:05 INFO - PID 4073 | Values: 185.0 195.0 200.0 189.0 194.0 192.0 191.0 197.0 191.0 198.0 17:06:05 INFO - PID 4073 | 17:06:05 INFO - PID 4073 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.20 Median:72.50 stddev:1.69 (2.3%) stddev-sans-first:1.79 17:06:05 INFO - PID 4073 | Values: 72.0 73.0 72.0 70.0 73.0 71.0 73.0 76.0 71.0 71.0 17:06:05 INFO - PID 4073 | -------- Summary: end -------- 17:06:05 INFO - PID 4073 | 17:06:06 INFO - TEST-INFO | 4073: exit 0 17:06:06 INFO - TEST-OK | kraken | took 63767ms 17:06:06 INFO - SUITE-END | took 1185s 17:06:07 INFO - Completed test suite (00:19:46) 17:06:07 INFO - javascript benchmark 17:06:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6756.628032780373, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2743.2318950693807, 2746.5880117982288, 2760.171948415476, 2764.4194719108987, 2771.750542451178, 5194.818181363653, 5289.391719952207, 5304.6286759926825, 5324.920126198101, 5342.358916929969, 5298.841034768953, 5300.761465734042, 5327.840164795052, 5381.54256888164, 5389.353277606692, 4427.651694051545, 4712.505186955372, 4717.410323709536, 4733.384659994196, 4747.287906813971, 4756.595689366391, 4778.283257511366, 4814.518548145193, 4818.10864989978, 4825.710457372551, 4648.930266046012, 4694.155052090622, 4720.645951553647, 4731.408573928259, 4779.569838714532, 4718.363020992157, 4718.551737584959, 4744.786484608201, 4785.114753770529, 4785.976070119662, 4609.838655647036, 4629.930551041737, 4635.397398338195, 4663.114008338405, 4678.7426691531955, 5187.144121220032, 5223.112070947948, 5259.368875734936, 5262.05283049051, 5315.7873685052555, 5685.488306052475, 5686.914696279559, 5690.943090569124, 5694.430556944314, 5694.743736531825, 5722.055860782966, 5734.713264336767, 5736.426357364272, 5737.713114344266, 5741.971290143564, 5245.7114858683135, 5295.761690723926, 5302.151655735141, 5304.071787437183, 5310.203469479609, 5791.276090488689, 5832.591718579659, 5841.036229022248, 5844.766209351664, 5852.414758524199, 5573.331200255995, 5587.916181257285, 5600.691961942132, 5681.091025435993, 5683.516901063456, 5680.750234948305, 5691.715414229272, 5700.771969121189, 5709.68596727184, 5717.342505611825, 5605.943940560624, 5608.551315894719, 5629.7185140742795, 5630.0, 5649.830505084854, 5550.72246387679, 5600.663960162403, 5612.915806262828, 5625.549956003591, 5730.484256416942, 4787.808487660454, 4794.640401969867, 4795.088933102699, 4801.063792560487, 4845.030993801183, 4099.426080348753, 4134.421181034658, 4150.730202536825, 4154.169166166779, 4216.7259128156575, 4819.59033482151, 4838.225883858566, 4895.804167833318, 4895.804167833318, 4926.605871530341, 5761.596688231783, 5764.769409223584, 5775.16260142277, 5777.364489906107, 5802.3037235531165, 4913.0, 4923.556879880756, 4925.21196608541, 4925.630577706686, 4973.626977976666, 5002.89994200114, 5070.492950705047, 5085.186370180753, 5131.4868513148385, 5131.486851314913, 5266.499682530153, 5301.807093403953, 5315.0964336063735, 5335.0, 5344.812931547377, 5694.430556944272, 5695.0, 5713.657180569179, 5723.971380143073, 5805.361410244954, 5292.920606190987, 5341.771392579806, 5356.3572371315695, 5375.758090885998, 5383.973080134574, 5606.131049687305, 5631.521320687787, 5632.0, 5653.717314134195, 5653.802116925888, 5666.716664166857, 5720.427957204246, 5741.224934633771, 5750.932556701469, 5806.9419305806405, 5533.031719449, 5535.25274087993, 5536.501714845522, 5536.806211782568, 5537.0, 5445.156000819879, 5497.45025497447, 5508.421615730291, 5513.062779327443, 5529.640573362719, 5415.431379705232, 5420.430854760193, 5446.618736688394, 5446.754896029609, 5448.645838020516, 5504.972475137599, 5518.978988887069, 5557.805476808292, 5560.888782224414, 5563.749631266522, 5381.892362152813, 5456.127019676833, 5486.1222204447095, 5504.146857237135, 5517.889642207214], "value": 5174.766179600226, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.5915977135548, 622.1569772957642, 987.1017374189489, 1007.2445665750691, 1075.2526993739355, 33075.66924330756, 33993.66006339936, 34039.82980085096, 34146.0, 34153.82923085387, 31337.686623133763, 31549.211269718267, 31560.68439315606, 31811.840940795322, 31815.681843181563, 6335.841603959915, 6403.327650596691, 6440.0, 6453.064305675674, 7154.8569028619395, 7095.503314767969, 7191.9640401797915, 7193.208747037822, 7196.676149573255, 7197.208307086243, 7159.24827893069, 7217.711291548332, 7237.529560578546, 7237.963810180941, 7238.891416628755, 7088.326608972139, 7175.784726458189, 7187.137543494762, 7196.676149573282, 7209.243029481881, 7031.718731250744, 7079.0, 7132.643367831588, 7134.108236470442, 7134.464915131386, 32223.83888080568, 32291.51562726561, 32408.18979525507, 32518.83740581282, 32674.608689566194, 3106.1458099022725, 3129.217695576106, 3132.5144602586633, 3139.6703346148784, 3145.402373549018, 24805.13182038638, 24965.375865603324, 24988.12541561055, 25001.4999700005, 25162.748372516224, 3212.4538828399227, 3231.482962725976, 3245.1562593725566, 3247.318063206729, 3248.7563432742404, 142214.0, 142994.0, 143030.28484857612, 143067.0, 143589.0, 33180.50229246563, 33934.83032584821, 39428.80285598554, 41524.79237603793, 41551.7922410386, 41525.37711934323, 41554.79222603868, 41612.58387416148, 41669.0, 42046.78976605159, 12557.309347985949, 12681.429335679917, 12690.873091269154, 12693.809592856114, 12694.555690550786, 10076.294659373774, 10144.188464922789, 10144.391336519833, 10158.949205254074, 10170.440625765506, 12005.399730013465, 12046.698832529082, 12057.336846473352, 12062.336571488653, 12192.512299508098, 5038.521340472649, 5110.26600768587, 5125.384953805493, 5249.084084309276, 5255.08036093682, 861.6510313323114, 912.28385717213, 915.1077699243185, 921.3504479342048, 944.3200895355333, 20577.794222057888, 20907.37277881666, 21453.141874325163, 22055.779442205694, 22060.448488787908, 980.5636491761098, 991.2961797124123, 996.6461906023402, 1008.5058321422597, 1010.1363334349172, 11090.5563777448, 11222.438878056064, 11527.884721152848, 11529.250598711225, 11665.475053622607, 170267.0, 170380.0, 170863.0, 170869.0, 171118.0, 40798.38802417966, 41070.0, 41127.7943610286, 41302.1739565207, 41423.378649320286, 1197.024425093546, 1238.6160290310033, 1246.5387806511467, 1249.5189352099508, 1262.4129779652505, 19999.20003199914, 20725.79274207299, 21248.893755531124, 21469.785302146778, 21703.457413564156, 29512.409751805273, 29571.704282956896, 29587.112386628436, 29592.0, 29675.55486667745, 150116.0, 151499.0, 152291.238543811, 152330.0, 152537.0, 27446.313842154104, 27865.721342786313, 27943.441131177668, 29677.5548366779, 29726.25684357908, 36950.07624809401, 36973.63026369702, 37292.813535932146, 37337.0665733348, 37434.25131497409, 26087.869560652074, 27493.587596185673, 27676.861615691792, 27844.30389240285, 28355.291117722223, 27309.86345068262, 27894.44211115807, 28503.14490565286, 28776.992805251717, 29142.708572913998, 30712.089779799368, 30894.0, 30982.84508577443, 31093.8445307772, 31118.22204444907, 26221.868890655423, 26430.86784566065, 26581.867090664422, 27174.72825271801, 28214.71785282121, 20036.69944950856, 22553.436164095372, 22740.545189096458, 22839.972201251316, 23038.193663222377], "value": 14510.52056193005, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.0008038026815, 397.3027337023523, 411.8105671391161, 416.9791510424478, 432.15082363156404, 17705.203265853037, 18400.987945662982, 18410.723839142425, 18673.719894201597, 19437.70843437346, 16983.57541061474, 17175.227114779835, 17213.0, 18038.098095095258, 18212.362567310145, 5416.837494875141, 5609.831705048855, 5629.549636029128, 5633.887322253552, 5809.215755872945, 5544.77820887164, 5548.195511650808, 5557.416471270499, 5562.721863906809, 5570.3315602127805, 5418.431064738204, 5481.972590137044, 5509.696966666832, 5510.504054635082, 5545.085060964936, 5543.77824887004, 5544.944550554504, 5561.443855614447, 5575.470330318633, 5577.163425486169, 4967.776450059756, 5074.517920797518, 5136.486351364871, 5141.126008578551, 5141.562967147797, 22151.667724984138, 22545.549089018292, 22626.88686556573, 22649.2072777452, 22799.886000570055, 1642.8192898781124, 1680.4454530005069, 1691.4249155287139, 1696.762453256545, 1696.9745453818202, 14737.0, 14917.776233356508, 15366.692666146726, 15377.692446151126, 15585.220738963006, 2025.2709024751077, 2122.1935664447565, 2132.2750264910005, 2137.5190582119053, 2144.710464087344, 88709.55645221798, 93929.0, 94252.0574794257, 94518.52740736322, 95148.0, 11104.111671066295, 11225.117074072641, 11365.204435689588, 11450.312981221154, 11577.768444631229, 15756.448524301824, 15835.762463563056, 15862.365505379887, 15879.841201588068, 15881.205939702968, 7419.0, 7645.311921926942, 7728.149903510609, 7802.68789248435, 7821.6089195541135, 6807.965960170168, 6814.659267036727, 6906.723731050803, 7097.183823860219, 7129.536580122275, 6972.0, 7052.9647351762915, 7057.541259818096, 7130.679119439637, 7148.428125749928, 2134.10223536983, 2151.946201344979, 2152.483403983033, 2166.274298110119, 2273.9204127855446, 848.4485084694875, 878.1832895407332, 883.1036497954581, 886.5124181700039, 909.1136142261374, 16811.41160059392, 16945.830541694424, 17058.31766729317, 17357.826421735874, 18067.819321806615, 882.9911700883038, 891.585412783059, 898.9370744047985, 905.103947092387, 918.2745630951473, 9139.543022848831, 9526.095020972996, 9598.808023839623, 9682.854757178648, 9741.464219467856, 343863.0, 353508.0, 356623.0, 358082.0, 359239.0, 69802.3019769806, 70953.0, 71076.64461677658, 71890.64054679693, 72852.63573682097, 1045.900639439252, 1073.3667136389568, 1110.655696734015, 1142.8628564572305, 1143.588308209044, 17748.20133093988, 18102.275908963493, 18608.0, 18750.531236718645, 18909.054547272855, 39306.0, 39363.015924602114, 40503.392449112696, 40592.594074058885, 41150.176996460505, 47163.528364717284, 47225.0, 47566.524334757596, 47603.28595071146, 49555.75222123866, 8278.958605206935, 8310.168983101641, 8575.656973720981, 8815.338849586178, 8829.823403531766, 13044.608661740163, 13249.271290079138, 13394.397252123483, 13502.797458038334, 13636.727265454834, 11265.605703800327, 11415.315081095161, 11632.53469861196, 11778.646640600795, 11949.402529873645, 10579.576816927236, 10719.517621707198, 10810.0, 10945.124390048937, 11160.10719142483, 11568.305901645928, 11588.536458541565, 11749.412529373669, 11785.233959792586, 12190.6952326189, 8371.0, 8472.110428404929, 8508.40441169137, 8642.611082501428, 8730.869036964323, 11011.83482247783, 11019.614313498989, 11469.770604588028, 11478.827817582576, 11586.362750048827], "value": 9005.078678301868, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1224.5958833584916, 1274.9872501274986, 1283.4417028592568, 1283.454531823974, 1293.5213970830791, 9080.318976076796, 9402.529873506315, 9418.905810941897, 9423.010583888687, 9708.466034368106, 9477.336586438953, 9614.615415383394, 9620.086091821284, 9646.180074693642, 9654.034596540343, 2146.6994620753067, 2193.6270833958265, 2195.4401627584944, 2199.593075281078, 2200.427888748921, 2098.842586805988, 2146.034284571941, 2147.38799442159, 2163.642998905179, 2165.5127596290868, 2109.050927082811, 2125.5642593268344, 2152.87082775034, 2154.256781410411, 2160.2115227941767, 2075.4915045813723, 2089.0703636881594, 2092.654711972523, 2092.843036772233, 2110.4407332057017, 2002.3592450415872, 2017.576308975117, 2050.261905713942, 2058.310465993894, 2141.507453285753, 9310.162085412345, 9428.575714092814, 9463.905360946372, 9481.099295566979, 9494.098060684224, 5288.0745869472685, 5482.753276102585, 5489.6980666063355, 5494.423085575997, 5498.80754173602, 3325.5177999190223, 3378.7803792753393, 3466.2027733621408, 3506.0533655913014, 3514.5782506099176, 1177.211268450132, 1210.1710328425056, 1229.6126720083234, 1241.2862604002735, 1261.4954018392625, 13397.0, 13468.595942121752, 13546.93226533861, 13598.796018059737, 13675.521356752466, 4959.752012399365, 5005.799768009311, 5117.283580298761, 5118.283440318359, 5140.640155189176, 11449.141314401453, 11558.479868405942, 11563.248388854698, 11578.594749183907, 11614.0, 5445.156000819879, 5447.836564903059, 5500.257465242221, 5508.91736623951, 5513.255710479114, 4713.410823647044, 4790.353302304145, 4853.830115945925, 4902.460729319772, 4984.22744474607, 3667.5598928128798, 3866.149447121629, 3885.1452680410266, 3932.9016774580864, 3955.92088158241, 1096.0847692176962, 1111.4664960818852, 1124.145649306533, 1125.994370028161, 1135.1316243074054, 687.8211664967145, 711.1608302203347, 712.8467379513326, 726.6040008195546, 728.621117019147, 5153.227015947563, 5286.048511268009, 5296.549793267615, 5331.4935081168005, 5381.569474442035, 570.8258981010748, 572.0475408444893, 575.4130786597647, 578.4938179093293, 580.94771470567, 3398.252384475461, 3455.2398472336045, 3636.7999760013454, 3756.4365345197893, 3824.1204522959874, 11599.76800464003, 12116.939415303043, 12250.203736757083, 12262.20295680778, 12276.508939642494, 11761.588344407905, 11961.760764784656, 12019.819702704466, 12203.389830508439, 12236.204646697935, 6931.0, 6955.582665040114, 7070.646467676595, 7103.289671032855, 7123.643817809192, 5974.2233509643465, 6090.634561926298, 6124.601900876429, 6130.6628135452975, 6145.877082458415, 10684.358938463716, 10915.727106822393, 11063.229883218646, 11204.383758893338, 11263.66209013731, 11198.83201751958, 11203.21577489568, 11334.829977550178, 11386.259893106922, 11393.715157121138, 7546.9245307546225, 7930.206979302255, 7947.125816160102, 7949.960250198712, 8029.277365037175, 8918.331125165509, 8961.193492585699, 9021.0, 9032.86450703227, 9091.045440228681, 7566.508176968479, 7726.497777644435, 7809.101953275219, 7816.6091695416135, 7953.164917683791, 7302.671379788028, 7722.922770772445, 7740.7677769667, 7742.303192712683, 7879.172686867796, 6935.618540980295, 7134.464915131282, 7149.82125446868, 7150.678219480032, 7160.57036577807, 4670.855640368131, 5112.130937740519, 5165.354330708661, 5187.688738675692, 5192.480751924777, 5038.974805125951, 5050.671706339076, 5143.305653736697, 5151.0, 5217.295665085165], "value": 4544.626071640566, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.2234862659978, 385.0047626884505, 386.10616422980814, 390.91009067914376, 394.0601665028906, 5451.727413629317, 5574.331080270368, 5581.944180558193, 5589.552835773138, 5600.831975040745, 5315.468453154683, 5441.068420710641, 5441.59188060895, 5445.945540544593, 5458.590605704569, 4243.596858298472, 4247.469066366704, 4249.893752656178, 4268.509121451027, 4277.08042770805, 4244.151169766059, 4256.4253825733595, 4265.0, 4268.637165840907, 4269.231538323101, 4121.4848143982, 4203.327467605184, 4232.449781528412, 4253.1706317268145, 4257.19113368459, 4203.327467605199, 4221.472315960505, 4223.746575205498, 4251.511076226243, 4263.445752052229, 3816.751911125768, 3818.5608655004476, 3828.157805282833, 3845.0964023454467, 3845.1732877431205, 5205.089109405877, 5424.1321388577635, 5433.1035379162395, 5452.727363631802, 5462.863428414282, 4844.103840789465, 4858.955324605226, 4865.19724245499, 4876.853694389139, 4898.853034408973, 5858.707064646751, 5866.530677545786, 5874.73563689635, 5891.705414729289, 5892.793752218695, 3907.4529565860803, 3977.9204415911518, 4046.9392959105635, 4058.5129784425762, 4060.2488539620263, 6033.577649564532, 6132.386761323832, 6177.81466556004, 6214.906776398358, 6272.9336012878375, 4544.954550454519, 4632.606228470618, 4636.953630463652, 4640.95359046412, 4646.976765116153, 4677.579017888338, 4687.8670205056615, 4696.319033740088, 4727.149113159596, 4733.597644200281, 5052.393712754493, 5159.884447376558, 5172.27588137661, 5218.947810521922, 5220.034293655686, 5849.415058494116, 5874.41390824475, 5880.794172204038, 5892.469677728939, 5897.203877476486, 1618.6924484347937, 1618.8785841061967, 1641.4501142117285, 1647.62104715916, 1655.4785242648527, 1108.2242430298822, 1158.2124155574122, 1179.4161889864572, 1181.6868529839599, 1208.3112625803383, 5082.440931497532, 5083.74581270935, 5106.821261255913, 5118.97440512795, 5119.48805119485, 6041.939580604226, 6070.362611925684, 6086.695665216722, 6090.208272924491, 6098.444896551439, 4960.975195124001, 5076.466970968069, 5098.796048158032, 5130.230465430141, 5138.897222055538, 3193.696598823108, 3222.38774632819, 3239.627442844056, 3245.496947973068, 3249.268914494267, 5517.834464966058, 5555.777768889199, 5589.74846131925, 5606.962711898312, 5680.715964201773, 6181.002213926242, 6193.349698281706, 6194.845128871724, 6224.906626400608, 6248.343923888017, 5531.478843318119, 5622.437756224426, 5637.408072152447, 5649.519790817744, 5655.660660360391, 6039.577229593886, 6086.573939824347, 6092.482139018233, 6107.541934354852, 6114.419130182626, 5851.64890106595, 5985.491233245223, 5995.61028533144, 5997.760089596542, 6001.699915004319, 5651.6043876928225, 5677.5457963362005, 5680.801171958961, 5681.17622944679, 5702.6293290935955, 4121.216968775923, 4164.916701665889, 4167.74993500391, 4171.499420069611, 4174.91650167001, 6005.666854895575, 6088.360722124113, 6123.357047509948, 6159.121467952317, 6161.15165450372, 5891.351951285269, 5914.792982245601, 5921.936744083746, 5942.227510423791, 5952.0, 5706.657600543981, 5857.765689372548, 5912.733926973383, 5915.31413547137, 5924.31870334917, 5748.827535173951, 5764.308283006066, 5803.8549036274435, 5805.680687562224, 5819.738111785065, 5911.024680927599, 5916.467517923235, 5920.549465381009, 5927.407259274038, 5951.940480595312, 5568.972155139199, 5692.658440493584, 5759.107338362561, 5765.106408506688, 5774.133879918046], "value": 4464.380896306601, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [695.6208866167939, 699.0353312428846, 708.9397401220896, 752.4695089961577, 776.6699152860036, 12312.261264324146, 12859.742805143891, 13552.18686878788, 14488.130712157277, 14491.0, 15083.472078477256, 15097.245137743124, 15686.13726245056, 15732.84267157328, 15796.973196742203, 894.1773568317132, 908.9181973622373, 917.8026724254285, 917.9770505737343, 920.5259291464901, 919.7148883845996, 920.4017388697367, 925.7315378540216, 926.1294383279695, 926.1386910173536, 955.8375076237022, 962.5476026267643, 962.9807403851919, 965.3194497878978, 968.4673429613684, 943.664998925382, 946.4888959961612, 947.209080417852, 950.2777888804524, 953.7043516509904, 700.1318365227132, 706.1455638677206, 706.4807366585555, 706.731442052017, 706.8162277807755, 14820.184889831055, 14969.850301496954, 15413.922930385388, 15535.844641553553, 15555.922220388939, 15712.135832529206, 15779.92110039454, 15807.130607816565, 15893.364265429369, 15901.1254381009, 11231.438428078563, 11495.1378646601, 11499.942500287529, 11559.711007224803, 11611.187216894821, 2937.8971735989353, 2940.426616809723, 2958.3787404644836, 2958.60058892049, 2970.212893583202, 71313.64343178303, 71904.2809571908, 72031.0, 72282.0, 73835.63082184609, 12240.877591224153, 12337.013038956862, 12373.381330933418, 12437.564685235973, 12474.18917770342, 22409.439764005703, 22984.885075574515, 23064.654030189562, 23167.53664926726, 23201.53596928052, 5910.379410161871, 6240.0, 6251.281102673251, 6299.748010079637, 6330.208723909512, 3052.4047810676707, 3118.937621247562, 3138.8901388451295, 3146.354997225609, 3146.606674165729, 3462.272922686214, 3538.4515400113023, 3557.3418917500344, 3574.5353104096303, 3698.8335524900904, 755.1202848681224, 761.4365369626547, 767.4742801181209, 773.961301934901, 775.0079897730801, 621.7844114755642, 635.5011316116919, 641.5252712992352, 642.5309524047472, 657.2802780954847, 10034.147097496649, 10320.019598138166, 10460.790784184426, 10915.345079295268, 11072.61938683187, 637.2894222941387, 642.408983734965, 646.1051443750439, 646.6734299178885, 650.1937597379216, 4419.160359531678, 4574.108048930427, 4635.675502714777, 4764.666473346832, 4792.0, 62190.0, 63657.68171159115, 64489.35510644927, 67166.32833671698, 67611.88657361148, 56325.7183714087, 56398.1540276888, 56666.43333566694, 57248.141277880866, 58325.416745832845, 52623.21065184102, 53041.7347913258, 53286.20777571735, 53316.46683533193, 53743.46256537385, 9000.36997410175, 9133.086691330815, 9312.394694344846, 9464.716058518256, 9577.23382129414, 27624.585631215145, 28236.71763282341, 28340.433191335644, 28392.290192745346, 28845.134645960654, 33018.33963320768, 33062.5040624386, 44680.55319446894, 44757.776211120035, 45754.0, 14045.929770351082, 14212.715745685235, 14324.713505730035, 14463.421463141356, 14514.056586321854, 13657.795133072814, 14175.787363189354, 14479.855201448272, 14615.707685846011, 14737.557873263819, 13487.05590608648, 13580.25308608036, 13796.586102416944, 14394.352254148798, 14691.55925322242, 13759.380827862971, 14346.354414051184, 14664.266786660412, 14787.186704731343, 14826.0, 12962.416691248727, 12995.350232488527, 13051.477940882258, 13318.134321269086, 13634.0, 9690.0, 9698.70903872885, 9724.611015559298, 9868.97685974388, 9947.751306217402, 10942.671719848417, 11089.667309980714, 11329.943350283196, 11485.942570287096, 11585.594504192313], "value": 6934.69797028186, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1544.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 113.0, 113.0, 112.0, 111.0, 111.0, 111.0, 111.0, 112.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 123.0, 124.0, 180.0, 126.0, 124.0, 123.0, 123.0, 147.0, 126.0], "value": 135.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 164.0, 166.0, 166.0, 176.0, 163.0, 164.0, 165.0, 168.0], "value": 166.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 100.0, 77.0, 74.0, 74.0, 76.0, 97.0, 78.0], "value": 79.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 104.0, 84.0, 83.0, 83.0, 98.0, 85.0, 84.0, 109.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 113.0, 114.0, 115.0, 117.0, 113.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 152.0, 152.0, 154.0, 152.0, 151.0, 151.0, 150.0, 150.0, 150.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, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 54.0, 55.0, 55.0, 55.0, 53.0, 55.0, 54.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 57.0, 56.0, 55.0, 56.0, 56.0, 56.0, 55.0, 55.0], "value": 55.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 91.0, 81.0, 83.0, 81.0, 82.0, 80.0, 83.0, 81.0, 83.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 137.0, 140.0, 130.0, 141.0, 134.0, 135.0, 132.0, 226.0, 131.0], "value": 144.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 195.0, 200.0, 189.0, 194.0, 192.0, 191.0, 197.0, 191.0, 198.0], "value": 193.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 72.0, 70.0, 73.0, 71.0, 73.0, 76.0, 71.0, 71.0], "value": 72.2, "unit": "score"}]}]} 17:06:07 INFO - Return code: 0 17:06:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:06:07 INFO - # TBPL SUCCESS # 17:06:07 INFO - Running post-action listener: _resource_record_post_action 17:06:07 INFO - [mozharness: 2017-05-09 00:06:07.193565Z] Finished run-tests step (success) 17:06:07 INFO - Running post-run listener: _resource_record_post_run 17:06:07 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 7847936; Write bytes: 357265408; Read time: 1960; Write time: 304924 17:06:07 INFO - TinderboxPrint: CPU usage
13.3% 17:06:07 INFO - TinderboxPrint: I/O read bytes / time
7,847,936 / 1,960 17:06:07 INFO - TinderboxPrint: I/O write bytes / time
357,265,408 / 304,924 17:06:07 INFO - TinderboxPrint: CPU idle
8,310.2 (86.7%) 17:06:07 INFO - TinderboxPrint: CPU user
1,217.6 (12.7%) 17:06:07 INFO - TinderboxPrint: Swap in / out
0 / 0 17:06:07 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 4096; Write bytes: 96845824; Read time: 136; Write time: 106284 17:06:07 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 5623808; Write bytes: 255459328; Read time: 1632; Write time: 197872 17:06:07 INFO - Running post-run listener: _upload_blobber_files 17:06:07 INFO - Blob upload gear active. 17:06:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:06:07 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 17:06:07 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'] 17:06:07 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 17:06:08 INFO - (blobuploader) - INFO - Open directory for files ... 17:06:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:06:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:06:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:06:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:06:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:06:08 INFO - (blobuploader) - INFO - Done attempting. 17:06:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:06:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:06:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:06:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:06:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:06:09 INFO - (blobuploader) - INFO - Done attempting. 17:06:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:06:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:06:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:06:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:06:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:06:10 INFO - (blobuploader) - INFO - Done attempting. 17:06:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:06:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:06:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:06:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:06:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:06:13 INFO - (blobuploader) - INFO - Done attempting. 17:06:13 INFO - (blobuploader) - INFO - Iteration through files over. 17:06:13 INFO - Return code: 0 17:06:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:06:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:06:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7cd5dc5555333a218e219192d79ede7ad1aa377162e76d7bed96665be9b910b816b3da5904100c3461c718b96b8edace47031af4a2dbde067050698d7cf3f0c0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/52352ea4d9492d4513bc3c572027d970b24d262a3d2f7b1dd25686193f6fb62cd1631fb12c4e693222e65be7b5117c8a1e409afeb6d6269eb91560a08278579b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a002605990a8a876c2b7affe09e3a1fa115f9c8a9c5465a96f47e9812c67ebc26b472f11468860792e18a503982e49d688f2bf270c7c77b6cf165b626d6d96f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a36660650641949ebbd34547ff9d028c144d3af23b538d1979536d09b30f2da66a99dd1d23f019d9d8045ef9640342b9ad8f27769b3a094d75821feac414f837"} 17:06:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:06:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:06:13 INFO - Contents: 17:06:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7cd5dc5555333a218e219192d79ede7ad1aa377162e76d7bed96665be9b910b816b3da5904100c3461c718b96b8edace47031af4a2dbde067050698d7cf3f0c0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/52352ea4d9492d4513bc3c572027d970b24d262a3d2f7b1dd25686193f6fb62cd1631fb12c4e693222e65be7b5117c8a1e409afeb6d6269eb91560a08278579b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a002605990a8a876c2b7affe09e3a1fa115f9c8a9c5465a96f47e9812c67ebc26b472f11468860792e18a503982e49d688f2bf270c7c77b6cf165b626d6d96f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a36660650641949ebbd34547ff9d028c144d3af23b538d1979536d09b30f2da66a99dd1d23f019d9d8045ef9640342b9ad8f27769b3a094d75821feac414f837"} 17:06:13 INFO - Running post-run listener: copy_logs_to_upload_dir 17:06:13 INFO - Copying logs to upload dir... 17:06:13 INFO - mkdir: /builds/slave/test/build/upload/logs 17:06:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.220062 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-05-08 17:06:13.569174) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-08 17:06:13.576852) ========= 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=6d15e502d8e29d5d2676d664000001c3-1494286909.237107-2028962057 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/7cd5dc5555333a218e219192d79ede7ad1aa377162e76d7bed96665be9b910b816b3da5904100c3461c718b96b8edace47031af4a2dbde067050698d7cf3f0c0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/52352ea4d9492d4513bc3c572027d970b24d262a3d2f7b1dd25686193f6fb62cd1631fb12c4e693222e65be7b5117c8a1e409afeb6d6269eb91560a08278579b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a002605990a8a876c2b7affe09e3a1fa115f9c8a9c5465a96f47e9812c67ebc26b472f11468860792e18a503982e49d688f2bf270c7c77b6cf165b626d6d96f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a36660650641949ebbd34547ff9d028c144d3af23b538d1979536d09b30f2da66a99dd1d23f019d9d8045ef9640342b9ad8f27769b3a094d75821feac414f837"} build_url:https://queue.taskcluster.net/v1/task/YB2o5iqdTgO8iKyjTRdTyA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011070 build_url: 'https://queue.taskcluster.net/v1/task/YB2o5iqdTgO8iKyjTRdTyA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7cd5dc5555333a218e219192d79ede7ad1aa377162e76d7bed96665be9b910b816b3da5904100c3461c718b96b8edace47031af4a2dbde067050698d7cf3f0c0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/52352ea4d9492d4513bc3c572027d970b24d262a3d2f7b1dd25686193f6fb62cd1631fb12c4e693222e65be7b5117c8a1e409afeb6d6269eb91560a08278579b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a002605990a8a876c2b7affe09e3a1fa115f9c8a9c5465a96f47e9812c67ebc26b472f11468860792e18a503982e49d688f2bf270c7c77b6cf165b626d6d96f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a36660650641949ebbd34547ff9d028c144d3af23b538d1979536d09b30f2da66a99dd1d23f019d9d8045ef9640342b9ad8f27769b3a094d75821feac414f837"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-08 17:06:13.602437) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 17:06:13.602828) ========= 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=6d15e502d8e29d5d2676d664000001c3-1494286909.237107-2028962057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004318 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 17:06:13.687228) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-08 17:06:13.687548) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-08 17:06:13.687846) ========= ========= Total master_lag: 0.18 =========