builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs slave: talos-linux64-ix-006 starttime: 1490797096.47 results: success (0) revision: c4392f466eaab690d9b0ef7bacf72fa5e6573007 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-29 07:18:16.466796) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-29 07:18:16.467272) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-29 07:18:16.467554) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-29 07:18:16.482252) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 07:18:16.482542) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1490797096.143068-716033130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-29 07:18:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.6M=0s 2017-03-29 07:18:16 (40.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.093889 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 07:18:16.590397) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 07:18:16.590726) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1490797096.143068-716033130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017920 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 07:18:16.639787) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-29 07:18:16.640102) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c4392f466eaab690d9b0ef7bacf72fa5e6573007 --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 c4392f466eaab690d9b0ef7bacf72fa5e6573007 --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=e31afd3c0f0de4e86ebe4d94000001b5-1490797096.143068-716033130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-29 07:18:17,034 truncating revision to first 12 chars 2017-03-29 07:18:17,034 Setting DEBUG logging. 2017-03-29 07:18:17,034 attempt 1/10 2017-03-29 07:18:17,034 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c4392f466eaa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-29 07:18:18,372 unpacking tar archive at: mozilla-central-c4392f466eaa/testing/mozharness/ program finished with exit code 0 elapsedTime=1.640149 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-29 07:18:18.293480) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-29 07:18:18.293807) ========= script_repo_revision: c4392f466eaab690d9b0ef7bacf72fa5e6573007 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-29 07:18:18.294210) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-29 07:18:18.294482) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-29 07:18:18.304560) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-03-29 07:18:18.304949) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1490797096.143068-716033130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:18:18 INFO - MultiFileLogger online at 20170329 07:18:18 in /builds/slave/test 07:18:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:18:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:18:18 INFO - {'append_to_log': False, 07:18:18 INFO - 'base_work_dir': '/builds/slave/test', 07:18:18 INFO - 'blob_upload_branch': 'Firefox', 07:18:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:18:18 INFO - 'branch': 'Firefox', 07:18:18 INFO - 'buildbot_json_path': 'buildprops.json', 07:18:18 INFO - 'config_files': ('talos/linux_config.py',), 07:18:18 INFO - 'default_actions': ('clobber', 07:18:18 INFO - 'read-buildbot-config', 07:18:18 INFO - 'download-and-extract', 07:18:18 INFO - 'populate-webroot', 07:18:18 INFO - 'create-virtualenv', 07:18:18 INFO - 'install', 07:18:18 INFO - 'run-tests'), 07:18:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:18:18 INFO - 'download_minidump_stackwalk': True, 07:18:18 INFO - 'download_symbols': 'ondemand', 07:18:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:18:18 INFO - 'tooltool.py': '/tools/tooltool.py', 07:18:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:18:18 INFO - '/tools/misc-python/virtualenv.py')}, 07:18:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:18:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:18:18 INFO - 'gecko_profile': False, 07:18:18 INFO - 'gecko_profile_interval': 0, 07:18:18 INFO - 'installer_path': 'installer.exe', 07:18:18 INFO - 'log_level': 'info', 07:18:18 INFO - 'log_name': 'talos', 07:18:18 INFO - 'log_to_console': True, 07:18:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:18:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:18:18 INFO - 'opt_config_files': (), 07:18:18 INFO - 'pip_index': False, 07:18:18 INFO - 'suite': 'dromaeojs', 07:18:18 INFO - 'system_bits': '32', 07:18:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:18:18 INFO - 'title': 'talos-linux64-ix-006', 07:18:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:18:18 INFO - 'use_talos_json': True, 07:18:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:18:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:18:18 INFO - 'work_dir': 'build'} 07:18:18 INFO - [mozharness: 2017-03-29 14:18:18.801392Z] Running clobber step. 07:18:18 INFO - Running pre-action listener: _resource_record_pre_action 07:18:18 INFO - Running main action method: clobber 07:18:18 INFO - rmtree: /builds/slave/test/build 07:18:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:18:19 INFO - Running post-action listener: _resource_record_post_action 07:18:19 INFO - [mozharness: 2017-03-29 14:18:19.790131Z] Finished clobber step (success) 07:18:19 INFO - [mozharness: 2017-03-29 14:18:19.790232Z] Running read-buildbot-config step. 07:18:19 INFO - Running pre-action listener: _resource_record_pre_action 07:18:19 INFO - Running main action method: read_buildbot_config 07:18:19 INFO - Using buildbot properties: 07:18:19 INFO - { 07:18:19 INFO - "project": "", 07:18:19 INFO - "product": "firefox", 07:18:19 INFO - "who": "ryanvm@gmail.com", 07:18:19 INFO - "installer_path": "public/build/target.tar.bz2", 07:18:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs", 07:18:19 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 07:18:19 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs", 07:18:19 INFO - "stage_platform": "linux64-stylo", 07:18:19 INFO - "basedir": "/builds/slave/test", 07:18:19 INFO - "buildnumber": 1, 07:18:19 INFO - "platform": "ubuntu64_hw_stylo", 07:18:19 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:18:19 INFO - "slavebuilddir": "test", 07:18:19 INFO - "taskId": "I5y_KjrqRyeetx0qqUcqaA", 07:18:19 INFO - "branch": "mozilla-central", 07:18:19 INFO - "script_repo_revision": "production", 07:18:19 INFO - "revision": "c4392f466eaab690d9b0ef7bacf72fa5e6573007", 07:18:19 INFO - "slavename": "talos-linux64-ix-006", 07:18:19 INFO - "repo_path": "mozilla-central" 07:18:19 INFO - } 07:18:19 INFO - Finding installer, test and symbols from parent task. 07:18:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I5y_KjrqRyeetx0qqUcqaA'}, attempt #1 07:18:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I5y_KjrqRyeetx0qqUcqaA'}, attempt #1 07:18:20 INFO - Task dependencies: Crwqb97NQPO9V41oSfMN8g 07:18:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Crwqb97NQPO9V41oSfMN8g'}, attempt #1 07:18:21 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Crwqb97NQPO9V41oSfMN8g/artifacts/public/build/target.tar.bz2 07:18:21 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Crwqb97NQPO9V41oSfMN8g/artifacts/public/build/test_packages.json 07:18:21 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Crwqb97NQPO9V41oSfMN8g/artifacts/public/build/target.crashreporter-symbols.zip 07:18:21 INFO - Running post-action listener: _resource_record_post_action 07:18:21 INFO - [mozharness: 2017-03-29 14:18:21.177636Z] Finished read-buildbot-config step (success) 07:18:21 INFO - [mozharness: 2017-03-29 14:18:21.177862Z] Running download-and-extract step. 07:18:21 INFO - Running pre-action listener: _resource_record_pre_action 07:18:21 INFO - Running main action method: download_and_extract 07:18:21 INFO - mkdir: /builds/slave/test/build/tests 07:18:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:21 INFO - trying https://queue.taskcluster.net/v1/task/Crwqb97NQPO9V41oSfMN8g/artifacts/public/build/target.test_packages.json 07:18:21 INFO - Downloading https://queue.taskcluster.net/v1/task/Crwqb97NQPO9V41oSfMN8g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:18:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Crwqb97NQPO9V41oSfMN8g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:18:21 INFO - Downloaded 986 bytes. 07:18:21 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:18:21 INFO - Using the following test package requirements: 07:18:21 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:18:21 INFO - u'common': [u'target.common.tests.zip'], 07:18:21 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:18:21 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:18:21 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:18:21 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:18:21 INFO - u'mozbase': [u'target.common.tests.zip'], 07:18:21 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:18:21 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:18:21 INFO - u'web-platform': [u'target.common.tests.zip', 07:18:21 INFO - u'target.web-platform.tests.zip'], 07:18:21 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:18:21 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 07:18:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Crwqb97NQPO9V41oSfMN8g/artifacts/public/build/target.common.tests.zip 07:18:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Crwqb97NQPO9V41oSfMN8g/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:18:21 INFO - Fetch https://queue.taskcluster.net/v1/task/Crwqb97NQPO9V41oSfMN8g/artifacts/public/build/target.common.tests.zip into memory 07:18:22 INFO - Expected file size: 58228706 07:18:22 INFO - Obtained file size: 58228706 07:18:32 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 07:18:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Crwqb97NQPO9V41oSfMN8g/artifacts/public/build/target.common.tests.zip 07:18:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Crwqb97NQPO9V41oSfMN8g/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:18:32 INFO - Fetch https://queue.taskcluster.net/v1/task/Crwqb97NQPO9V41oSfMN8g/artifacts/public/build/target.common.tests.zip into memory 07:18:34 INFO - Expected file size: 58228706 07:18:34 INFO - Obtained file size: 58228706 07:18:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Crwqb97NQPO9V41oSfMN8g/artifacts/public/build/target.talos.tests.zip 07:18:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Crwqb97NQPO9V41oSfMN8g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:18:44 INFO - Fetch https://queue.taskcluster.net/v1/task/Crwqb97NQPO9V41oSfMN8g/artifacts/public/build/target.talos.tests.zip into memory 07:18:45 INFO - Expected file size: 14404171 07:18:45 INFO - Obtained file size: 14404171 07:18:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:45 INFO - trying https://queue.taskcluster.net/v1/task/Crwqb97NQPO9V41oSfMN8g/artifacts/public/build/target.tar.bz2 07:18:45 INFO - Downloading https://queue.taskcluster.net/v1/task/Crwqb97NQPO9V41oSfMN8g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:18:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Crwqb97NQPO9V41oSfMN8g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:18:46 INFO - Downloaded 63983593 bytes. 07:18:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Crwqb97NQPO9V41oSfMN8g/artifacts/public/build/target.tar.bz2 07:18:46 INFO - mkdir: /builds/slave/test/properties 07:18:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:18:46 INFO - Writing to file /builds/slave/test/properties/build_url 07:18:46 INFO - Contents: 07:18:46 INFO - build_url:https://queue.taskcluster.net/v1/task/Crwqb97NQPO9V41oSfMN8g/artifacts/public/build/target.tar.bz2 07:18:46 INFO - Running post-action listener: _resource_record_post_action 07:18:46 INFO - Running post-action listener: set_extra_try_arguments 07:18:46 INFO - [mozharness: 2017-03-29 14:18:46.979102Z] Finished download-and-extract step (success) 07:18:46 INFO - [mozharness: 2017-03-29 14:18:46.979198Z] Running populate-webroot step. 07:18:46 INFO - Running pre-action listener: _resource_record_pre_action 07:18:46 INFO - Running main action method: populate_webroot 07:18:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:18:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:18:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:18:46 INFO - '--tppagecycles', 07:18:46 INFO - '7'], 07:18:46 INFO - 'tests': ['tsvgm']}}, 07:18:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:18:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:18:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:18:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:18:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:18:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:18:46 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:18:46 INFO - 'talos_options': ['--disable-e10s'], 07:18:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:18:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:18:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:18:46 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:18:46 INFO - 'talos_options': ['--disable-e10s'], 07:18:46 INFO - 'tests': ['damp', 'tps']}, 07:18:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:18:46 INFO - 'tests': ['damp', 'tps']}, 07:18:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:18:46 INFO - 'tests': ['dromaeo_dom']}, 07:18:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:18:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:18:46 INFO - 'tests': ['basic_compositor_video']}, 07:18:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:18:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:18:46 INFO - 'tests': ['a11yr', 07:18:46 INFO - 'ts_paint', 07:18:46 INFO - 'tpaint', 07:18:46 INFO - 'sessionrestore', 07:18:46 INFO - 'sessionrestore_no_auto_restore', 07:18:46 INFO - 'tabpaint']}, 07:18:46 INFO - 'other-e10s': {'tests': ['a11yr', 07:18:46 INFO - 'ts_paint', 07:18:46 INFO - 'tpaint', 07:18:46 INFO - 'sessionrestore', 07:18:46 INFO - 'sessionrestore_no_auto_restore', 07:18:46 INFO - 'tabpaint']}, 07:18:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:18:46 INFO - 'ts_paint', 07:18:46 INFO - 'tpaint', 07:18:46 INFO - 'sessionrestore', 07:18:46 INFO - 'sessionrestore_no_auto_restore', 07:18:46 INFO - 'tabpaint']}, 07:18:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:18:46 INFO - 'ts_paint', 07:18:46 INFO - 'tpaint', 07:18:46 INFO - 'sessionrestore', 07:18:46 INFO - 'sessionrestore_no_auto_restore', 07:18:46 INFO - 'tabpaint']}, 07:18:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:18:46 INFO - 'tests': ['a11yr', 07:18:46 INFO - 'ts_paint', 07:18:46 INFO - 'tpaint', 07:18:46 INFO - 'sessionrestore', 07:18:46 INFO - 'sessionrestore_no_auto_restore', 07:18:46 INFO - 'tabpaint']}, 07:18:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:18:46 INFO - 'tests': ['a11yr', 07:18:46 INFO - 'ts_paint', 07:18:46 INFO - 'tpaint', 07:18:46 INFO - 'sessionrestore', 07:18:46 INFO - 'sessionrestore_no_auto_restore', 07:18:46 INFO - 'tabpaint']}, 07:18:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:18:46 INFO - 'tests': ['tsvgx', 07:18:46 INFO - 'tsvgr_opacity', 07:18:46 INFO - 'tart', 07:18:46 INFO - 'tscrollx', 07:18:46 INFO - 'cart', 07:18:46 INFO - 'tsvg_static']}, 07:18:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:18:46 INFO - 'tsvgr_opacity', 07:18:46 INFO - 'tart', 07:18:46 INFO - 'tscrollx', 07:18:46 INFO - 'cart', 07:18:46 INFO - 'tsvg_static']}, 07:18:46 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:18:46 INFO - 'talos_options': ['--disable-e10s'], 07:18:46 INFO - 'tests': ['tp5o']}, 07:18:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:18:46 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:18:46 INFO - 'talos_options': ['--disable-e10s', 07:18:46 INFO - '--xperf_path', 07:18:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:18:46 INFO - 'tests': ['tp5n']}, 07:18:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:18:46 INFO - 'talos_options': ['--xperf_path', 07:18:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:18:46 INFO - 'tests': ['tp5n']}}, 07:18:46 INFO - 'talos.zip': {'path': '', 07:18:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:18:46 INFO - Running post-action listener: _resource_record_post_action 07:18:46 INFO - [mozharness: 2017-03-29 14:18:46.992381Z] Finished populate-webroot step (success) 07:18:46 INFO - [mozharness: 2017-03-29 14:18:46.992471Z] Running create-virtualenv step. 07:18:46 INFO - Running pre-action listener: _resource_record_pre_action 07:18:46 INFO - Running main action method: create_virtualenv 07:18:46 INFO - Creating virtualenv /builds/slave/test/build/venv 07:18:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:18:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:18:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:18:47 INFO - Using real prefix '/usr' 07:18:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:18:47 INFO - Installing distribute.............................................................................................................................................................................................done. 07:18:49 INFO - Installing pip.................done. 07:18:49 INFO - Return code: 0 07:18:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:18:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:18:49 INFO - Reading from file tmpfile_stdout 07:18:49 INFO - Output received: 07:18:49 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:18:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:18:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:49 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 0x17681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a06310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a03400>, '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 0x1a043b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a04840>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1490797096.143068-716033130', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:18:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:18:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:18:49 INFO - Using env: {'DISPLAY': ':0', 07:18:49 INFO - 'HOME': '/home/cltbld', 07:18:49 INFO - 'LANG': 'en_US.UTF-8', 07:18:49 INFO - 'LANGUAGE': 'en_US:en', 07:18:49 INFO - 'LOGNAME': 'cltbld', 07:18:49 INFO - 'MAIL': '/var/mail/cltbld', 07:18:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:49 INFO - 'MOZ_NO_REMOTE': '1', 07:18:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:49 INFO - 'NO_EM_RESTART': '1', 07:18:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:49 INFO - 'PWD': '/builds/slave/test', 07:18:49 INFO - 'SHELL': '/bin/bash', 07:18:49 INFO - 'SHLVL': '1', 07:18:49 INFO - 'TERM': 'linux', 07:18:49 INFO - 'TMOUT': '86400', 07:18:49 INFO - 'USER': 'cltbld', 07:18:49 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1490797096.143068-716033130', 07:18:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:49 INFO - '_': '/tools/buildbot/bin/python'} 07:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:18:50 INFO - Cleaning up... 07:18:50 INFO - Return code: 0 07:18:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a06310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a03400>, '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 0x1a043b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a04840>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1490797096.143068-716033130', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:18:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:18:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:18:50 INFO - Using env: {'DISPLAY': ':0', 07:18:50 INFO - 'HOME': '/home/cltbld', 07:18:50 INFO - 'LANG': 'en_US.UTF-8', 07:18:50 INFO - 'LANGUAGE': 'en_US:en', 07:18:50 INFO - 'LOGNAME': 'cltbld', 07:18:50 INFO - 'MAIL': '/var/mail/cltbld', 07:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:50 INFO - 'MOZ_NO_REMOTE': '1', 07:18:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:50 INFO - 'NO_EM_RESTART': '1', 07:18:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:50 INFO - 'PWD': '/builds/slave/test', 07:18:50 INFO - 'SHELL': '/bin/bash', 07:18:50 INFO - 'SHLVL': '1', 07:18:50 INFO - 'TERM': 'linux', 07:18:50 INFO - 'TMOUT': '86400', 07:18:50 INFO - 'USER': 'cltbld', 07:18:50 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1490797096.143068-716033130', 07:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:50 INFO - '_': '/tools/buildbot/bin/python'} 07:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:50 INFO - Downloading/unpacking psutil>=3.1.1 07:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:18:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:18:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:18:52 INFO - Installing collected packages: psutil 07:18:52 INFO - Running setup.py install for psutil 07:18:52 INFO - building 'psutil._psutil_linux' extension 07:18:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:18:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:18:52 INFO - building 'psutil._psutil_posix' extension 07:18:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:18:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:18:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:18:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:18:53 INFO - Successfully installed psutil 07:18:53 INFO - Cleaning up... 07:18:53 INFO - Return code: 0 07:18:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:18:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a06310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a03400>, '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 0x1a043b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a04840>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1490797096.143068-716033130', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:18:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:18:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:18:53 INFO - Using env: {'DISPLAY': ':0', 07:18:53 INFO - 'HOME': '/home/cltbld', 07:18:53 INFO - 'LANG': 'en_US.UTF-8', 07:18:53 INFO - 'LANGUAGE': 'en_US:en', 07:18:53 INFO - 'LOGNAME': 'cltbld', 07:18:53 INFO - 'MAIL': '/var/mail/cltbld', 07:18:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:53 INFO - 'MOZ_NO_REMOTE': '1', 07:18:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:53 INFO - 'NO_EM_RESTART': '1', 07:18:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:53 INFO - 'PWD': '/builds/slave/test', 07:18:53 INFO - 'SHELL': '/bin/bash', 07:18:53 INFO - 'SHLVL': '1', 07:18:53 INFO - 'TERM': 'linux', 07:18:53 INFO - 'TMOUT': '86400', 07:18:53 INFO - 'USER': 'cltbld', 07:18:53 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1490797096.143068-716033130', 07:18:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:53 INFO - '_': '/tools/buildbot/bin/python'} 07:18:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:18:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:18:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:18:55 INFO - Installing collected packages: mozsystemmonitor 07:18:55 INFO - Running setup.py install for mozsystemmonitor 07:18:55 INFO - Successfully installed mozsystemmonitor 07:18:55 INFO - Cleaning up... 07:18:55 INFO - Return code: 0 07:18:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:18:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a06310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a03400>, '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 0x1a043b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a04840>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1490797096.143068-716033130', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:18:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:18:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:18:55 INFO - Using env: {'DISPLAY': ':0', 07:18:55 INFO - 'HOME': '/home/cltbld', 07:18:55 INFO - 'LANG': 'en_US.UTF-8', 07:18:55 INFO - 'LANGUAGE': 'en_US:en', 07:18:55 INFO - 'LOGNAME': 'cltbld', 07:18:55 INFO - 'MAIL': '/var/mail/cltbld', 07:18:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:55 INFO - 'MOZ_NO_REMOTE': '1', 07:18:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:55 INFO - 'NO_EM_RESTART': '1', 07:18:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:55 INFO - 'PWD': '/builds/slave/test', 07:18:55 INFO - 'SHELL': '/bin/bash', 07:18:55 INFO - 'SHLVL': '1', 07:18:55 INFO - 'TERM': 'linux', 07:18:55 INFO - 'TMOUT': '86400', 07:18:55 INFO - 'USER': 'cltbld', 07:18:55 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1490797096.143068-716033130', 07:18:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:55 INFO - '_': '/tools/buildbot/bin/python'} 07:18:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:55 INFO - Downloading/unpacking jsonschema==2.5.1 07:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:18:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:57 INFO - Downloading functools32-3.2.3-2.tar.gz 07:18:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:18:58 INFO - warning: no files found matching '*.txt' 07:18:58 INFO - no previously-included directories found matching 'build' 07:18:58 INFO - no previously-included directories found matching 'dist' 07:18:58 INFO - no previously-included directories found matching '.git*' 07:18:58 INFO - Installing collected packages: jsonschema, functools32 07:18:58 INFO - Running setup.py install for functools32 07:18:58 INFO - warning: no files found matching '*.txt' 07:18:58 INFO - no previously-included directories found matching 'build' 07:18:58 INFO - no previously-included directories found matching 'dist' 07:18:58 INFO - no previously-included directories found matching '.git*' 07:18:58 INFO - Successfully installed jsonschema functools32 07:18:58 INFO - Cleaning up... 07:18:58 INFO - Return code: 0 07:18:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x17681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a06310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a03400>, '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 0x1a043b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a04840>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1490797096.143068-716033130', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:18:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:18:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:18:58 INFO - Using env: {'DISPLAY': ':0', 07:18:58 INFO - 'HOME': '/home/cltbld', 07:18:58 INFO - 'LANG': 'en_US.UTF-8', 07:18:58 INFO - 'LANGUAGE': 'en_US:en', 07:18:58 INFO - 'LOGNAME': 'cltbld', 07:18:58 INFO - 'MAIL': '/var/mail/cltbld', 07:18:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:58 INFO - 'MOZ_NO_REMOTE': '1', 07:18:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:58 INFO - 'NO_EM_RESTART': '1', 07:18:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:58 INFO - 'PWD': '/builds/slave/test', 07:18:58 INFO - 'SHELL': '/bin/bash', 07:18:58 INFO - 'SHLVL': '1', 07:18:58 INFO - 'TERM': 'linux', 07:18:58 INFO - 'TMOUT': '86400', 07:18:58 INFO - 'USER': 'cltbld', 07:18:58 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1490797096.143068-716033130', 07:18:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:58 INFO - '_': '/tools/buildbot/bin/python'} 07:18:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:18:58 INFO - Cleaning up... 07:18:58 INFO - Return code: 0 07:18:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x17681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a06310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a03400>, '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 0x1a043b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a04840>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1490797096.143068-716033130', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:18:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:18:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:18:58 INFO - Using env: {'DISPLAY': ':0', 07:18:58 INFO - 'HOME': '/home/cltbld', 07:18:58 INFO - 'LANG': 'en_US.UTF-8', 07:18:58 INFO - 'LANGUAGE': 'en_US:en', 07:18:58 INFO - 'LOGNAME': 'cltbld', 07:18:58 INFO - 'MAIL': '/var/mail/cltbld', 07:18:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:58 INFO - 'MOZ_NO_REMOTE': '1', 07:18:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:58 INFO - 'NO_EM_RESTART': '1', 07:18:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:58 INFO - 'PWD': '/builds/slave/test', 07:18:58 INFO - 'SHELL': '/bin/bash', 07:18:58 INFO - 'SHLVL': '1', 07:18:58 INFO - 'TERM': 'linux', 07:18:58 INFO - 'TMOUT': '86400', 07:18:58 INFO - 'USER': 'cltbld', 07:18:58 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1490797096.143068-716033130', 07:18:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:58 INFO - '_': '/tools/buildbot/bin/python'} 07:18:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:58 INFO - Downloading/unpacking blobuploader==1.2.4 07:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:00 INFO - Downloading blobuploader-1.2.4.tar.gz 07:19:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:19:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:19:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:01 INFO - Downloading docopt-0.6.1.tar.gz 07:19:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:19:01 INFO - Installing collected packages: blobuploader, requests, docopt 07:19:01 INFO - Running setup.py install for blobuploader 07:19:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:19:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:19:01 INFO - Running setup.py install for requests 07:19:01 INFO - Running setup.py install for docopt 07:19:02 INFO - Successfully installed blobuploader requests docopt 07:19:02 INFO - Cleaning up... 07:19:02 INFO - Return code: 0 07:19:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:02 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 0x17681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a06310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a03400>, '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 0x1a043b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a04840>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1490797096.143068-716033130', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:19:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:19:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:19:02 INFO - Using env: {'DISPLAY': ':0', 07:19:02 INFO - 'HOME': '/home/cltbld', 07:19:02 INFO - 'LANG': 'en_US.UTF-8', 07:19:02 INFO - 'LANGUAGE': 'en_US:en', 07:19:02 INFO - 'LOGNAME': 'cltbld', 07:19:02 INFO - 'MAIL': '/var/mail/cltbld', 07:19:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:02 INFO - 'MOZ_NO_REMOTE': '1', 07:19:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:02 INFO - 'NO_EM_RESTART': '1', 07:19:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:02 INFO - 'PWD': '/builds/slave/test', 07:19:02 INFO - 'SHELL': '/bin/bash', 07:19:02 INFO - 'SHLVL': '1', 07:19:02 INFO - 'TERM': 'linux', 07:19:02 INFO - 'TMOUT': '86400', 07:19:02 INFO - 'USER': 'cltbld', 07:19:02 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1490797096.143068-716033130', 07:19:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:02 INFO - '_': '/tools/buildbot/bin/python'} 07:19:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:19:02 INFO - Running setup.py (path:/tmp/pip-SCXdvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:19:02 INFO - Running setup.py (path:/tmp/pip-7SIaxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:19:02 INFO - Running setup.py (path:/tmp/pip-A1HFCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:19:02 INFO - Running setup.py (path:/tmp/pip-9PToCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:19:02 INFO - Running setup.py (path:/tmp/pip-GXvtxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:19:02 INFO - Running setup.py (path:/tmp/pip-dX9_y1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:19:02 INFO - Running setup.py (path:/tmp/pip-5T0hZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:19:02 INFO - Running setup.py (path:/tmp/pip-J3iXmw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:19:02 INFO - Running setup.py (path:/tmp/pip-mV5PJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:19:02 INFO - Running setup.py (path:/tmp/pip-mMi3sL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:19:03 INFO - Running setup.py (path:/tmp/pip-vwXhCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:19:03 INFO - Running setup.py (path:/tmp/pip-6_5F29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:19:03 INFO - Running setup.py (path:/tmp/pip-dA7x28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:19:03 INFO - Running setup.py (path:/tmp/pip-kn3UtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:19:03 INFO - Running setup.py (path:/tmp/pip-iZRFzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:19:03 INFO - Running setup.py (path:/tmp/pip-hf5iyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:19:03 INFO - Running setup.py (path:/tmp/pip-AbSDpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:19:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:19:03 INFO - Running setup.py install for manifestparser 07:19:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:19:03 INFO - Running setup.py install for mozcrash 07:19:03 INFO - Running setup.py install for mozdebug 07:19:03 INFO - Running setup.py install for mozdevice 07:19:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:19:03 INFO - Running setup.py install for mozfile 07:19:04 INFO - Running setup.py install for mozhttpd 07:19:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:19:04 INFO - Running setup.py install for mozinfo 07:19:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:19:04 INFO - Running setup.py install for mozInstall 07:19:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:19:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:19:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:19:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:19:04 INFO - Running setup.py install for mozleak 07:19:04 INFO - Running setup.py install for mozlog 07:19:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:19:04 INFO - Running setup.py install for moznetwork 07:19:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:19:04 INFO - Running setup.py install for mozprocess 07:19:04 INFO - Running setup.py install for mozprofile 07:19:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:19:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:19:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:19:04 INFO - Running setup.py install for mozrunner 07:19:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:19:04 INFO - Running setup.py install for mozscreenshot 07:19:05 INFO - Running setup.py install for moztest 07:19:05 INFO - Running setup.py install for mozversion 07:19:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:19:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:19:05 INFO - Cleaning up... 07:19:05 INFO - Return code: 0 07:19:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:05 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 0x17681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a06310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a03400>, '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 0x1a043b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a04840>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1490797096.143068-716033130', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:19:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:19:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:19:05 INFO - Using env: {'DISPLAY': ':0', 07:19:05 INFO - 'HOME': '/home/cltbld', 07:19:05 INFO - 'LANG': 'en_US.UTF-8', 07:19:05 INFO - 'LANGUAGE': 'en_US:en', 07:19:05 INFO - 'LOGNAME': 'cltbld', 07:19:05 INFO - 'MAIL': '/var/mail/cltbld', 07:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:05 INFO - 'MOZ_NO_REMOTE': '1', 07:19:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:05 INFO - 'NO_EM_RESTART': '1', 07:19:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:05 INFO - 'PWD': '/builds/slave/test', 07:19:05 INFO - 'SHELL': '/bin/bash', 07:19:05 INFO - 'SHLVL': '1', 07:19:05 INFO - 'TERM': 'linux', 07:19:05 INFO - 'TMOUT': '86400', 07:19:05 INFO - 'USER': 'cltbld', 07:19:05 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1490797096.143068-716033130', 07:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:05 INFO - '_': '/tools/buildbot/bin/python'} 07:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:19:05 INFO - Running setup.py (path:/tmp/pip-JKMM2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:19:05 INFO - Running setup.py (path:/tmp/pip-prigvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:19:05 INFO - Running setup.py (path:/tmp/pip-O9WFIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:19:05 INFO - Running setup.py (path:/tmp/pip-Nw3OG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:19:05 INFO - Running setup.py (path:/tmp/pip-Tvn1hY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:19:05 INFO - Running setup.py (path:/tmp/pip-74aqbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:19:05 INFO - Running setup.py (path:/tmp/pip-VFwgaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:19:06 INFO - Running setup.py (path:/tmp/pip-gCRYFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:19:06 INFO - Running setup.py (path:/tmp/pip-Kd9FlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:19:06 INFO - Running setup.py (path:/tmp/pip-0WLULe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:19:06 INFO - Running setup.py (path:/tmp/pip-_vFJzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:19:06 INFO - Running setup.py (path:/tmp/pip-zSu_oQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:19:06 INFO - Running setup.py (path:/tmp/pip-cFhx9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:19:06 INFO - Running setup.py (path:/tmp/pip-YwOjhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:19:06 INFO - Running setup.py (path:/tmp/pip-WOG3Hq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:19:06 INFO - Running setup.py (path:/tmp/pip-weM2t1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:19:06 INFO - Running setup.py (path:/tmp/pip-bfXcxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:19:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:08 INFO - Downloading blessings-1.6.tar.gz 07:19:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:19:08 INFO - Installing collected packages: blessings 07:19:08 INFO - Running setup.py install for blessings 07:19:08 INFO - Successfully installed blessings 07:19:08 INFO - Cleaning up... 07:19:09 INFO - Return code: 0 07:19:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:19:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:19:09 INFO - Reading from file tmpfile_stdout 07:19:09 INFO - Current package versions: 07:19:09 INFO - argparse == 1.2.1 07:19:09 INFO - blessings == 1.6 07:19:09 INFO - blobuploader == 1.2.4 07:19:09 INFO - docopt == 0.6.1 07:19:09 INFO - functools32 == 3.2.3-2 07:19:09 INFO - jsonschema == 2.5.1 07:19:09 INFO - manifestparser == 1.1 07:19:09 INFO - mozInstall == 1.12 07:19:09 INFO - mozcrash == 1.0 07:19:09 INFO - mozdebug == 0.1 07:19:09 INFO - mozdevice == 0.49 07:19:09 INFO - mozfile == 1.2 07:19:09 INFO - mozhttpd == 0.7 07:19:09 INFO - mozinfo == 0.9 07:19:09 INFO - mozleak == 0.1 07:19:09 INFO - mozlog == 3.4 07:19:09 INFO - moznetwork == 0.27 07:19:09 INFO - mozprocess == 0.25 07:19:09 INFO - mozprofile == 0.28 07:19:09 INFO - mozrunner == 6.13 07:19:09 INFO - mozscreenshot == 0.1 07:19:09 INFO - mozsystemmonitor == 0.3 07:19:09 INFO - moztest == 0.8 07:19:09 INFO - mozversion == 1.4 07:19:09 INFO - psutil == 3.1.1 07:19:09 INFO - requests == 1.2.3 07:19:09 INFO - wsgiref == 0.1.2 07:19:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:09 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 0x17681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a06310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a03400>, '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 0x1a043b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a04840>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1490797096.143068-716033130', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:19:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:19:09 INFO - Using env: {'DISPLAY': ':0', 07:19:09 INFO - 'HOME': '/home/cltbld', 07:19:09 INFO - 'LANG': 'en_US.UTF-8', 07:19:09 INFO - 'LANGUAGE': 'en_US:en', 07:19:09 INFO - 'LOGNAME': 'cltbld', 07:19:09 INFO - 'MAIL': '/var/mail/cltbld', 07:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:09 INFO - 'MOZ_NO_REMOTE': '1', 07:19:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:09 INFO - 'NO_EM_RESTART': '1', 07:19:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:09 INFO - 'PWD': '/builds/slave/test', 07:19:09 INFO - 'SHELL': '/bin/bash', 07:19:09 INFO - 'SHLVL': '1', 07:19:09 INFO - 'TERM': 'linux', 07:19:09 INFO - 'TMOUT': '86400', 07:19:09 INFO - 'USER': 'cltbld', 07:19:09 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1490797096.143068-716033130', 07:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:09 INFO - '_': '/tools/buildbot/bin/python'} 07:19:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:19:09 INFO - Cleaning up... 07:19:09 INFO - Return code: 0 07:19:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a06310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a03400>, '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 0x1a043b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a04840>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1490797096.143068-716033130', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:19:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:19:09 INFO - Using env: {'DISPLAY': ':0', 07:19:09 INFO - 'HOME': '/home/cltbld', 07:19:09 INFO - 'LANG': 'en_US.UTF-8', 07:19:09 INFO - 'LANGUAGE': 'en_US:en', 07:19:09 INFO - 'LOGNAME': 'cltbld', 07:19:09 INFO - 'MAIL': '/var/mail/cltbld', 07:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:09 INFO - 'MOZ_NO_REMOTE': '1', 07:19:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:09 INFO - 'NO_EM_RESTART': '1', 07:19:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:09 INFO - 'PWD': '/builds/slave/test', 07:19:09 INFO - 'SHELL': '/bin/bash', 07:19:09 INFO - 'SHLVL': '1', 07:19:09 INFO - 'TERM': 'linux', 07:19:09 INFO - 'TMOUT': '86400', 07:19:09 INFO - 'USER': 'cltbld', 07:19:09 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1490797096.143068-716033130', 07:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:09 INFO - '_': '/tools/buildbot/bin/python'} 07:19:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:19:09 INFO - Cleaning up... 07:19:09 INFO - Return code: 0 07:19:09 INFO - Running post-action listener: _resource_record_post_action 07:19:09 INFO - Running post-action listener: _start_resource_monitoring 07:19:09 INFO - Starting resource monitoring. 07:19:09 INFO - [mozharness: 2017-03-29 14:19:09.718934Z] Finished create-virtualenv step (success) 07:19:09 INFO - [mozharness: 2017-03-29 14:19:09.719453Z] Running install step. 07:19:09 INFO - Running pre-action listener: _resource_record_pre_action 07:19:09 INFO - Running main action method: install 07:19:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:19:09 INFO - Reading from file tmpfile_stdout 07:19:09 INFO - Detecting whether we're running mozinstall >=1.0... 07:19:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:19:10 INFO - Reading from file tmpfile_stdout 07:19:10 INFO - Output received: 07:19:10 INFO - Usage: mozinstall [options] installer 07:19:10 INFO - Options: 07:19:10 INFO - -h, --help show this help message and exit 07:19:10 INFO - -d DEST, --destination=DEST 07:19:10 INFO - Directory to install application into. [default: 07:19:10 INFO - "/builds/slave/test"] 07:19:10 INFO - --app=APP Application being installed. [default: firefox] 07:19:10 INFO - mkdir: /builds/slave/test/build/application 07:19:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:19:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:19:26 INFO - Reading from file tmpfile_stdout 07:19:26 INFO - Output received: 07:19:26 INFO - /builds/slave/test/build/application/firefox/firefox 07:19:26 INFO - Running post-action listener: _resource_record_post_action 07:19:26 INFO - [mozharness: 2017-03-29 14:19:26.099659Z] Finished install step (success) 07:19:26 INFO - [mozharness: 2017-03-29 14:19:26.099936Z] Running run-tests step. 07:19:26 INFO - Running pre-action listener: _resource_record_pre_action 07:19:26 INFO - Running main action method: run_tests 07:19:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:19:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:19:26 INFO - Python 2.7.3 07:19:26 INFO - Return code: 0 07:19:26 INFO - grabbing minidump binary from tooltool 07:19:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:26 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 0x1a03400>, '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 0x1a043b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a04840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:19:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:19:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:19:26 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:19:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:19:26 INFO - Return code: 0 07:19:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:19:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:19:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:19:26 INFO - ENV: RUST_BACKTRACE is now 1 07:19:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:19:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:19:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Crwqb97NQPO9V41oSfMN8g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:19:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Crwqb97NQPO9V41oSfMN8g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-006 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:19:26 INFO - Using env: {'DISPLAY': ':0', 07:19:26 INFO - 'HOME': '/home/cltbld', 07:19:26 INFO - 'LANG': 'en_US.UTF-8', 07:19:26 INFO - 'LANGUAGE': 'en_US:en', 07:19:26 INFO - 'LOGNAME': 'cltbld', 07:19:26 INFO - 'MAIL': '/var/mail/cltbld', 07:19:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:19:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:19:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:26 INFO - 'MOZ_NO_REMOTE': '1', 07:19:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:19:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:26 INFO - 'NO_EM_RESTART': '1', 07:19:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:26 INFO - 'PWD': '/builds/slave/test', 07:19:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:19:26 INFO - 'RUST_BACKTRACE': '1', 07:19:26 INFO - 'SHELL': '/bin/bash', 07:19:26 INFO - 'SHLVL': '1', 07:19:26 INFO - 'TERM': 'linux', 07:19:26 INFO - 'TMOUT': '86400', 07:19:26 INFO - 'USER': 'cltbld', 07:19:26 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1490797096.143068-716033130', 07:19:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:26 INFO - '_': '/tools/buildbot/bin/python'} 07:19:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Crwqb97NQPO9V41oSfMN8g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:19:26 INFO - mozversion application_buildid: 20170329134039 07:19:26 INFO - mozversion application_changeset: c4392f466eaab690d9b0ef7bacf72fa5e6573007 07:19:26 INFO - mozversion application_display_name: Nightly 07:19:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:19:26 INFO - mozversion application_name: Firefox 07:19:26 INFO - mozversion application_remotingname: firefox 07:19:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:19:26 INFO - mozversion application_vendor: Mozilla 07:19:26 INFO - mozversion application_version: 55.0a1 07:19:26 INFO - mozversion platform_buildid: 20170329134039 07:19:26 INFO - mozversion platform_changeset: c4392f466eaab690d9b0ef7bacf72fa5e6573007 07:19:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:19:26 INFO - mozversion platform_version: 55.0a1 07:19:26 INFO - using testdate: 1490797166 07:19:26 INFO - actual date: 1490797166 07:19:26 INFO - starting webserver on 'localhost:44482' 07:19:26 INFO - SUITE-START | Running 2 tests 07:19:26 INFO - TEST-START | dromaeo_css 07:19:26 INFO - operating with platform_type : linux_ 07:19:26 INFO - Initialising browser for dromaeo_css test... 07:19:26 INFO - TEST-INFO | started process 25476 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFlw8n1/profile http://localhost:44482/getInfo.html) 07:19:30 INFO - PID 25476 | __metrics Screen width/height:1600/1200 07:19:30 INFO - PID 25476 | colorDepth:24 07:19:30 INFO - PID 25476 | Browser inner width/height: 1024/697 07:19:30 INFO - PID 25476 | __metrics 07:19:31 ERROR - PID 25476 | 1490797171366 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 07:19:31 INFO - PID 25476 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:19:31 INFO - PID 25476 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:19:32 INFO - TEST-INFO | 25476: exit 0 07:19:32 INFO - Browser initialized. 07:19:32 INFO - Running cycle 1/1 for dromaeo_css test... 07:19:32 INFO - TEST-INFO | started process 25573 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFlw8n1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:19:44 INFO - PID 25573 | RSS: Main: 168017920 07:19:44 INFO - PID 25573 | 07:22:50 INFO - PID 25573 | Cycle 1(1): loaded http://localhost:44482/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44482/tests/dromaeo/cssquery-ext.html) 07:22:52 INFO - PID 25573 | RSS: Main: 299745280 07:22:52 INFO - PID 25573 | 07:24:34 INFO - PID 25573 | ************************* 07:24:34 INFO - PID 25573 | A coding exception was thrown and uncaught in a Task. 07:24:34 INFO - PID 25573 | 07:24:34 ERROR - PID 25573 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:24:34 INFO - PID 25573 | Full stack: 07:24:34 INFO - PID 25573 | ************************* 07:24:34 INFO - PID 25573 | ************************* 07:24:34 INFO - PID 25573 | A coding exception was thrown and uncaught in a Task. 07:24:34 INFO - PID 25573 | 07:24:34 ERROR - PID 25573 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:24:34 INFO - PID 25573 | Full stack: 07:24:34 INFO - PID 25573 | ************************* 07:24:34 INFO - PID 25573 | ************************* 07:24:34 INFO - PID 25573 | A coding exception was thrown and uncaught in a Task. 07:24:34 INFO - PID 25573 | 07:24:34 ERROR - PID 25573 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:24:34 INFO - PID 25573 | Full stack: 07:24:34 INFO - PID 25573 | ************************* 07:24:34 INFO - PID 25573 | ************************* 07:24:34 INFO - PID 25573 | A coding exception was thrown and uncaught in a Task. 07:24:34 INFO - PID 25573 | 07:24:34 ERROR - PID 25573 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:24:34 INFO - PID 25573 | Full stack: 07:24:34 INFO - PID 25573 | ************************* 07:25:54 INFO - PID 25573 | Cycle 1(1): loaded http://localhost:44482/tests/dromaeo/cssquery-ext.html (next: http://localhost:44482/tests/dromaeo/cssquery-jquery.html) 07:25:55 INFO - PID 25573 | RSS: Main: 258936832 07:25:55 INFO - PID 25573 | 07:28:57 INFO - PID 25573 | Cycle 1(1): loaded http://localhost:44482/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44482/tests/dromaeo/cssquery-mootools.html) 07:28:58 INFO - PID 25573 | RSS: Main: 208367616 07:28:58 INFO - PID 25573 | 07:32:00 INFO - PID 25573 | Cycle 1(1): loaded http://localhost:44482/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44482/tests/dromaeo/cssquery-prototype.html) 07:32:01 INFO - PID 25573 | RSS: Main: 234278912 07:32:01 INFO - PID 25573 | 07:35:04 INFO - PID 25573 | Cycle 1(1): loaded http://localhost:44482/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44482/tests/dromaeo/cssquery-yui.html) 07:35:05 INFO - PID 25573 | RSS: Main: 216035328 07:35:05 INFO - PID 25573 | 07:38:08 INFO - PID 25573 | Cycle 1(1): loaded http://localhost:44482/tests/dromaeo/cssquery-yui.html (next: http://localhost:44482/tests/dromaeo/cssquery-dojo.html) 07:38:08 INFO - PID 25573 | RSS: Main: 287514624 07:38:08 INFO - PID 25573 | 07:38:08 INFO - PID 25573 | __start_tp_report 07:38:08 INFO - PID 25573 | _x_x_mozilla_page_load 07:38:08 INFO - PID 25573 | _x_x_mozilla_page_load_details 07:38:08 INFO - PID 25573 | |i|pagename|runs| 07:38:08 INFO - PID 25573 | |0;dojo.html;2656.667916510436;2694.124409566889;2724.073814902931;2728.877200525976;2751.0233866977223;4818.445878723948;4910.6317026223;5038.47096054914;5067.265246539249;5104.642675012746;4979.078870408968;4992.750362481879;5023.221400682891;5056.519630635093;5081.796728130879;4518.932216016762;4566.817327306912;4608.331791890174;4663.976680116594;4676.5089665584965;4648.558386953234;4675.064987002596;4683.555062269079;4694.155052090622;4731.668783185179;4535.750533720644;4569;4569.6801223914335;4630.120277147331;4664.813407463697;4597.126545956257;4602.102589994953;4602.148602508513;4655.092257009885;4666.953330466686;4508.323751437278;4511.210538155809;4512.390827238347;4543.295789152687;4567.086582683477;4840.806367745286;4883.12103821312;4886.096072226649;4890.8288209912835;4946.87632809179;5249.055170069386;5249.4750524947585;5251.973740131275;5253.474652534755;5255.474452554752;5250.868728281824;5276.076686579871;5324.361076670824;5408.080626293539;5414.187871819219;5028.748562571856;5038.622103342264;5040.2691609716385;5046.772895219724;5082.059818933509;5453.481919217668;5490.945090549123;5511.641743286674;5515.503604675599;5562.86092847674;5211.5049070338255;5261.921071183859;5267.972745314627;5299.31108955841;5300.867478313073;5363.356397232279;5364.8122315718765;5365.597580181502;5389.218563308376;5418.647787893774;5320;5343.0649636314265;5345;5345.305110335631;5401;5261.947380526222;5273.472652734773;5311.309529761106;5313.388960269618;5320.76056577455;4491.169133710274;4497.730136191839;4528.320751887178;4536.841210557614;4544.409226800495;3875.4380614811257;3879.1078052048188;3882.2623701496627;3916.7649941003633;3921.431392448079;4506.864794056183;4559.6124329431705;4588.242939914877;4591.65562582801;4629.351890735233;5335.626506144533;5376.677399356051;5407.459254074561;5416.620836541404;5417.945820541823;4563.612092972135;4578.9542104579195;4588.88527786808;4592.862214133581;4641.187792136363;4793;4799.952000480021;4801.95198048022;4802.159622066194;4851.975740121347;4893.6085113191575;4940.8764780880765;4949.777260023236;5075.365579302587;5129.256257842518;5417.322834645669;5421.701806400686;5432.103702888979;5442.755076021668;5481.314835645544;5057.190849464068;5059.772310245974;5064.873378165576;5071.0872043032605;5082.822101226439;5217.191335343028;5248.6588371755715;5270.8155214567305;5344.518993290622;5347.358317001985;5404.405515393382;5418.539424148991;5428.945710542844;5476.233327334096;5479.616426850242;5101.897962040813;5161.741912904415;5255.02781985334;5272.841814745564;5278.366596008504;5272.235525848807;5294.549963253013;5295.4969277918535;5297.073012222922;5300.443453437333;5086.491350864884;5182.740862956913;5189.6886186828915;5239.135542635422;5251;5271.973640131775;5308.867278318073;5310.495502927216;5313.920291195558;5314.309139811954;5018.598512118949;5067.9239811403595;5075.847724568269;5119.0273847968765;5123.820666276662 07:38:08 INFO - PID 25573 | |1;ext.html;598.5630489742488;647.1942431672568;667.1160712056525;1037.0562787863046;1053.5048527192228;27073;31059;31489.84255078724;31523.684763152418;31541.053768386926;32747;33155.66844331556;33253.83373083137;33292.83353583229;33368.332633347316;5527.723613819313;7169.318914703108;7330.706771729125;7332.046833911584;7333.486655934087;5587;7013.053237812906;7179.9282007180045;7182.9281707183045;7183.281671832827;7243.927560724404;7295.270472952689;7295.452841036943;7299.525530840505;7310.34206921377;7231.385332246739;7298.124225092996;7411.518251313647;7414.888776668355;7421.591812450313;7090.468214883905;7164.856702865914;7166.713331466735;7169.920722990327;7194.748183813542;32341.191470213198;32484.6751532484;32515.512267316008;32560;32639;2553.706323772771;2567.5763499022823;2574.2277316804884;2581.9870900645565;2623.842569445839;23058.53882922349;23204.53590928172;23217.53564928709;23316.067357305856;23499.41251468727;2998.78211911275;3013.186439661301;3022.2595464111214;3025.788194826363;3025.8940937067096;152931;153490;153850;154053.2297338506;154357.99999999886;41573.58426415757;41831.58168418338;41976.58023419727;41980.58019419828;42111.578884210765;44002;44384.3342349865;44406.33390499145;44410.55589444129;44492.77753611276;12199;12216.877831221575;12225.938870305592;12256.325902075294;12362.814557781641;7503.699852005968;7596.886046709304;9751.658691945748;9777.071178238057;9950.303478756563;11737.119716021161;11890.702732431586;11904.404779761151;11927.284362938251;11937.88062119385;4927.556519913153;4993.675411098267;4996.150654388763;5016.917979038658;5089.185730283137;867.3711559119588;872.581161042703;900.617237673986;915.9542022898828;926.8563372677246;19805.801941980684;20213.494662633257;21220.893895530422;21236.36290911275;21426.785732142478;984.6799790068256;994.4778991029767;995.4425521707722;1000.6597756762735;1020.0411613083678;10672.250848372554;10761.83857242142;10901.509432075576;10973.670789876316;10979.451027448597;207243;209341;209451;209781;209855;41089.58910410858;41140.58859411367;41183.1763364731;41242.58757412388;41248.79375603103;1217.945192466341;1257.5661396818084;1260.7478504299177;1267.9112462127748;1269.6825793551611;19146.52133696669;19689.21243150258;19995;20161.596768064264;20511.692324614844;30104.09687709372;30287;30299.24251893632;30321;30327;224260;225362;225862;225974;226703;22623.886880565493;26913;27223;27342.726572734813;28533;26588.601170982063;33827.96680827474;36685.26629467449;37039.629603703615;37192.628073718915;29743.851280743456;29757.5536366959;29957.400851983275;30037.54943675803;30936;30245.243868903453;30378.84810575933;30474.84762576173;30990.22524436907;31807.204819879687;33329;33640.327193456484;33850;34102.317953641286;34245.143871403416;27612.46227942208;29077.563836542893;30197.09408717742;30282;30304.393912122076;21828.236011739515;23947.760522394554;24206.75793242045;24326.51346973015;24493.75506244986 07:38:08 INFO - PID 25573 | |2;jquery.html;425.72616578511247;430.9698321117519;435.74073426311344;445.20753059553994;447.3736768524066;16190.271437785314;17068.487945361645;17303.91348043258;17615.73576396352;17723.645527089466;18257.178426970786;18444.44666659999;18882.433526994213;19090.427287181374;19095.427137185907;5472.480114389126;5548.944510554883;5638.802641907534;5659.094544872821;5659.292588426447;5567.359753628344;5660.830175094754;5663.4336566343245;5670.3479099903425;5671.7731290748325;5414.566834653218;5552;5598.188262701906;5599.524040456566;5614.494695477427;5407.945920540784;5573.860653483675;5600.859978500529;5616.719164041802;5627.2684551008315;5040.269160971675;5043.823466178666;5049.798008079672;5057.74711264439;5060.2409638554145;21660.783392166035;22088.88955555228;22128.557428851334;22230.777692223033;22322.776772232395;1540.9768853467208;1545.8608725214672;1553.9378424862991;1594.9601259968479;1597.8881478296523;13635.727285454235;14135.434582616683;14409.855901440957;14465.20441375724;14780.334884930204;1689.4002629066626;1725.9137043147791;1732.6361464092429;1737.2703464544923;1759.6304775997055;95249.4275515207;95864;97145;97154.51422742911;97211.51394243054;10978.670639880816;11174.139249426364;11317.773644527064;11339.262947908359;11378.829317560243;16004.199790010452;16025.358985640443;16028.278727457293;16060.19699015068;16063.518094457186;7332.853342933218;7482;7650.38796896247;7675.577843218676;7715.768526944201;6836.7352039872785;6858.039874417585;6866.446436998517;7022.613756243456;7068.469864760164;7231.783046508614;7240.384567311732;7255.201927787939;7292.854142917218;7351.77944661661;1947.2405761752927;1967.1442922328833;1975.4737793039355;1978.5943881504256;2094.6117883035017;854.2525290370926;864.5158711121792;877.9165979231963;882.5895958379384;905.5291248550717;17111;17157.313707451813;17574.29702811899;17654.11729413524;18027.72958405625;888.2938064238946;902.3683421604903;903.8779764731809;905.0406569036842;917.1653795046609;9726.17327527154;10389.688309350731;11266.94366528162;11531.538738450368;12217.511299548096;454614;465557;474312;478999;482251;66906.33093669098;81825.59087204645;93650;97805;99619.50190249002;1119.9160062995309;1153.2676750263643;1155.820847768597;1166.7374840660784;1169.386072312043;17458;17591.208395622485;17694.557636058686;18058.367957121438;18426.262949481872;42916.570834291255;43274.567254328314;43426.78286608673;43591.56408435875;44642.776786115865;52887.20669190042;54332.45667543274;55130.44869551253;55891;56264.71867640636;7692.269234422721;7729.961350193213;7803.960980195063;7805.297523222937;8052.919470805217;11504.964553190253;12240.204386714835;12279.508819647472;12303.630891073282;12602.55891043809;9570.760730981781;9597.856032159663;9693.176080032994;9858.309918305937;10123.59505619767;9178.541072946193;9246.95376523113;9266.907330926873;9297.209737172416;9544.141027307576;10151.898481015096;10161.695149145537;10486.842697359698;10572.788544229226;10876.673699788702;7676;7729;7771.8834217485655;7932.36541076724;7976.441649084509;9998.85093648674;9999.35004224752;10095.646652367132;10440.164786816884;10604.310719803188 07:38:08 INFO - PID 25573 | |3;mootools.html;1130.0620484997453;1268.7018550640598;1323.629383772544;1337.6254648698364;1343.0867010432908;8026.11712711602;9342.439453632787;9562.904370956288;9572.13850753432;9584.76038099048;9580.61677532898;9724.805503889918;9724.93025767165;9726.270529710264;9737.853932191005;2174.6303128468157;2215.645496720525;2217.124235926808;2218.944526386845;2219.04581030157;1826.936057237997;1882.6705326567865;2182.9235976740815;2240.7423146338137;2248.415411992877;2166.5775173841107;2186.759456459788;2189.200941656292;2191.7698641642555;2196.143504033428;2120.989395053015;2129.361191642501;2143.303426386423;2160.2007257314735;2163.296928498244;2168.0894024509744;2178.411828806229;2188.8577242479187;2191.550732099916;2192.2984644913636;9371.390859594172;9586.76033099171;9606.183474404614;9615.375000625007;9616.95191524038;5175.197844334134;5374.516293533601;5384.219288203228;5393.919091213635;5408.675479471244;3153.8423078846195;3164.6677098904515;3208.871645134192;3222.1139186723603;3265.510173473974;1156.6645672754892;1161.506359797083;1173.8356630071796;1190.5892467098838;1582.1061100478194;13058.608241752763;13094;13120.081594288404;13129.146605470709;13204.273764942829;4351.804168812348;4578.221702310615;4630.21286381316;4648.976755116203;4673.719576825401;10455.111315538265;10479.528421221063;10494.422806745702;10495.632652857113;10503.422311772772;5319.707416092075;5321.920171197435;5359.544438722753;5360.65155764874;5378.569714422837;4858.927116093261;4896.6572339935865;4925.926111108336;4936.654434189572;4981.526754958273;3280.7375409967144;3397;3769.8680546180753;3847.1343947611563;3864.111254411445;1066.9573217071231;1072.5924148823553;1093.294824837975;1101.5758932810925;1105.3699391347016;695.2977492732376;699.4439420660588;715.1275443958466;724.8876424154264;740.7259314053726;5274.7098909560345;5855.151003104526;5861.5603829712945;5948.137520059654;6210.9068363974575;819.610684924656;819.8770184472377;831.5094094484283;837.9329653627696;840.2395831772255;3150.322680623631;3244.4484437645656;3299.8075524531087;3363.4450315698127;3372.8819491317686;10954.835677464844;11424.942875285737;11933.880661193278;11934.045276377869;11953.282803031845;11333.546658133582;11712.180147389772;11766.58816941403;11781.293122412682;11801.704957376134;9009.684661036832;9223.216026637676;9223.953880230421;9224.123708247706;9228.95385523068;5599.468050535193;5632.183333416549;5696.458836410535;5721.742521586455;5729.197912292366;10725.088367488539;11150.888491114985;11156.051735602565;11189.496472658913;11312.773744525228;11306.886931130583;11450.255733377304;11488.19582629208;11584.362860042778;11596.36220007874;7613.695452182073;7874.921250787419;7939.880901786593;8126.268635822805;8126.796830079059;7796.61016949139;7997.680092796456;8649.178328058824;8829.426087304562;8938.195562399154;7354.485186036926;7388.6675099621725;7395.223501532261;7496.7376141834775;7611.581363025087;7574.962125189339;7695.115061767744;7797.493162944391;7862.488938218998;7909.1695371985115;6980.371766541036;6984.895226571707;7010.36906678381;7018.052562903943;7038.718451261892;4910.8281210157475;5010.223415370623;5015.122353588181;5024.171011783015;5066.746662666926;5004.124278251365;5025.170846810235;5074.188129899198;5206.609504287269;5233.39815921174 07:38:08 INFO - PID 25573 | |4;prototype.html;381.9732618716689;405.33322684184515;409.0673264955902;411.7426608369769;412.7028539451594;5288;5297.549708274796;5366.758495867691;5393.1910213468;5406.864828379293;5060.822871199509;5265;5268.209768534722;5289.153735402337;5322.973385133078;4116.464859568252;4128;4151.58484151584;4152.9999999999845;4154.106867023589;4142.730722503027;4152.958470415288;4160.375943608467;4164.666826653875;4172.436721042651;4051.6961227907877;4099.44657471242;4103.466549348581;4139.606737359961;4147.709660323779;4081.5918408159246;4090.734102283342;4093.2427500912277;4094.6110119538894;4107.466029416171;3593.2274560969254;3604.53141091659;3608.621094785036;3610.548681414823;3637.1634524059614;4823.421189457287;5106.106431374495;5111.616628752859;5119.616028797818;5123.615728820353;4612.76936153191;4628.514006029386;4639.280911458729;4655.767211639404;4656.441227052742;5582.581306401996;5594.9720251398885;5595.720213989284;5602.887942241132;5605.607607467479;3773.924521509582;3868.535775706905;3874.6900247980375;3876.7286289959716;3880.47613572167;5524.801151125173;5700.942990570041;5722.2561067061015;5827.592068555203;5863.58954873159;3919.412088186795;3919.8040097994985;3922.686185105185;3928.233994371127;3937.310970580137;3979.880603581897;3981.980090099589;3987.1228329767405;3989.501312335958;4001.7198796083994;4393.29707246839;4395.318725597537;4601.700889442175;4628.454350107428;4642.582167604932;5567.47109024642;5576.247206627135;5586.190002449704;5593.860153496195;5628.831135065954;1370.7052983608571;1375.931203439824;1377.1461693749939;1378.4486205517874;1396.818413606245;901.1574178143326;958.1568219966385;969.9466529340813;974.2741657465234;979.5543027922279;4867.294242334912;4884.633652476078;4895.388076490439;4895.388076490439;4910.90178196434;5794.855128621818;5802.6808525531505;5812.680302583314;5817.505512031525;5823.980803359395;4642.257238841769;4904.2643603459055;4906.70559766408;4910.593809033548;4921.581665558396;3060.816351018946;3067.5858759067687;3068.6164229471315;3072.927072927073;3076.215794838988;5398.568114550826;5436.266104075979;5440.591955603346;5443.646162999393;5468.343798744176;5670.7240870803735;5903.734331955073;5906.675132867734;5963.0023941979925;5995.790147344822;5407.432219616883;5431.2667789847865;5453.618246722692;5481.355593321988;5488.53347465462;5655.88688226225;5783.681897495678;5807.680577568105;5838.532917366685;5847.26909136358;5668.688222147822;5705.828825135252;5717.199592057199;5717.7141142941855;5725.112607545837;5146.305248791366;5239.397469291081;5271.710055946806;5450.482204190755;5467.261919640957;4050.270951228807;4051.93922091163;4057.91884162321;4066.207089617496;4067;5744.942550574441;5781.624194427349;5782.739776709974;5789.2763404574425;5828.737706803289;5445.428230035789;5571.415001424792;5588.217649528988;5620.85947851307;5621.887562248814;5564.638298510584;5565.526930210815;5577.498025177753;5585.525230355465;5592.412796656293;5335.973320133529;5520.447955204448;5537;5541.722913854211;5556.527695145796;5587.664740115606;5619.8876022480135;5634.774609015757;5639.915401268902;5642.802501912413;5474.945250547603;5476.178573213891;5478.643888147258;5498.697571633438;5506.356948664744 07:38:08 INFO - PID 25573 | |5;yui.html;690.2614202803003;691.8062942376135;695.5096656856916;704.6371118873781;711.7579823208499;11137.610183643574;11641.825372619418;11678.824817627743;11730.472128754205;11740.882591174086;11366.204365694404;11393.088552915748;11396.829047564293;11401.201915865893;11425.257358271707;869.4870026684255;884.9778755531099;915.3912648089046;919.1130559010553;926.3700683535193;939.9953000235023;940.4874343482784;941.3316545252878;941.6421759731293;946.153192892361;976.8681228034195;976.9316147869652;977.291463688827;977.4623956823754;979.1139019187611;972.2270794718216;972.7081875437341;973.5181085362719;974.0503009565688;977.0522593084696;718.1992078832117;719.6329871765384;720.0243669827361;720.8342081321325;722.7073035420663;11669.183157179;11881.465334059989;12869.970402367788;12954.48182072716;12994;11840.230385024946;12632.621021369374;12634.684132896658;12767.425465853967;13096.279704616243;9314.487703176323;9496.287778416578;9549.09283618055;9749.951250243703;9782.608695652165;2433.36736413286;2465.716442609105;2484.5155194737035;2491.5515207262683;2545.1982625472915;61518.38481615216;63233.68383158101;63529.04706429407;63570.36429635691;64243.67878160579;10592.364458132537;10637.73405664849;10728.249022568345;10751.354918704747;10889.401082940356;21267.255646052316;21643.78356216449;21677.891610542163;21690.457738556663;21990.120395184334;5701.258836351248;5845.444682755132;5869.236999190078;5953.404659534099;6046.637201767908;2951.2474319048506;2990.7607391408637;3004.5943797587483;3037.4532584134627;3073.6004319438775;3151.5902932618615;3206.422843888076;3229.1119942016135;3238.6923242291946;3272.60728712556;663.6383171171626;663.857270686795;665.6072916978909;681.1961884975776;683.1324218242903;448.4058622325432;462.64607575204997;470.30864628996005;483.74361588358227;484.3146947069927;8567.657293708307;9382.437053776795;9826.557804898797;9918.900810991941;10064.949675251577;470.51771933767475;484.2784251465291;490.6075139888075;495.4896456649657;496.32995456134654;3734.327820992193;3775.565809931893;3810.180811125566;3928.194720082376;3963.207358528306;45464;47885.5211447888;57385.71307143437;58134.7093264531;58479;32491.675083249338;41736.58263417388;42330.57669423328;43790.34314485285;49907.75046124746;38628.80685596554;39575.60424395719;40953;42431.57568424338;45836.31245531253;9193.402428842104;9597.760055998657;9715.902840971783;9784.755381115529;9833.950830245803;24420.51158976846;24632.384190394667;24736.876315619025;25549.23352299434;25590.744092558834;29549.704502954693;29830.552541712324;30036.399272014874;30071.398572028;30703.385932281675;11131.387773672526;11173.553057877594;11240.15698822608;11516.251443656136;11815.29630423218;12703.491860325854;12886.226826390446;13054.282014489294;13101.934490327487;13187.208767473981;10851.565937362417;11787;12016.33910134951;12115.878841211475;12246.387680616112;12026.819597706217;12148.817767733315;12223.69440763988;12934.741305173655;13397.732045359233;11816.172867899164;12065.879341206475;12066.215695979734;12116.878831211576;12270.32513211782;8263.214994575506;8436.620352084294;8832.690855820016;9090.59092340833;9210.907890921273;9040.050794666466;9615.5672994714;9846.163076138322;9891.110237826486;9981.251406144424 07:38:08 INFO - PID 25573 | __end_tp_report 07:38:08 INFO - PID 25573 | __start_cc_report 07:38:08 INFO - PID 25573 | _x_x_mozilla_cycle_collect,1502 07:38:08 INFO - PID 25573 | __end_cc_report 07:38:08 INFO - PID 25573 | __startTimestamp1490798288809__endTimestamp 07:38:08 INFO - PID 25573 | 07:38:08 INFO - PID 25573 | ------- Summary: start ------- 07:38:08 INFO - PID 25573 | Number of tests: 6 07:38:08 INFO - PID 25573 | 07:38:08 INFO - PID 25573 | [#0] dojo.html Cycles:165 Average:4945.08 Median:5075.85 stddev:540.48 (10.6%) stddev-sans-first:511.46 07:38:08 INFO - PID 25573 | Values: 2656.7 2694.1 2724.1 2728.9 2751.0 4818.4 4910.6 5038.5 5067.3 5104.6 4979.1 4992.8 5023.2 5056.5 5081.8 4518.9 4566.8 4608.3 4664.0 4676.5 4648.6 4675.1 4683.6 4694.2 4731.7 4535.8 4569.0 4569.7 4630.1 4664.8 4597.1 4602.1 4602.1 4655.1 4667.0 4508.3 4511.2 4512.4 4543.3 4567.1 4840.8 4883.1 4886.1 4890.8 4946.9 5249.1 5249.5 5252.0 5253.5 5255.5 5250.9 5276.1 5324.4 5408.1 5414.2 5028.7 5038.6 5040.3 5046.8 5082.1 5453.5 5490.9 5511.6 5515.5 5562.9 5211.5 5261.9 5268.0 5299.3 5300.9 5363.4 5364.8 5365.6 5389.2 5418.6 5320.0 5343.1 5345.0 5345.3 5401.0 5261.9 5273.5 5311.3 5313.4 5320.8 4491.2 4497.7 4528.3 4536.8 4544.4 3875.4 3879.1 3882.3 3916.8 3921.4 4506.9 4559.6 4588.2 4591.7 4629.4 5335.6 5376.7 5407.5 5416.6 5417.9 4563.6 4579.0 4588.9 4592.9 4641.2 4793.0 4800.0 4802.0 4802.2 4852.0 4893.6 4940.9 4949.8 5075.4 5129.3 5417.3 5421.7 5432.1 5442.8 5481.3 5057.2 5059.8 5064.9 5071.1 5082.8 5217.2 5248.7 5270.8 5344.5 5347.4 5404.4 5418.5 5428.9 5476.2 5479.6 5101.9 5161.7 5255.0 5272.8 5278.4 5272.2 5294.5 5295.5 5297.1 5300.4 5086.5 5182.7 5189.7 5239.1 5251.0 5272.0 5308.9 5310.5 5313.9 5314.3 5018.6 5067.9 5075.8 5119.0 5123.8 07:38:08 INFO - PID 25573 | 07:38:08 INFO - PID 25573 | [#1] ext.html Cycles:180 Average:33586.44 Median:30352.92 stddev:51673.27 (170.2%) stddev-sans-first:51758.86 07:38:08 INFO - PID 25573 | Values: 598.6 647.2 667.1 1037.1 1053.5 27073.0 31059.0 31489.8 31523.7 31541.1 32747.0 33155.7 33253.8 33292.8 33368.3 5527.7 7169.3 7330.7 7332.0 7333.5 5587.0 7013.1 7179.9 7182.9 7183.3 7243.9 7295.3 7295.5 7299.5 7310.3 7231.4 7298.1 7411.5 7414.9 7421.6 7090.5 7164.9 7166.7 7169.9 7194.7 32341.2 32484.7 32515.5 32560.0 32639.0 2553.7 2567.6 2574.2 2582.0 2623.8 23058.5 23204.5 23217.5 23316.1 23499.4 2998.8 3013.2 3022.3 3025.8 3025.9 152931.0 153490.0 153850.0 154053.2 154358.0 41573.6 41831.6 41976.6 41980.6 42111.6 44002.0 44384.3 44406.3 44410.6 44492.8 12199.0 12216.9 12225.9 12256.3 12362.8 7503.7 7596.9 9751.7 9777.1 9950.3 11737.1 11890.7 11904.4 11927.3 11937.9 4927.6 4993.7 4996.2 5016.9 5089.2 867.4 872.6 900.6 916.0 926.9 19805.8 20213.5 21220.9 21236.4 21426.8 984.7 994.5 995.4 1000.7 1020.0 10672.3 10761.8 10901.5 10973.7 10979.5 207243.0 209341.0 209451.0 209781.0 209855.0 41089.6 41140.6 41183.2 41242.6 41248.8 1217.9 1257.6 1260.7 1267.9 1269.7 19146.5 19689.2 19995.0 20161.6 20511.7 30104.1 30287.0 30299.2 30321.0 30327.0 224260.0 225362.0 225862.0 225974.0 226703.0 22623.9 26913.0 27223.0 27342.7 28533.0 26588.6 33828.0 36685.3 37039.6 37192.6 29743.9 29757.6 29957.4 30037.5 30936.0 30245.2 30378.8 30474.8 30990.2 31807.2 33329.0 33640.3 33850.0 34102.3 34245.1 27612.5 29077.6 30197.1 30282.0 30304.4 21828.2 23947.8 24206.8 24326.5 24493.8 07:38:08 INFO - PID 25573 | 07:38:08 INFO - PID 25573 | [#2] jquery.html Cycles:180 Average:28485.65 Median:476655.50 stddev:78114.04 (16.4%) stddev-sans-first:78304.75 07:38:08 INFO - PID 25573 | Values: 425.7 431.0 435.7 445.2 447.4 16190.3 17068.5 17303.9 17615.7 17723.6 18257.2 18444.4 18882.4 19090.4 19095.4 5472.5 5548.9 5638.8 5659.1 5659.3 5567.4 5660.8 5663.4 5670.3 5671.8 5414.6 5552.0 5598.2 5599.5 5614.5 5407.9 5573.9 5600.9 5616.7 5627.3 5040.3 5043.8 5049.8 5057.7 5060.2 21660.8 22088.9 22128.6 22230.8 22322.8 1541.0 1545.9 1553.9 1595.0 1597.9 13635.7 14135.4 14409.9 14465.2 14780.3 1689.4 1725.9 1732.6 1737.3 1759.6 95249.4 95864.0 97145.0 97154.5 97211.5 10978.7 11174.1 11317.8 11339.3 11378.8 16004.2 16025.4 16028.3 16060.2 16063.5 7332.9 7482.0 7650.4 7675.6 7715.8 6836.7 6858.0 6866.4 7022.6 7068.5 7231.8 7240.4 7255.2 7292.9 7351.8 1947.2 1967.1 1975.5 1978.6 2094.6 854.3 864.5 877.9 882.6 905.5 17111.0 17157.3 17574.3 17654.1 18027.7 888.3 902.4 903.9 905.0 917.2 9726.2 10389.7 11266.9 11531.5 12217.5 454614.0 465557.0 474312.0 478999.0 482251.0 66906.3 81825.6 93650.0 97805.0 99619.5 1119.9 1153.3 1155.8 1166.7 1169.4 17458.0 17591.2 17694.6 18058.4 18426.3 42916.6 43274.6 43426.8 43591.6 44642.8 52887.2 54332.5 55130.4 55891.0 56264.7 7692.3 7730.0 7804.0 7805.3 8052.9 11505.0 12240.2 12279.5 12303.6 12602.6 9570.8 9597.9 9693.2 9858.3 10123.6 9178.5 9247.0 9266.9 9297.2 9544.1 10151.9 10161.7 10486.8 10572.8 10876.7 7676.0 7729.0 7771.9 7932.4 7976.4 9998.9 9999.4 10095.6 10440.2 10604.3 07:38:08 INFO - PID 25573 | 07:38:08 INFO - PID 25573 | [#3] mootools.html Cycles:180 Average:5935.45 Median:4877.79 stddev:3657.70 (75.0%) stddev-sans-first:3650.14 07:38:08 INFO - PID 25573 | Values: 1130.1 1268.7 1323.6 1337.6 1343.1 8026.1 9342.4 9562.9 9572.1 9584.8 9580.6 9724.8 9724.9 9726.3 9737.9 2174.6 2215.6 2217.1 2218.9 2219.0 1826.9 1882.7 2182.9 2240.7 2248.4 2166.6 2186.8 2189.2 2191.8 2196.1 2121.0 2129.4 2143.3 2160.2 2163.3 2168.1 2178.4 2188.9 2191.6 2192.3 9371.4 9586.8 9606.2 9615.4 9617.0 5175.2 5374.5 5384.2 5393.9 5408.7 3153.8 3164.7 3208.9 3222.1 3265.5 1156.7 1161.5 1173.8 1190.6 1582.1 13058.6 13094.0 13120.1 13129.1 13204.3 4351.8 4578.2 4630.2 4649.0 4673.7 10455.1 10479.5 10494.4 10495.6 10503.4 5319.7 5321.9 5359.5 5360.7 5378.6 4858.9 4896.7 4925.9 4936.7 4981.5 3280.7 3397.0 3769.9 3847.1 3864.1 1067.0 1072.6 1093.3 1101.6 1105.4 695.3 699.4 715.1 724.9 740.7 5274.7 5855.2 5861.6 5948.1 6210.9 819.6 819.9 831.5 837.9 840.2 3150.3 3244.4 3299.8 3363.4 3372.9 10954.8 11424.9 11933.9 11934.0 11953.3 11333.5 11712.2 11766.6 11781.3 11801.7 9009.7 9223.2 9224.0 9224.1 9229.0 5599.5 5632.2 5696.5 5721.7 5729.2 10725.1 11150.9 11156.1 11189.5 11312.8 11306.9 11450.3 11488.2 11584.4 11596.4 7613.7 7874.9 7939.9 8126.3 8126.8 7796.6 7997.7 8649.2 8829.4 8938.2 7354.5 7388.7 7395.2 7496.7 7611.6 7575.0 7695.1 7797.5 7862.5 7909.2 6980.4 6984.9 7010.4 7018.1 7038.7 4910.8 5010.2 5015.1 5024.2 5066.7 5004.1 5025.2 5074.2 5206.6 5233.4 07:38:08 INFO - PID 25573 | 07:38:08 INFO - PID 25573 | [#4] prototype.html Cycles:180 Average:4615.84 Median:5279.86 stddev:1352.49 (25.6%) stddev-sans-first:1318.42 07:38:08 INFO - PID 25573 | Values: 382.0 405.3 409.1 411.7 412.7 5288.0 5297.5 5366.8 5393.2 5406.9 5060.8 5265.0 5268.2 5289.2 5323.0 4116.5 4128.0 4151.6 4153.0 4154.1 4142.7 4153.0 4160.4 4164.7 4172.4 4051.7 4099.4 4103.5 4139.6 4147.7 4081.6 4090.7 4093.2 4094.6 4107.5 3593.2 3604.5 3608.6 3610.5 3637.2 4823.4 5106.1 5111.6 5119.6 5123.6 4612.8 4628.5 4639.3 4655.8 4656.4 5582.6 5595.0 5595.7 5602.9 5605.6 3773.9 3868.5 3874.7 3876.7 3880.5 5524.8 5700.9 5722.3 5827.6 5863.6 3919.4 3919.8 3922.7 3928.2 3937.3 3979.9 3982.0 3987.1 3989.5 4001.7 4393.3 4395.3 4601.7 4628.5 4642.6 5567.5 5576.2 5586.2 5593.9 5628.8 1370.7 1375.9 1377.1 1378.4 1396.8 901.2 958.2 969.9 974.3 979.6 4867.3 4884.6 4895.4 4895.4 4910.9 5794.9 5802.7 5812.7 5817.5 5824.0 4642.3 4904.3 4906.7 4910.6 4921.6 3060.8 3067.6 3068.6 3072.9 3076.2 5398.6 5436.3 5440.6 5443.6 5468.3 5670.7 5903.7 5906.7 5963.0 5995.8 5407.4 5431.3 5453.6 5481.4 5488.5 5655.9 5783.7 5807.7 5838.5 5847.3 5668.7 5705.8 5717.2 5717.7 5725.1 5146.3 5239.4 5271.7 5450.5 5467.3 4050.3 4051.9 4057.9 4066.2 4067.0 5744.9 5781.6 5782.7 5789.3 5828.7 5445.4 5571.4 5588.2 5620.9 5621.9 5564.6 5565.5 5577.5 5585.5 5592.4 5336.0 5520.4 5537.0 5541.7 5556.5 5587.7 5619.9 5634.8 5639.9 5642.8 5474.9 5476.2 5478.6 5498.7 5506.4 07:38:08 INFO - PID 25573 | 07:38:08 INFO - PID 25573 | [#5] yui.html Cycles:180 Average:13025.97 Median:42033.58 stddev:15193.95 (36.1%) stddev-sans-first:15208.34 07:38:08 INFO - PID 25573 | Values: 690.3 691.8 695.5 704.6 711.8 11137.6 11641.8 11678.8 11730.5 11740.9 11366.2 11393.1 11396.8 11401.2 11425.3 869.5 885.0 915.4 919.1 926.4 940.0 940.5 941.3 941.6 946.2 976.9 976.9 977.3 977.5 979.1 972.2 972.7 973.5 974.1 977.1 718.2 719.6 720.0 720.8 722.7 11669.2 11881.5 12870.0 12954.5 12994.0 11840.2 12632.6 12634.7 12767.4 13096.3 9314.5 9496.3 9549.1 9750.0 9782.6 2433.4 2465.7 2484.5 2491.6 2545.2 61518.4 63233.7 63529.0 63570.4 64243.7 10592.4 10637.7 10728.2 10751.4 10889.4 21267.3 21643.8 21677.9 21690.5 21990.1 5701.3 5845.4 5869.2 5953.4 6046.6 2951.2 2990.8 3004.6 3037.5 3073.6 3151.6 3206.4 3229.1 3238.7 3272.6 663.6 663.9 665.6 681.2 683.1 448.4 462.6 470.3 483.7 484.3 8567.7 9382.4 9826.6 9918.9 10064.9 470.5 484.3 490.6 495.5 496.3 3734.3 3775.6 3810.2 3928.2 3963.2 45464.0 47885.5 57385.7 58134.7 58479.0 32491.7 41736.6 42330.6 43790.3 49907.8 38628.8 39575.6 40953.0 42431.6 45836.3 9193.4 9597.8 9715.9 9784.8 9834.0 24420.5 24632.4 24736.9 25549.2 25590.7 29549.7 29830.6 30036.4 30071.4 30703.4 11131.4 11173.6 11240.2 11516.3 11815.3 12703.5 12886.2 13054.3 13101.9 13187.2 10851.6 11787.0 12016.3 12115.9 12246.4 12026.8 12148.8 12223.7 12934.7 13397.7 11816.2 12065.9 12066.2 12116.9 12270.3 8263.2 8436.6 8832.7 9090.6 9210.9 9040.1 9615.6 9846.2 9891.1 9981.3 07:38:08 INFO - PID 25573 | -------- Summary: end -------- 07:38:08 INFO - PID 25573 | 07:38:09 INFO - TEST-INFO | 25573: exit 0 07:38:09 INFO - TEST-OK | dromaeo_css | took 1123236ms 07:38:09 INFO - TEST-START | kraken 07:38:09 INFO - operating with platform_type : linux_ 07:38:09 INFO - Initialising browser for kraken test... 07:38:09 INFO - TEST-INFO | started process 25907 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz_OB3j/profile http://localhost:44482/getInfo.html) 07:38:13 INFO - PID 25907 | __metrics Screen width/height:1600/1200 07:38:13 INFO - PID 25907 | colorDepth:24 07:38:13 INFO - PID 25907 | Browser inner width/height: 1024/697 07:38:13 INFO - PID 25907 | __metrics 07:38:14 ERROR - PID 25907 | 1490798294610 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 07:38:14 INFO - PID 25907 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:38:14 INFO - PID 25907 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:38:15 INFO - TEST-INFO | 25907: exit 0 07:38:15 INFO - Browser initialized. 07:38:15 INFO - Running cycle 1/1 for kraken test... 07:38:15 INFO - TEST-INFO | started process 26008 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz_OB3j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:38:27 INFO - PID 26008 | RSS: Main: 166920192 07:38:27 INFO - PID 26008 | 07:38:30 INFO - PID 26008 | Cycle 1(1): loaded http://localhost:44482/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44482/tests/kraken/driver.html?testName=audio-beat-detection) 07:38:31 INFO - PID 26008 | RSS: Main: 227225600 07:38:31 INFO - PID 26008 | 07:38:34 INFO - PID 26008 | Cycle 1(1): loaded http://localhost:44482/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44482/tests/kraken/driver.html?testName=audio-dft) 07:38:35 INFO - PID 26008 | RSS: Main: 204517376 07:38:35 INFO - PID 26008 | 07:38:38 INFO - PID 26008 | Cycle 1(1): loaded http://localhost:44482/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44482/tests/kraken/driver.html?testName=audio-fft) 07:38:38 INFO - PID 26008 | RSS: Main: 288317440 07:38:38 INFO - PID 26008 | 07:38:41 INFO - PID 26008 | Cycle 1(1): loaded http://localhost:44482/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44482/tests/kraken/driver.html?testName=audio-oscillator) 07:38:41 INFO - PID 26008 | RSS: Main: 200581120 07:38:41 INFO - PID 26008 | 07:38:44 INFO - PID 26008 | Cycle 1(1): loaded http://localhost:44482/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44482/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:38:44 INFO - PID 26008 | RSS: Main: 204996608 07:38:44 INFO - PID 26008 | 07:38:47 INFO - PID 26008 | Cycle 1(1): loaded http://localhost:44482/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44482/tests/kraken/driver.html?testName=imaging-darkroom) 07:38:48 INFO - PID 26008 | RSS: Main: 241090560 07:38:48 INFO - PID 26008 | 07:38:52 INFO - PID 26008 | Cycle 1(1): loaded http://localhost:44482/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44482/tests/kraken/driver.html?testName=imaging-desaturate) 07:38:52 INFO - PID 26008 | RSS: Main: 235581440 07:38:52 INFO - PID 26008 | 07:38:55 INFO - PID 26008 | Cycle 1(1): loaded http://localhost:44482/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44482/tests/kraken/driver.html?testName=json-parse-financial) 07:38:56 INFO - PID 26008 | RSS: Main: 240340992 07:38:56 INFO - PID 26008 | 07:38:58 INFO - PID 26008 | Cycle 1(1): loaded http://localhost:44482/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44482/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:38:58 INFO - PID 26008 | RSS: Main: 203739136 07:38:58 INFO - PID 26008 | 07:39:00 INFO - PID 26008 | Cycle 1(1): loaded http://localhost:44482/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44482/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:39:01 INFO - PID 26008 | RSS: Main: 212234240 07:39:01 INFO - PID 26008 | 07:39:03 INFO - PID 26008 | Cycle 1(1): loaded http://localhost:44482/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44482/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:39:04 INFO - PID 26008 | RSS: Main: 220741632 07:39:04 INFO - PID 26008 | 07:39:07 INFO - PID 26008 | Cycle 1(1): loaded http://localhost:44482/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44482/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:39:07 INFO - PID 26008 | RSS: Main: 228052992 07:39:07 INFO - PID 26008 | 07:39:11 INFO - PID 26008 | Cycle 1(1): loaded http://localhost:44482/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44482/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:39:11 INFO - PID 26008 | RSS: Main: 226242560 07:39:11 INFO - PID 26008 | 07:39:13 INFO - PID 26008 | Cycle 1(1): loaded http://localhost:44482/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44482/tests/kraken/driver.html?testName=ai-astar) 07:39:14 INFO - PID 26008 | RSS: Main: 295055360 07:39:14 INFO - PID 26008 | 07:39:14 INFO - PID 26008 | __start_tp_report 07:39:14 INFO - PID 26008 | _x_x_mozilla_page_load 07:39:14 INFO - PID 26008 | _x_x_mozilla_page_load_details 07:39:14 INFO - PID 26008 | |i|pagename|runs| 07:39:14 INFO - PID 26008 | |0;ai-astar;104;113;112;112;112;112;113;112;111;111 07:39:14 INFO - PID 26008 | |1;audio-beat-detection;151;124;133;169;125;124;124;123;147;130 07:39:14 INFO - PID 26008 | |2;audio-dft;163;165;167;166;164;164;166;165;165;167 07:39:14 INFO - PID 26008 | |3;audio-fft;76;76;79;102;75;75;75;77;91;75 07:39:14 INFO - PID 26008 | |4;audio-oscillator;83;86;112;84;85;84;108;86;84;124 07:39:14 INFO - PID 26008 | |5;imaging-gaussian-blur;114;115;115;114;114;114;113;114;113;116 07:39:14 INFO - PID 26008 | |6;imaging-darkroom;150;149;151;151;151;151;150;151;150;151 07:39:14 INFO - PID 26008 | |7;imaging-desaturate;94;94;94;95;94;94;95;95;95;95 07:39:14 INFO - PID 26008 | |8;json-parse-financial;68;66;66;66;68;67;69;67;68;68 07:39:14 INFO - PID 26008 | |9;json-stringify-tinderbox;55;55;56;55;57;56;56;55;56;56 07:39:14 INFO - PID 26008 | |10;stanford-crypto-aes;84;86;91;91;85;82;86;84;83;84 07:39:14 INFO - PID 26008 | |11;stanford-crypto-ccm;135;132;144;142;134;153;135;138;186;134 07:39:14 INFO - PID 26008 | |12;stanford-crypto-pbkdf2;192;202;209;195;200;209;195;195;194;199 07:39:14 INFO - PID 26008 | |13;stanford-crypto-sha256-iterative;72;71;72;73;75;70;73;71;71;71 07:39:14 INFO - PID 26008 | __end_tp_report 07:39:14 INFO - PID 26008 | __start_cc_report 07:39:14 INFO - PID 26008 | _x_x_mozilla_cycle_collect,2013 07:39:14 INFO - PID 26008 | __end_cc_report 07:39:14 INFO - PID 26008 | __startTimestamp1490798354044__endTimestamp 07:39:14 INFO - PID 26008 | 07:39:14 INFO - PID 26008 | ------- Summary: start ------- 07:39:14 INFO - PID 26008 | Number of tests: 14 07:39:14 INFO - PID 26008 | 07:39:14 INFO - PID 26008 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:2.62 (2.3%) stddev-sans-first:0.71 07:39:14 INFO - PID 26008 | Values: 104.0 113.0 112.0 112.0 112.0 112.0 113.0 112.0 111.0 111.0 07:39:14 INFO - PID 26008 | 07:39:14 INFO - PID 26008 | [#1] audio-beat-detection Cycles:10 Average:135.00 Median:131.50 stddev:15.61 (11.9%) stddev-sans-first:15.44 07:39:14 INFO - PID 26008 | Values: 151.0 124.0 133.0 169.0 125.0 124.0 124.0 123.0 147.0 130.0 07:39:14 INFO - PID 26008 | 07:39:14 INFO - PID 26008 | [#2] audio-dft Cycles:10 Average:165.20 Median:165.50 stddev:1.32 (0.8%) stddev-sans-first:1.13 07:39:14 INFO - PID 26008 | Values: 163.0 165.0 167.0 166.0 164.0 164.0 166.0 165.0 165.0 167.0 07:39:14 INFO - PID 26008 | 07:39:14 INFO - PID 26008 | [#3] audio-fft Cycles:10 Average:80.10 Median:76.00 stddev:9.11 (12.0%) stddev-sans-first:9.54 07:39:14 INFO - PID 26008 | Values: 76.0 76.0 79.0 102.0 75.0 75.0 75.0 77.0 91.0 75.0 07:39:14 INFO - PID 26008 | 07:39:14 INFO - PID 26008 | [#4] audio-oscillator Cycles:10 Average:93.60 Median:84.00 stddev:15.09 (18.0%) stddev-sans-first:15.51 07:39:14 INFO - PID 26008 | Values: 83.0 86.0 112.0 84.0 85.0 84.0 108.0 86.0 84.0 124.0 07:39:14 INFO - PID 26008 | 07:39:14 INFO - PID 26008 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:0.92 (0.8%) stddev-sans-first:0.97 07:39:14 INFO - PID 26008 | Values: 114.0 115.0 115.0 114.0 114.0 114.0 113.0 114.0 113.0 116.0 07:39:14 INFO - PID 26008 | 07:39:14 INFO - PID 26008 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:151.00 stddev:0.71 (0.5%) stddev-sans-first:0.73 07:39:14 INFO - PID 26008 | Values: 150.0 149.0 151.0 151.0 151.0 151.0 150.0 151.0 150.0 151.0 07:39:14 INFO - PID 26008 | 07:39:14 INFO - PID 26008 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 07:39:14 INFO - PID 26008 | Values: 94.0 94.0 94.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 07:39:14 INFO - PID 26008 | 07:39:14 INFO - PID 26008 | [#8] json-parse-financial Cycles:10 Average:67.30 Median:68.00 stddev:1.06 (1.6%) stddev-sans-first:1.09 07:39:14 INFO - PID 26008 | Values: 68.0 66.0 66.0 66.0 68.0 67.0 69.0 67.0 68.0 68.0 07:39:14 INFO - PID 26008 | 07:39:14 INFO - PID 26008 | [#9] json-stringify-tinderbox Cycles:10 Average:55.70 Median:56.00 stddev:0.67 (1.2%) stddev-sans-first:0.67 07:39:14 INFO - PID 26008 | Values: 55.0 55.0 56.0 55.0 57.0 56.0 56.0 55.0 56.0 56.0 07:39:14 INFO - PID 26008 | 07:39:14 INFO - PID 26008 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:85.50 stddev:3.10 (3.6%) stddev-sans-first:3.23 07:39:14 INFO - PID 26008 | Values: 84.0 86.0 91.0 91.0 85.0 82.0 86.0 84.0 83.0 84.0 07:39:14 INFO - PID 26008 | 07:39:14 INFO - PID 26008 | [#11] stanford-crypto-ccm Cycles:10 Average:143.30 Median:140.00 stddev:16.28 (11.6%) stddev-sans-first:16.99 07:39:14 INFO - PID 26008 | Values: 135.0 132.0 144.0 142.0 134.0 153.0 135.0 138.0 186.0 134.0 07:39:14 INFO - PID 26008 | 07:39:14 INFO - PID 26008 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:199.00 Median:199.50 stddev:6.07 (3.0%) stddev-sans-first:5.89 07:39:14 INFO - PID 26008 | Values: 192.0 202.0 209.0 195.0 200.0 209.0 195.0 195.0 194.0 199.0 07:39:14 INFO - PID 26008 | 07:39:14 INFO - PID 26008 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.90 Median:72.00 stddev:1.45 (2.0%) stddev-sans-first:1.54 07:39:14 INFO - PID 26008 | Values: 72.0 71.0 72.0 73.0 75.0 70.0 73.0 71.0 71.0 71.0 07:39:14 INFO - PID 26008 | -------- Summary: end -------- 07:39:14 INFO - PID 26008 | 07:39:15 INFO - TEST-INFO | 26008: exit 0 07:39:15 INFO - TEST-OK | kraken | took 65604ms 07:39:15 INFO - SUITE-END | took 1188s 07:39:15 INFO - Completed test suite (00:19:49) 07:39:15 INFO - javascript benchmark 07:39:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6489.978760502172, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2656.667916510436, 2694.124409566889, 2724.073814902931, 2728.877200525976, 2751.0233866977223, 4818.445878723948, 4910.6317026223, 5038.47096054914, 5067.265246539249, 5104.642675012746, 4979.078870408968, 4992.750362481879, 5023.221400682891, 5056.519630635093, 5081.796728130879, 4518.932216016762, 4566.817327306912, 4608.331791890174, 4663.976680116594, 4676.5089665584965, 4648.558386953234, 4675.064987002596, 4683.555062269079, 4694.155052090622, 4731.668783185179, 4535.750533720644, 4569.0, 4569.6801223914335, 4630.120277147331, 4664.813407463697, 4597.126545956257, 4602.102589994953, 4602.148602508513, 4655.092257009885, 4666.953330466686, 4508.323751437278, 4511.210538155809, 4512.390827238347, 4543.295789152687, 4567.086582683477, 4840.806367745286, 4883.12103821312, 4886.096072226649, 4890.8288209912835, 4946.87632809179, 5249.055170069386, 5249.4750524947585, 5251.973740131275, 5253.474652534755, 5255.474452554752, 5250.868728281824, 5276.076686579871, 5324.361076670824, 5408.080626293539, 5414.187871819219, 5028.748562571856, 5038.622103342264, 5040.2691609716385, 5046.772895219724, 5082.059818933509, 5453.481919217668, 5490.945090549123, 5511.641743286674, 5515.503604675599, 5562.86092847674, 5211.5049070338255, 5261.921071183859, 5267.972745314627, 5299.31108955841, 5300.867478313073, 5363.356397232279, 5364.8122315718765, 5365.597580181502, 5389.218563308376, 5418.647787893774, 5320.0, 5343.0649636314265, 5345.0, 5345.305110335631, 5401.0, 5261.947380526222, 5273.472652734773, 5311.309529761106, 5313.388960269618, 5320.76056577455, 4491.169133710274, 4497.730136191839, 4528.320751887178, 4536.841210557614, 4544.409226800495, 3875.4380614811257, 3879.1078052048188, 3882.2623701496627, 3916.7649941003633, 3921.431392448079, 4506.864794056183, 4559.6124329431705, 4588.242939914877, 4591.65562582801, 4629.351890735233, 5335.626506144533, 5376.677399356051, 5407.459254074561, 5416.620836541404, 5417.945820541823, 4563.612092972135, 4578.9542104579195, 4588.88527786808, 4592.862214133581, 4641.187792136363, 4793.0, 4799.952000480021, 4801.95198048022, 4802.159622066194, 4851.975740121347, 4893.6085113191575, 4940.8764780880765, 4949.777260023236, 5075.365579302587, 5129.256257842518, 5417.322834645669, 5421.701806400686, 5432.103702888979, 5442.755076021668, 5481.314835645544, 5057.190849464068, 5059.772310245974, 5064.873378165576, 5071.0872043032605, 5082.822101226439, 5217.191335343028, 5248.6588371755715, 5270.8155214567305, 5344.518993290622, 5347.358317001985, 5404.405515393382, 5418.539424148991, 5428.945710542844, 5476.233327334096, 5479.616426850242, 5101.897962040813, 5161.741912904415, 5255.02781985334, 5272.841814745564, 5278.366596008504, 5272.235525848807, 5294.549963253013, 5295.4969277918535, 5297.073012222922, 5300.443453437333, 5086.491350864884, 5182.740862956913, 5189.6886186828915, 5239.135542635422, 5251.0, 5271.973640131775, 5308.867278318073, 5310.495502927216, 5313.920291195558, 5314.309139811954, 5018.598512118949, 5067.9239811403595, 5075.847724568269, 5119.0273847968765, 5123.820666276662], "value": 4908.614262902932, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.5630489742488, 647.1942431672568, 667.1160712056525, 1037.0562787863046, 1053.5048527192228, 27073.0, 31059.0, 31489.84255078724, 31523.684763152418, 31541.053768386926, 32747.0, 33155.66844331556, 33253.83373083137, 33292.83353583229, 33368.332633347316, 5527.723613819313, 7169.318914703108, 7330.706771729125, 7332.046833911584, 7333.486655934087, 5587.0, 7013.053237812906, 7179.9282007180045, 7182.9281707183045, 7183.281671832827, 7243.927560724404, 7295.270472952689, 7295.452841036943, 7299.525530840505, 7310.34206921377, 7231.385332246739, 7298.124225092996, 7411.518251313647, 7414.888776668355, 7421.591812450313, 7090.468214883905, 7164.856702865914, 7166.713331466735, 7169.920722990327, 7194.748183813542, 32341.191470213198, 32484.6751532484, 32515.512267316008, 32560.0, 32639.0, 2553.706323772771, 2567.5763499022823, 2574.2277316804884, 2581.9870900645565, 2623.842569445839, 23058.53882922349, 23204.53590928172, 23217.53564928709, 23316.067357305856, 23499.41251468727, 2998.78211911275, 3013.186439661301, 3022.2595464111214, 3025.788194826363, 3025.8940937067096, 152931.0, 153490.0, 153850.0, 154053.2297338506, 154357.99999999886, 41573.58426415757, 41831.58168418338, 41976.58023419727, 41980.58019419828, 42111.578884210765, 44002.0, 44384.3342349865, 44406.33390499145, 44410.55589444129, 44492.77753611276, 12199.0, 12216.877831221575, 12225.938870305592, 12256.325902075294, 12362.814557781641, 7503.699852005968, 7596.886046709304, 9751.658691945748, 9777.071178238057, 9950.303478756563, 11737.119716021161, 11890.702732431586, 11904.404779761151, 11927.284362938251, 11937.88062119385, 4927.556519913153, 4993.675411098267, 4996.150654388763, 5016.917979038658, 5089.185730283137, 867.3711559119588, 872.581161042703, 900.617237673986, 915.9542022898828, 926.8563372677246, 19805.801941980684, 20213.494662633257, 21220.893895530422, 21236.36290911275, 21426.785732142478, 984.6799790068256, 994.4778991029767, 995.4425521707722, 1000.6597756762735, 1020.0411613083678, 10672.250848372554, 10761.83857242142, 10901.509432075576, 10973.670789876316, 10979.451027448597, 207243.0, 209341.0, 209451.0, 209781.0, 209855.0, 41089.58910410858, 41140.58859411367, 41183.1763364731, 41242.58757412388, 41248.79375603103, 1217.945192466341, 1257.5661396818084, 1260.7478504299177, 1267.9112462127748, 1269.6825793551611, 19146.52133696669, 19689.21243150258, 19995.0, 20161.596768064264, 20511.692324614844, 30104.09687709372, 30287.0, 30299.24251893632, 30321.0, 30327.0, 224260.0, 225362.0, 225862.0, 225974.0, 226703.0, 22623.886880565493, 26913.0, 27223.0, 27342.726572734813, 28533.0, 26588.601170982063, 33827.96680827474, 36685.26629467449, 37039.629603703615, 37192.628073718915, 29743.851280743456, 29757.5536366959, 29957.400851983275, 30037.54943675803, 30936.0, 30245.243868903453, 30378.84810575933, 30474.84762576173, 30990.22524436907, 31807.204819879687, 33329.0, 33640.327193456484, 33850.0, 34102.317953641286, 34245.143871403416, 27612.46227942208, 29077.563836542893, 30197.09408717742, 30282.0, 30304.393912122076, 21828.236011739515, 23947.760522394554, 24206.75793242045, 24326.51346973015, 24493.75506244986], "value": 14660.47222524651, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.72616578511247, 430.9698321117519, 435.74073426311344, 445.20753059553994, 447.3736768524066, 16190.271437785314, 17068.487945361645, 17303.91348043258, 17615.73576396352, 17723.645527089466, 18257.178426970786, 18444.44666659999, 18882.433526994213, 19090.427287181374, 19095.427137185907, 5472.480114389126, 5548.944510554883, 5638.802641907534, 5659.094544872821, 5659.292588426447, 5567.359753628344, 5660.830175094754, 5663.4336566343245, 5670.3479099903425, 5671.7731290748325, 5414.566834653218, 5552.0, 5598.188262701906, 5599.524040456566, 5614.494695477427, 5407.945920540784, 5573.860653483675, 5600.859978500529, 5616.719164041802, 5627.2684551008315, 5040.269160971675, 5043.823466178666, 5049.798008079672, 5057.74711264439, 5060.2409638554145, 21660.783392166035, 22088.88955555228, 22128.557428851334, 22230.777692223033, 22322.776772232395, 1540.9768853467208, 1545.8608725214672, 1553.9378424862991, 1594.9601259968479, 1597.8881478296523, 13635.727285454235, 14135.434582616683, 14409.855901440957, 14465.20441375724, 14780.334884930204, 1689.4002629066626, 1725.9137043147791, 1732.6361464092429, 1737.2703464544923, 1759.6304775997055, 95249.4275515207, 95864.0, 97145.0, 97154.51422742911, 97211.51394243054, 10978.670639880816, 11174.139249426364, 11317.773644527064, 11339.262947908359, 11378.829317560243, 16004.199790010452, 16025.358985640443, 16028.278727457293, 16060.19699015068, 16063.518094457186, 7332.853342933218, 7482.0, 7650.38796896247, 7675.577843218676, 7715.768526944201, 6836.7352039872785, 6858.039874417585, 6866.446436998517, 7022.613756243456, 7068.469864760164, 7231.783046508614, 7240.384567311732, 7255.201927787939, 7292.854142917218, 7351.77944661661, 1947.2405761752927, 1967.1442922328833, 1975.4737793039355, 1978.5943881504256, 2094.6117883035017, 854.2525290370926, 864.5158711121792, 877.9165979231963, 882.5895958379384, 905.5291248550717, 17111.0, 17157.313707451813, 17574.29702811899, 17654.11729413524, 18027.72958405625, 888.2938064238946, 902.3683421604903, 903.8779764731809, 905.0406569036842, 917.1653795046609, 9726.17327527154, 10389.688309350731, 11266.94366528162, 11531.538738450368, 12217.511299548096, 454614.0, 465557.0, 474312.0, 478999.0, 482251.0, 66906.33093669098, 81825.59087204645, 93650.0, 97805.0, 99619.50190249002, 1119.9160062995309, 1153.2676750263643, 1155.820847768597, 1166.7374840660784, 1169.386072312043, 17458.0, 17591.208395622485, 17694.557636058686, 18058.367957121438, 18426.262949481872, 42916.570834291255, 43274.567254328314, 43426.78286608673, 43591.56408435875, 44642.776786115865, 52887.20669190042, 54332.45667543274, 55130.44869551253, 55891.0, 56264.71867640636, 7692.269234422721, 7729.961350193213, 7803.960980195063, 7805.297523222937, 8052.919470805217, 11504.964553190253, 12240.204386714835, 12279.508819647472, 12303.630891073282, 12602.55891043809, 9570.760730981781, 9597.856032159663, 9693.176080032994, 9858.309918305937, 10123.59505619767, 9178.541072946193, 9246.95376523113, 9266.907330926873, 9297.209737172416, 9544.141027307576, 10151.898481015096, 10161.695149145537, 10486.842697359698, 10572.788544229226, 10876.673699788702, 7676.0, 7729.0, 7771.8834217485655, 7932.36541076724, 7976.441649084509, 9998.85093648674, 9999.35004224752, 10095.646652367132, 10440.164786816884, 10604.310719803188], "value": 8941.752257657081, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1130.0620484997453, 1268.7018550640598, 1323.629383772544, 1337.6254648698364, 1343.0867010432908, 8026.11712711602, 9342.439453632787, 9562.904370956288, 9572.13850753432, 9584.76038099048, 9580.61677532898, 9724.805503889918, 9724.93025767165, 9726.270529710264, 9737.853932191005, 2174.6303128468157, 2215.645496720525, 2217.124235926808, 2218.944526386845, 2219.04581030157, 1826.936057237997, 1882.6705326567865, 2182.9235976740815, 2240.7423146338137, 2248.415411992877, 2166.5775173841107, 2186.759456459788, 2189.200941656292, 2191.7698641642555, 2196.143504033428, 2120.989395053015, 2129.361191642501, 2143.303426386423, 2160.2007257314735, 2163.296928498244, 2168.0894024509744, 2178.411828806229, 2188.8577242479187, 2191.550732099916, 2192.2984644913636, 9371.390859594172, 9586.76033099171, 9606.183474404614, 9615.375000625007, 9616.95191524038, 5175.197844334134, 5374.516293533601, 5384.219288203228, 5393.919091213635, 5408.675479471244, 3153.8423078846195, 3164.6677098904515, 3208.871645134192, 3222.1139186723603, 3265.510173473974, 1156.6645672754892, 1161.506359797083, 1173.8356630071796, 1190.5892467098838, 1582.1061100478194, 13058.608241752763, 13094.0, 13120.081594288404, 13129.146605470709, 13204.273764942829, 4351.804168812348, 4578.221702310615, 4630.21286381316, 4648.976755116203, 4673.719576825401, 10455.111315538265, 10479.528421221063, 10494.422806745702, 10495.632652857113, 10503.422311772772, 5319.707416092075, 5321.920171197435, 5359.544438722753, 5360.65155764874, 5378.569714422837, 4858.927116093261, 4896.6572339935865, 4925.926111108336, 4936.654434189572, 4981.526754958273, 3280.7375409967144, 3397.0, 3769.8680546180753, 3847.1343947611563, 3864.111254411445, 1066.9573217071231, 1072.5924148823553, 1093.294824837975, 1101.5758932810925, 1105.3699391347016, 695.2977492732376, 699.4439420660588, 715.1275443958466, 724.8876424154264, 740.7259314053726, 5274.7098909560345, 5855.151003104526, 5861.5603829712945, 5948.137520059654, 6210.9068363974575, 819.610684924656, 819.8770184472377, 831.5094094484283, 837.9329653627696, 840.2395831772255, 3150.322680623631, 3244.4484437645656, 3299.8075524531087, 3363.4450315698127, 3372.8819491317686, 10954.835677464844, 11424.942875285737, 11933.880661193278, 11934.045276377869, 11953.282803031845, 11333.546658133582, 11712.180147389772, 11766.58816941403, 11781.293122412682, 11801.704957376134, 9009.684661036832, 9223.216026637676, 9223.953880230421, 9224.123708247706, 9228.95385523068, 5599.468050535193, 5632.183333416549, 5696.458836410535, 5721.742521586455, 5729.197912292366, 10725.088367488539, 11150.888491114985, 11156.051735602565, 11189.496472658913, 11312.773744525228, 11306.886931130583, 11450.255733377304, 11488.19582629208, 11584.362860042778, 11596.36220007874, 7613.695452182073, 7874.921250787419, 7939.880901786593, 8126.268635822805, 8126.796830079059, 7796.61016949139, 7997.680092796456, 8649.178328058824, 8829.426087304562, 8938.195562399154, 7354.485186036926, 7388.6675099621725, 7395.223501532261, 7496.7376141834775, 7611.581363025087, 7574.962125189339, 7695.115061767744, 7797.493162944391, 7862.488938218998, 7909.1695371985115, 6980.371766541036, 6984.895226571707, 7010.36906678381, 7018.052562903943, 7038.718451261892, 4910.8281210157475, 5010.223415370623, 5015.122353588181, 5024.171011783015, 5066.746662666926, 5004.124278251365, 5025.170846810235, 5074.188129899198, 5206.609504287269, 5233.39815921174], "value": 4557.275042789947, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.9732618716689, 405.33322684184515, 409.0673264955902, 411.7426608369769, 412.7028539451594, 5288.0, 5297.549708274796, 5366.758495867691, 5393.1910213468, 5406.864828379293, 5060.822871199509, 5265.0, 5268.209768534722, 5289.153735402337, 5322.973385133078, 4116.464859568252, 4128.0, 4151.58484151584, 4152.9999999999845, 4154.106867023589, 4142.730722503027, 4152.958470415288, 4160.375943608467, 4164.666826653875, 4172.436721042651, 4051.6961227907877, 4099.44657471242, 4103.466549348581, 4139.606737359961, 4147.709660323779, 4081.5918408159246, 4090.734102283342, 4093.2427500912277, 4094.6110119538894, 4107.466029416171, 3593.2274560969254, 3604.53141091659, 3608.621094785036, 3610.548681414823, 3637.1634524059614, 4823.421189457287, 5106.106431374495, 5111.616628752859, 5119.616028797818, 5123.615728820353, 4612.76936153191, 4628.514006029386, 4639.280911458729, 4655.767211639404, 4656.441227052742, 5582.581306401996, 5594.9720251398885, 5595.720213989284, 5602.887942241132, 5605.607607467479, 3773.924521509582, 3868.535775706905, 3874.6900247980375, 3876.7286289959716, 3880.47613572167, 5524.801151125173, 5700.942990570041, 5722.2561067061015, 5827.592068555203, 5863.58954873159, 3919.412088186795, 3919.8040097994985, 3922.686185105185, 3928.233994371127, 3937.310970580137, 3979.880603581897, 3981.980090099589, 3987.1228329767405, 3989.501312335958, 4001.7198796083994, 4393.29707246839, 4395.318725597537, 4601.700889442175, 4628.454350107428, 4642.582167604932, 5567.47109024642, 5576.247206627135, 5586.190002449704, 5593.860153496195, 5628.831135065954, 1370.7052983608571, 1375.931203439824, 1377.1461693749939, 1378.4486205517874, 1396.818413606245, 901.1574178143326, 958.1568219966385, 969.9466529340813, 974.2741657465234, 979.5543027922279, 4867.294242334912, 4884.633652476078, 4895.388076490439, 4895.388076490439, 4910.90178196434, 5794.855128621818, 5802.6808525531505, 5812.680302583314, 5817.505512031525, 5823.980803359395, 4642.257238841769, 4904.2643603459055, 4906.70559766408, 4910.593809033548, 4921.581665558396, 3060.816351018946, 3067.5858759067687, 3068.6164229471315, 3072.927072927073, 3076.215794838988, 5398.568114550826, 5436.266104075979, 5440.591955603346, 5443.646162999393, 5468.343798744176, 5670.7240870803735, 5903.734331955073, 5906.675132867734, 5963.0023941979925, 5995.790147344822, 5407.432219616883, 5431.2667789847865, 5453.618246722692, 5481.355593321988, 5488.53347465462, 5655.88688226225, 5783.681897495678, 5807.680577568105, 5838.532917366685, 5847.26909136358, 5668.688222147822, 5705.828825135252, 5717.199592057199, 5717.7141142941855, 5725.112607545837, 5146.305248791366, 5239.397469291081, 5271.710055946806, 5450.482204190755, 5467.261919640957, 4050.270951228807, 4051.93922091163, 4057.91884162321, 4066.207089617496, 4067.0, 5744.942550574441, 5781.624194427349, 5782.739776709974, 5789.2763404574425, 5828.737706803289, 5445.428230035789, 5571.415001424792, 5588.217649528988, 5620.85947851307, 5621.887562248814, 5564.638298510584, 5565.526930210815, 5577.498025177753, 5585.525230355465, 5592.412796656293, 5335.973320133529, 5520.447955204448, 5537.0, 5541.722913854211, 5556.527695145796, 5587.664740115606, 5619.8876022480135, 5634.774609015757, 5639.915401268902, 5642.802501912413, 5474.945250547603, 5476.178573213891, 5478.643888147258, 5498.697571633438, 5506.356948664744], "value": 4206.7101232481, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.2614202803003, 691.8062942376135, 695.5096656856916, 704.6371118873781, 711.7579823208499, 11137.610183643574, 11641.825372619418, 11678.824817627743, 11730.472128754205, 11740.882591174086, 11366.204365694404, 11393.088552915748, 11396.829047564293, 11401.201915865893, 11425.257358271707, 869.4870026684255, 884.9778755531099, 915.3912648089046, 919.1130559010553, 926.3700683535193, 939.9953000235023, 940.4874343482784, 941.3316545252878, 941.6421759731293, 946.153192892361, 976.8681228034195, 976.9316147869652, 977.291463688827, 977.4623956823754, 979.1139019187611, 972.2270794718216, 972.7081875437341, 973.5181085362719, 974.0503009565688, 977.0522593084696, 718.1992078832117, 719.6329871765384, 720.0243669827361, 720.8342081321325, 722.7073035420663, 11669.183157179, 11881.465334059989, 12869.970402367788, 12954.48182072716, 12994.0, 11840.230385024946, 12632.621021369374, 12634.684132896658, 12767.425465853967, 13096.279704616243, 9314.487703176323, 9496.287778416578, 9549.09283618055, 9749.951250243703, 9782.608695652165, 2433.36736413286, 2465.716442609105, 2484.5155194737035, 2491.5515207262683, 2545.1982625472915, 61518.38481615216, 63233.68383158101, 63529.04706429407, 63570.36429635691, 64243.67878160579, 10592.364458132537, 10637.73405664849, 10728.249022568345, 10751.354918704747, 10889.401082940356, 21267.255646052316, 21643.78356216449, 21677.891610542163, 21690.457738556663, 21990.120395184334, 5701.258836351248, 5845.444682755132, 5869.236999190078, 5953.404659534099, 6046.637201767908, 2951.2474319048506, 2990.7607391408637, 3004.5943797587483, 3037.4532584134627, 3073.6004319438775, 3151.5902932618615, 3206.422843888076, 3229.1119942016135, 3238.6923242291946, 3272.60728712556, 663.6383171171626, 663.857270686795, 665.6072916978909, 681.1961884975776, 683.1324218242903, 448.4058622325432, 462.64607575204997, 470.30864628996005, 483.74361588358227, 484.3146947069927, 8567.657293708307, 9382.437053776795, 9826.557804898797, 9918.900810991941, 10064.949675251577, 470.51771933767475, 484.2784251465291, 490.6075139888075, 495.4896456649657, 496.32995456134654, 3734.327820992193, 3775.565809931893, 3810.180811125566, 3928.194720082376, 3963.207358528306, 45464.0, 47885.5211447888, 57385.71307143437, 58134.7093264531, 58479.0, 32491.675083249338, 41736.58263417388, 42330.57669423328, 43790.34314485285, 49907.75046124746, 38628.80685596554, 39575.60424395719, 40953.0, 42431.57568424338, 45836.31245531253, 9193.402428842104, 9597.760055998657, 9715.902840971783, 9784.755381115529, 9833.950830245803, 24420.51158976846, 24632.384190394667, 24736.876315619025, 25549.23352299434, 25590.744092558834, 29549.704502954693, 29830.552541712324, 30036.399272014874, 30071.398572028, 30703.385932281675, 11131.387773672526, 11173.553057877594, 11240.15698822608, 11516.251443656136, 11815.29630423218, 12703.491860325854, 12886.226826390446, 13054.282014489294, 13101.934490327487, 13187.208767473981, 10851.565937362417, 11787.0, 12016.33910134951, 12115.878841211475, 12246.387680616112, 12026.819597706217, 12148.817767733315, 12223.69440763988, 12934.741305173655, 13397.732045359233, 11816.172867899164, 12065.879341206475, 12066.215695979734, 12116.878831211576, 12270.32513211782, 8263.214994575506, 8436.620352084294, 8832.690855820016, 9090.59092340833, 9210.907890921273, 9040.050794666466, 9615.5672994714, 9846.163076138322, 9891.110237826486, 9981.251406144424], "value": 6056.85167209812, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1567.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 112.0, 112.0, 112.0, 112.0, 113.0, 112.0, 111.0, 111.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 124.0, 133.0, 169.0, 125.0, 124.0, 124.0, 123.0, 147.0, 130.0], "value": 135.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 167.0, 166.0, 164.0, 164.0, 166.0, 165.0, 165.0, 167.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 79.0, 102.0, 75.0, 75.0, 75.0, 77.0, 91.0, 75.0], "value": 80.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 112.0, 84.0, 85.0, 84.0, 108.0, 86.0, 84.0, 124.0], "value": 93.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 114.0, 114.0, 114.0, 113.0, 114.0, 113.0, 116.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 151.0, 151.0, 151.0, 151.0, 150.0, 151.0, 150.0, 151.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 66.0, 66.0, 68.0, 67.0, 69.0, 67.0, 68.0, 68.0], "value": 67.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 55.0, 57.0, 56.0, 56.0, 55.0, 56.0, 56.0], "value": 55.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 91.0, 91.0, 85.0, 82.0, 86.0, 84.0, 83.0, 84.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 132.0, 144.0, 142.0, 134.0, 153.0, 135.0, 138.0, 186.0, 134.0], "value": 143.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 202.0, 209.0, 195.0, 200.0, 209.0, 195.0, 195.0, 194.0, 199.0], "value": 199.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 72.0, 73.0, 75.0, 70.0, 73.0, 71.0, 71.0, 71.0], "value": 71.9, "unit": "score"}]}]} 07:39:15 INFO - Return code: 0 07:39:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:39:15 ERROR - # TBPL SUCCESS # 07:39:15 INFO - Running post-action listener: _resource_record_post_action 07:39:15 INFO - [mozharness: 2017-03-29 14:39:15.848615Z] Finished run-tests step (success) 07:39:15 INFO - Running post-run listener: _resource_record_post_run 07:39:15 INFO - Total resource usage - Wall time: 1206s; CPU: 13.0%; Read bytes: 4096; Write bytes: 371396608; Read time: 12; Write time: 275024 07:39:15 INFO - TinderboxPrint: CPU usage
13.0% 07:39:15 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 07:39:15 INFO - TinderboxPrint: I/O write bytes / time
371,396,608 / 275,024 07:39:15 INFO - TinderboxPrint: CPU idle
8,373.5 (87.0%) 07:39:15 INFO - TinderboxPrint: CPU user
1,206.0 (12.5%) 07:39:15 INFO - TinderboxPrint: Swap in / out
0 / 0 07:39:15 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 109797376; Read time: 0; Write time: 110996 07:39:15 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 261599232; Read time: 0; Write time: 164028 07:39:16 INFO - Running post-run listener: _upload_blobber_files 07:39:16 INFO - Blob upload gear active. 07:39:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:39:16 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:39:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:39:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:39:16 INFO - (blobuploader) - INFO - Open directory for files ... 07:39:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:39:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:39:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:39:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:39:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:39:20 INFO - (blobuploader) - INFO - Done attempting. 07:39:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:39:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:39:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:39:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:39:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:39:20 INFO - (blobuploader) - INFO - Done attempting. 07:39:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:39:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:39:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:39:21 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:39:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:39:21 INFO - (blobuploader) - INFO - Done attempting. 07:39:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:39:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:39:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:39:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:39:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:39:22 INFO - (blobuploader) - INFO - Done attempting. 07:39:22 INFO - (blobuploader) - INFO - Iteration through files over. 07:39:22 INFO - Return code: 0 07:39:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:39:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:39:22 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/afc91abfc4a8fc4745f3a22a7ba09c8daa40148db0cca15fe02ac7ca71831e954231ab69288a36b69aea1556098e540c285a14a867854064c4e8413fba994b25", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91dc4765cbefc4c6b3712122b8b572710ff8e3a6043a1c8e55d9f495b353f8d88891fd03008c62640556460006b64e82f5599f1036527af694afec28e06c6389", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cbd3edba2ea1526a2877949c38cf8e4c5080e261bf42be6f0a2e2d1f6bb5436651474b9aa3b711f6c463fe4783a2c753d0eb796dfefb2bdecb513c5eec8470b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a570c55505a992da49218690159e796137c6a681658e85b916f33f47c072aecdb2ee6d18155d9bd6051d3953148436a98f73ed0533fc27a9751f1ecce68e43ef"} 07:39:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:39:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:39:22 INFO - Contents: 07:39:22 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/afc91abfc4a8fc4745f3a22a7ba09c8daa40148db0cca15fe02ac7ca71831e954231ab69288a36b69aea1556098e540c285a14a867854064c4e8413fba994b25", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91dc4765cbefc4c6b3712122b8b572710ff8e3a6043a1c8e55d9f495b353f8d88891fd03008c62640556460006b64e82f5599f1036527af694afec28e06c6389", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cbd3edba2ea1526a2877949c38cf8e4c5080e261bf42be6f0a2e2d1f6bb5436651474b9aa3b711f6c463fe4783a2c753d0eb796dfefb2bdecb513c5eec8470b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a570c55505a992da49218690159e796137c6a681658e85b916f33f47c072aecdb2ee6d18155d9bd6051d3953148436a98f73ed0533fc27a9751f1ecce68e43ef"} 07:39:22 INFO - Running post-run listener: copy_logs_to_upload_dir 07:39:22 INFO - Copying logs to upload dir... 07:39:22 INFO - mkdir: /builds/slave/test/build/upload/logs 07:39:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.112980 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-03-29 07:39:22.431704) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-29 07:39:22.435795) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1490797096.143068-716033130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/afc91abfc4a8fc4745f3a22a7ba09c8daa40148db0cca15fe02ac7ca71831e954231ab69288a36b69aea1556098e540c285a14a867854064c4e8413fba994b25", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91dc4765cbefc4c6b3712122b8b572710ff8e3a6043a1c8e55d9f495b353f8d88891fd03008c62640556460006b64e82f5599f1036527af694afec28e06c6389", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cbd3edba2ea1526a2877949c38cf8e4c5080e261bf42be6f0a2e2d1f6bb5436651474b9aa3b711f6c463fe4783a2c753d0eb796dfefb2bdecb513c5eec8470b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a570c55505a992da49218690159e796137c6a681658e85b916f33f47c072aecdb2ee6d18155d9bd6051d3953148436a98f73ed0533fc27a9751f1ecce68e43ef"} build_url:https://queue.taskcluster.net/v1/task/Crwqb97NQPO9V41oSfMN8g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011180 build_url: 'https://queue.taskcluster.net/v1/task/Crwqb97NQPO9V41oSfMN8g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/afc91abfc4a8fc4745f3a22a7ba09c8daa40148db0cca15fe02ac7ca71831e954231ab69288a36b69aea1556098e540c285a14a867854064c4e8413fba994b25", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91dc4765cbefc4c6b3712122b8b572710ff8e3a6043a1c8e55d9f495b353f8d88891fd03008c62640556460006b64e82f5599f1036527af694afec28e06c6389", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cbd3edba2ea1526a2877949c38cf8e4c5080e261bf42be6f0a2e2d1f6bb5436651474b9aa3b711f6c463fe4783a2c753d0eb796dfefb2bdecb513c5eec8470b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a570c55505a992da49218690159e796137c6a681658e85b916f33f47c072aecdb2ee6d18155d9bd6051d3953148436a98f73ed0533fc27a9751f1ecce68e43ef"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-29 07:39:22.461804) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 07:39:22.462208) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1490797096.143068-716033130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004446 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 07:39:22.544086) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-29 07:39:22.544407) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-29 07:39:22.544707) ========= ========= Total master_lag: 0.16 =========