builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-080 starttime: 1490312862.56 results: success (0) revision: 01d1dedf400d4be413b1a0d48090dca7acf29637 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 16:47:42.563950) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 16:47:42.564851) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 16:47:42.565249) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 16:47:42.581189) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 16:47:42.581465) ========= 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=781b77c4c33858b1f599d705000001c1-1490312862.66852-788313833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-23 16:47:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.8M=0s 2017-03-23 16:47:42 (42.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.104267 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 16:47:42.700297) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 16:47:42.700860) ========= 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=781b77c4c33858b1f599d705000001c1-1490312862.66852-788313833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021575 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 16:47:42.751929) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-23 16:47:42.752536) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 01d1dedf400d4be413b1a0d48090dca7acf29637 --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 01d1dedf400d4be413b1a0d48090dca7acf29637 --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=781b77c4c33858b1f599d705000001c1-1490312862.66852-788313833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-23 16:47:42,899 truncating revision to first 12 chars 2017-03-23 16:47:42,899 Setting DEBUG logging. 2017-03-23 16:47:42,899 attempt 1/10 2017-03-23 16:47:42,899 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/01d1dedf400d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-23 16:47:43,978 unpacking tar archive at: mozilla-central-01d1dedf400d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.373710 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-23 16:47:44.141596) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 16:47:44.141996) ========= script_repo_revision: 01d1dedf400d4be413b1a0d48090dca7acf29637 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 16:47:44.142411) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 16:47:44.142841) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 16:47:44.152925) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-03-23 16:47:44.153237) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=781b77c4c33858b1f599d705000001c1-1490312862.66852-788313833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:47:44 INFO - MultiFileLogger online at 20170323 16:47:44 in /builds/slave/test 16:47:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 16:47:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:47:44 INFO - {'append_to_log': False, 16:47:44 INFO - 'base_work_dir': '/builds/slave/test', 16:47:44 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:47:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:47:44 INFO - 'branch': 'Firefox-Non-PGO', 16:47:44 INFO - 'buildbot_json_path': 'buildprops.json', 16:47:44 INFO - 'config_files': ('talos/linux_config.py',), 16:47:44 INFO - 'default_actions': ('clobber', 16:47:44 INFO - 'read-buildbot-config', 16:47:44 INFO - 'download-and-extract', 16:47:44 INFO - 'populate-webroot', 16:47:44 INFO - 'create-virtualenv', 16:47:44 INFO - 'install', 16:47:44 INFO - 'run-tests'), 16:47:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:47:44 INFO - 'download_minidump_stackwalk': True, 16:47:44 INFO - 'download_symbols': 'ondemand', 16:47:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:47:44 INFO - 'tooltool.py': '/tools/tooltool.py', 16:47:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:47:44 INFO - '/tools/misc-python/virtualenv.py')}, 16:47:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:47:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:47:44 INFO - 'gecko_profile': False, 16:47:44 INFO - 'gecko_profile_interval': 0, 16:47:44 INFO - 'installer_path': 'installer.exe', 16:47:44 INFO - 'log_level': 'info', 16:47:44 INFO - 'log_name': 'talos', 16:47:44 INFO - 'log_to_console': True, 16:47:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:47:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:47:44 INFO - 'opt_config_files': (), 16:47:44 INFO - 'pip_index': False, 16:47:44 INFO - 'suite': 'dromaeojs-e10s', 16:47:44 INFO - 'system_bits': '32', 16:47:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:47:44 INFO - 'title': 'talos-linux64-ix-080', 16:47:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:47:44 INFO - 'use_talos_json': True, 16:47:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:47:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:47:44 INFO - 'work_dir': 'build'} 16:47:44 INFO - [mozharness: 2017-03-23 23:47:44.399001Z] Running clobber step. 16:47:44 INFO - Running pre-action listener: _resource_record_pre_action 16:47:44 INFO - Running main action method: clobber 16:47:44 INFO - rmtree: /builds/slave/test/build 16:47:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:47:45 INFO - Running post-action listener: _resource_record_post_action 16:47:45 INFO - [mozharness: 2017-03-23 23:47:45.386503Z] Finished clobber step (success) 16:47:45 INFO - [mozharness: 2017-03-23 23:47:45.386603Z] Running read-buildbot-config step. 16:47:45 INFO - Running pre-action listener: _resource_record_pre_action 16:47:45 INFO - Running main action method: read_buildbot_config 16:47:45 INFO - Using buildbot properties: 16:47:45 INFO - { 16:47:45 INFO - "project": "", 16:47:45 INFO - "product": "firefox", 16:47:45 INFO - "who": "kwierso@gmail.com", 16:47:45 INFO - "installer_path": "public/build/target.tar.bz2", 16:47:45 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:47:45 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 16:47:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 16:47:45 INFO - "stage_platform": "linux64", 16:47:45 INFO - "basedir": "/builds/slave/test", 16:47:45 INFO - "buildnumber": 484, 16:47:45 INFO - "platform": "ubuntu64_hw", 16:47:45 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:47:45 INFO - "slavebuilddir": "test", 16:47:45 INFO - "taskId": "fyEUuIDnQ2Cm5CweMWALXQ", 16:47:45 INFO - "branch": "mozilla-central", 16:47:45 INFO - "script_repo_revision": "production", 16:47:45 INFO - "revision": "01d1dedf400d4be413b1a0d48090dca7acf29637", 16:47:45 INFO - "slavename": "talos-linux64-ix-080", 16:47:45 INFO - "repo_path": "mozilla-central" 16:47:45 INFO - } 16:47:45 INFO - Finding installer, test and symbols from parent task. 16:47:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fyEUuIDnQ2Cm5CweMWALXQ'}, attempt #1 16:47:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fyEUuIDnQ2Cm5CweMWALXQ'}, attempt #1 16:47:46 INFO - Task dependencies: Bg3_ZOuERsGBA1k1GNxQSA 16:47:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA'}, attempt #1 16:47:46 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.tar.bz2 16:47:46 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/test_packages.json 16:47:46 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.crashreporter-symbols.zip 16:47:46 INFO - Running post-action listener: _resource_record_post_action 16:47:46 INFO - [mozharness: 2017-03-23 23:47:46.865113Z] Finished read-buildbot-config step (success) 16:47:46 INFO - [mozharness: 2017-03-23 23:47:46.865330Z] Running download-and-extract step. 16:47:46 INFO - Running pre-action listener: _resource_record_pre_action 16:47:46 INFO - Running main action method: download_and_extract 16:47:46 INFO - mkdir: /builds/slave/test/build/tests 16:47:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:46 INFO - trying https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.test_packages.json 16:47:46 INFO - Downloading https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:47:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:47:47 INFO - Downloaded 986 bytes. 16:47:47 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:47:47 INFO - Using the following test package requirements: 16:47:47 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:47:47 INFO - u'common': [u'target.common.tests.zip'], 16:47:47 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:47:47 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:47:47 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:47:47 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:47:47 INFO - u'mozbase': [u'target.common.tests.zip'], 16:47:47 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:47:47 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:47:47 INFO - u'web-platform': [u'target.common.tests.zip', 16:47:47 INFO - u'target.web-platform.tests.zip'], 16:47:47 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:47:47 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:47:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.common.tests.zip 16:47:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:47:47 INFO - Fetch https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.common.tests.zip into memory 16:47:48 INFO - Expected file size: 58125575 16:47:48 INFO - Obtained file size: 58125575 16:47:58 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:47:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.common.tests.zip 16:47:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:47:58 INFO - Fetch https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.common.tests.zip into memory 16:47:59 INFO - Expected file size: 58125575 16:47:59 INFO - Obtained file size: 58125575 16:48:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.talos.tests.zip 16:48:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:48:10 INFO - Fetch https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.talos.tests.zip into memory 16:48:11 INFO - Expected file size: 14404171 16:48:11 INFO - Obtained file size: 14404171 16:48:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:11 INFO - trying https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.tar.bz2 16:48:11 INFO - Downloading https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:48:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:48:12 INFO - Downloaded 62433763 bytes. 16:48:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.tar.bz2 16:48:12 INFO - mkdir: /builds/slave/test/properties 16:48:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:48:12 INFO - Writing to file /builds/slave/test/properties/build_url 16:48:12 INFO - Contents: 16:48:12 INFO - build_url:https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.tar.bz2 16:48:12 INFO - Running post-action listener: _resource_record_post_action 16:48:12 INFO - Running post-action listener: set_extra_try_arguments 16:48:12 INFO - [mozharness: 2017-03-23 23:48:12.471958Z] Finished download-and-extract step (success) 16:48:12 INFO - [mozharness: 2017-03-23 23:48:12.472054Z] Running populate-webroot step. 16:48:12 INFO - Running pre-action listener: _resource_record_pre_action 16:48:12 INFO - Running main action method: populate_webroot 16:48:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:48:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:48:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:48:12 INFO - '--tppagecycles', 16:48:12 INFO - '7'], 16:48:12 INFO - 'tests': ['tsvgm']}}, 16:48:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:48:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:48:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:48:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:48:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:48:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:48:12 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:48:12 INFO - 'talos_options': ['--disable-e10s'], 16:48:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:48:12 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:48:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:48:12 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:48:12 INFO - 'talos_options': ['--disable-e10s'], 16:48:12 INFO - 'tests': ['damp', 'tps']}, 16:48:12 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:48:12 INFO - 'tests': ['damp', 'tps']}, 16:48:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:48:12 INFO - 'tests': ['dromaeo_dom']}, 16:48:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:48:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:48:12 INFO - 'tests': ['basic_compositor_video']}, 16:48:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:48:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:48:12 INFO - 'tests': ['a11yr', 16:48:12 INFO - 'ts_paint', 16:48:12 INFO - 'tpaint', 16:48:12 INFO - 'sessionrestore', 16:48:12 INFO - 'sessionrestore_no_auto_restore', 16:48:12 INFO - 'tabpaint']}, 16:48:12 INFO - 'other-e10s': {'tests': ['a11yr', 16:48:12 INFO - 'ts_paint', 16:48:12 INFO - 'tpaint', 16:48:12 INFO - 'sessionrestore', 16:48:12 INFO - 'sessionrestore_no_auto_restore', 16:48:12 INFO - 'tabpaint']}, 16:48:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:48:12 INFO - 'ts_paint', 16:48:12 INFO - 'tpaint', 16:48:12 INFO - 'sessionrestore', 16:48:12 INFO - 'sessionrestore_no_auto_restore', 16:48:12 INFO - 'tabpaint']}, 16:48:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:48:12 INFO - 'ts_paint', 16:48:12 INFO - 'tpaint', 16:48:12 INFO - 'sessionrestore', 16:48:12 INFO - 'sessionrestore_no_auto_restore', 16:48:12 INFO - 'tabpaint']}, 16:48:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:48:12 INFO - 'tests': ['a11yr', 16:48:12 INFO - 'ts_paint', 16:48:12 INFO - 'tpaint', 16:48:12 INFO - 'sessionrestore', 16:48:12 INFO - 'sessionrestore_no_auto_restore', 16:48:12 INFO - 'tabpaint']}, 16:48:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:48:12 INFO - 'tests': ['a11yr', 16:48:12 INFO - 'ts_paint', 16:48:12 INFO - 'tpaint', 16:48:12 INFO - 'sessionrestore', 16:48:12 INFO - 'sessionrestore_no_auto_restore', 16:48:12 INFO - 'tabpaint']}, 16:48:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:48:12 INFO - 'tests': ['tsvgx', 16:48:12 INFO - 'tsvgr_opacity', 16:48:12 INFO - 'tart', 16:48:12 INFO - 'tscrollx', 16:48:12 INFO - 'cart', 16:48:12 INFO - 'tsvg_static']}, 16:48:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:48:12 INFO - 'tsvgr_opacity', 16:48:12 INFO - 'tart', 16:48:12 INFO - 'tscrollx', 16:48:12 INFO - 'cart', 16:48:12 INFO - 'tsvg_static']}, 16:48:12 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:48:12 INFO - 'talos_options': ['--disable-e10s'], 16:48:12 INFO - 'tests': ['tp5o']}, 16:48:12 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:48:12 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:48:12 INFO - 'talos_options': ['--disable-e10s', 16:48:12 INFO - '--xperf_path', 16:48:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:48:12 INFO - 'tests': ['tp5n']}, 16:48:12 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:48:12 INFO - 'talos_options': ['--xperf_path', 16:48:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:48:12 INFO - 'tests': ['tp5n']}}, 16:48:12 INFO - 'talos.zip': {'path': '', 16:48:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:48:12 INFO - Running post-action listener: _resource_record_post_action 16:48:12 INFO - [mozharness: 2017-03-23 23:48:12.485126Z] Finished populate-webroot step (success) 16:48:12 INFO - [mozharness: 2017-03-23 23:48:12.485214Z] Running create-virtualenv step. 16:48:12 INFO - Running pre-action listener: _resource_record_pre_action 16:48:12 INFO - Running main action method: create_virtualenv 16:48:12 INFO - Creating virtualenv /builds/slave/test/build/venv 16:48:12 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:48:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:48:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:48:12 INFO - Using real prefix '/usr' 16:48:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:48:13 INFO - Installing distribute.............................................................................................................................................................................................done. 16:48:15 INFO - Installing pip.................done. 16:48:15 INFO - Return code: 0 16:48:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:48:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:48:15 INFO - Reading from file tmpfile_stdout 16:48:15 INFO - Output received: 16:48:15 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 16:48:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e8f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f87a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x212cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212a290>, '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 0x212ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212b040>, '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': '781b77c4c33858b1f599d705000001c1-1490312862.66852-788313833', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:48:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:48:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:48:15 INFO - Using env: {'DISPLAY': ':0', 16:48:15 INFO - 'HOME': '/home/cltbld', 16:48:15 INFO - 'LANG': 'en_US.UTF-8', 16:48:15 INFO - 'LANGUAGE': 'en_US:en', 16:48:15 INFO - 'LOGNAME': 'cltbld', 16:48:15 INFO - 'MAIL': '/var/mail/cltbld', 16:48:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:15 INFO - 'MOZ_NO_REMOTE': '1', 16:48:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:15 INFO - 'NO_EM_RESTART': '1', 16:48:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:15 INFO - 'PWD': '/builds/slave/test', 16:48:15 INFO - 'SHELL': '/bin/bash', 16:48:15 INFO - 'SHLVL': '1', 16:48:15 INFO - 'TERM': 'linux', 16:48:15 INFO - 'TMOUT': '86400', 16:48:15 INFO - 'USER': 'cltbld', 16:48:15 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1490312862.66852-788313833', 16:48:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:15 INFO - '_': '/tools/buildbot/bin/python'} 16:48:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:48:15 INFO - Cleaning up... 16:48:15 INFO - Return code: 0 16:48:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1e8f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f87a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x212cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212a290>, '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 0x212ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212b040>, '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': '781b77c4c33858b1f599d705000001c1-1490312862.66852-788313833', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:48:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:48:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:48:15 INFO - Using env: {'DISPLAY': ':0', 16:48:15 INFO - 'HOME': '/home/cltbld', 16:48:15 INFO - 'LANG': 'en_US.UTF-8', 16:48:15 INFO - 'LANGUAGE': 'en_US:en', 16:48:15 INFO - 'LOGNAME': 'cltbld', 16:48:15 INFO - 'MAIL': '/var/mail/cltbld', 16:48:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:15 INFO - 'MOZ_NO_REMOTE': '1', 16:48:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:15 INFO - 'NO_EM_RESTART': '1', 16:48:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:15 INFO - 'PWD': '/builds/slave/test', 16:48:15 INFO - 'SHELL': '/bin/bash', 16:48:15 INFO - 'SHLVL': '1', 16:48:15 INFO - 'TERM': 'linux', 16:48:15 INFO - 'TMOUT': '86400', 16:48:15 INFO - 'USER': 'cltbld', 16:48:15 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1490312862.66852-788313833', 16:48:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:15 INFO - '_': '/tools/buildbot/bin/python'} 16:48:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:15 INFO - Downloading/unpacking psutil>=3.1.1 16:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:48:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:48:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:48:17 INFO - Installing collected packages: psutil 16:48:17 INFO - Running setup.py install for psutil 16:48:17 INFO - building 'psutil._psutil_linux' extension 16:48:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:48:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:48:18 INFO - building 'psutil._psutil_posix' extension 16:48:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:48:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:48:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:48:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:48:18 INFO - Successfully installed psutil 16:48:18 INFO - Cleaning up... 16:48:18 INFO - Return code: 0 16:48:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:48:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:18 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 0x1e8f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f87a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x212cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212a290>, '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 0x212ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212b040>, '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': '781b77c4c33858b1f599d705000001c1-1490312862.66852-788313833', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:48:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:48:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:48:18 INFO - Using env: {'DISPLAY': ':0', 16:48:18 INFO - 'HOME': '/home/cltbld', 16:48:18 INFO - 'LANG': 'en_US.UTF-8', 16:48:18 INFO - 'LANGUAGE': 'en_US:en', 16:48:18 INFO - 'LOGNAME': 'cltbld', 16:48:18 INFO - 'MAIL': '/var/mail/cltbld', 16:48:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:18 INFO - 'MOZ_NO_REMOTE': '1', 16:48:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:18 INFO - 'NO_EM_RESTART': '1', 16:48:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:18 INFO - 'PWD': '/builds/slave/test', 16:48:18 INFO - 'SHELL': '/bin/bash', 16:48:18 INFO - 'SHLVL': '1', 16:48:18 INFO - 'TERM': 'linux', 16:48:18 INFO - 'TMOUT': '86400', 16:48:18 INFO - 'USER': 'cltbld', 16:48:18 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1490312862.66852-788313833', 16:48:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:18 INFO - '_': '/tools/buildbot/bin/python'} 16:48:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:48:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:48:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:48:20 INFO - Installing collected packages: mozsystemmonitor 16:48:20 INFO - Running setup.py install for mozsystemmonitor 16:48:20 INFO - Successfully installed mozsystemmonitor 16:48:20 INFO - Cleaning up... 16:48:20 INFO - Return code: 0 16:48:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:48:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:20 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 0x1e8f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f87a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x212cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212a290>, '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 0x212ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212b040>, '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': '781b77c4c33858b1f599d705000001c1-1490312862.66852-788313833', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:48:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:48:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:48:20 INFO - Using env: {'DISPLAY': ':0', 16:48:20 INFO - 'HOME': '/home/cltbld', 16:48:20 INFO - 'LANG': 'en_US.UTF-8', 16:48:20 INFO - 'LANGUAGE': 'en_US:en', 16:48:20 INFO - 'LOGNAME': 'cltbld', 16:48:20 INFO - 'MAIL': '/var/mail/cltbld', 16:48:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:20 INFO - 'MOZ_NO_REMOTE': '1', 16:48:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:20 INFO - 'NO_EM_RESTART': '1', 16:48:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:20 INFO - 'PWD': '/builds/slave/test', 16:48:20 INFO - 'SHELL': '/bin/bash', 16:48:20 INFO - 'SHLVL': '1', 16:48:20 INFO - 'TERM': 'linux', 16:48:20 INFO - 'TMOUT': '86400', 16:48:20 INFO - 'USER': 'cltbld', 16:48:20 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1490312862.66852-788313833', 16:48:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:20 INFO - '_': '/tools/buildbot/bin/python'} 16:48:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:21 INFO - Downloading/unpacking jsonschema==2.5.1 16:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:48:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:23 INFO - Downloading functools32-3.2.3-2.tar.gz 16:48:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:48:23 INFO - warning: no files found matching '*.txt' 16:48:23 INFO - no previously-included directories found matching 'build' 16:48:23 INFO - no previously-included directories found matching 'dist' 16:48:23 INFO - no previously-included directories found matching '.git*' 16:48:23 INFO - Installing collected packages: jsonschema, functools32 16:48:23 INFO - Running setup.py install for functools32 16:48:23 INFO - warning: no files found matching '*.txt' 16:48:23 INFO - no previously-included directories found matching 'build' 16:48:23 INFO - no previously-included directories found matching 'dist' 16:48:23 INFO - no previously-included directories found matching '.git*' 16:48:23 INFO - Successfully installed jsonschema functools32 16:48:23 INFO - Cleaning up... 16:48:23 INFO - Return code: 0 16:48:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:48:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:23 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 0x1e8f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f87a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x212cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212a290>, '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 0x212ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212b040>, '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': '781b77c4c33858b1f599d705000001c1-1490312862.66852-788313833', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:48:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:48:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:48:23 INFO - Using env: {'DISPLAY': ':0', 16:48:23 INFO - 'HOME': '/home/cltbld', 16:48:23 INFO - 'LANG': 'en_US.UTF-8', 16:48:23 INFO - 'LANGUAGE': 'en_US:en', 16:48:23 INFO - 'LOGNAME': 'cltbld', 16:48:23 INFO - 'MAIL': '/var/mail/cltbld', 16:48:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:23 INFO - 'MOZ_NO_REMOTE': '1', 16:48:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:23 INFO - 'NO_EM_RESTART': '1', 16:48:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:23 INFO - 'PWD': '/builds/slave/test', 16:48:23 INFO - 'SHELL': '/bin/bash', 16:48:23 INFO - 'SHLVL': '1', 16:48:23 INFO - 'TERM': 'linux', 16:48:23 INFO - 'TMOUT': '86400', 16:48:23 INFO - 'USER': 'cltbld', 16:48:23 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1490312862.66852-788313833', 16:48:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:23 INFO - '_': '/tools/buildbot/bin/python'} 16:48:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:48:23 INFO - Cleaning up... 16:48:23 INFO - Return code: 0 16:48:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:48:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:23 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 0x1e8f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f87a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x212cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212a290>, '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 0x212ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212b040>, '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': '781b77c4c33858b1f599d705000001c1-1490312862.66852-788313833', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:48:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:48:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:48:23 INFO - Using env: {'DISPLAY': ':0', 16:48:23 INFO - 'HOME': '/home/cltbld', 16:48:23 INFO - 'LANG': 'en_US.UTF-8', 16:48:23 INFO - 'LANGUAGE': 'en_US:en', 16:48:23 INFO - 'LOGNAME': 'cltbld', 16:48:23 INFO - 'MAIL': '/var/mail/cltbld', 16:48:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:23 INFO - 'MOZ_NO_REMOTE': '1', 16:48:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:23 INFO - 'NO_EM_RESTART': '1', 16:48:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:23 INFO - 'PWD': '/builds/slave/test', 16:48:23 INFO - 'SHELL': '/bin/bash', 16:48:23 INFO - 'SHLVL': '1', 16:48:23 INFO - 'TERM': 'linux', 16:48:23 INFO - 'TMOUT': '86400', 16:48:23 INFO - 'USER': 'cltbld', 16:48:23 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1490312862.66852-788313833', 16:48:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:23 INFO - '_': '/tools/buildbot/bin/python'} 16:48:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:23 INFO - Downloading/unpacking blobuploader==1.2.4 16:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:25 INFO - Downloading blobuploader-1.2.4.tar.gz 16:48:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:48:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:48:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:26 INFO - Downloading docopt-0.6.1.tar.gz 16:48:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:48:26 INFO - Installing collected packages: blobuploader, requests, docopt 16:48:26 INFO - Running setup.py install for blobuploader 16:48:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:48:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:48:26 INFO - Running setup.py install for requests 16:48:27 INFO - Running setup.py install for docopt 16:48:27 INFO - Successfully installed blobuploader requests docopt 16:48:27 INFO - Cleaning up... 16:48:27 INFO - Return code: 0 16:48:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:27 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 0x1e8f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f87a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x212cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212a290>, '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 0x212ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212b040>, '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': '781b77c4c33858b1f599d705000001c1-1490312862.66852-788313833', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:48:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:48:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:48:27 INFO - Using env: {'DISPLAY': ':0', 16:48:27 INFO - 'HOME': '/home/cltbld', 16:48:27 INFO - 'LANG': 'en_US.UTF-8', 16:48:27 INFO - 'LANGUAGE': 'en_US:en', 16:48:27 INFO - 'LOGNAME': 'cltbld', 16:48:27 INFO - 'MAIL': '/var/mail/cltbld', 16:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:27 INFO - 'MOZ_NO_REMOTE': '1', 16:48:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:27 INFO - 'NO_EM_RESTART': '1', 16:48:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:27 INFO - 'PWD': '/builds/slave/test', 16:48:27 INFO - 'SHELL': '/bin/bash', 16:48:27 INFO - 'SHLVL': '1', 16:48:27 INFO - 'TERM': 'linux', 16:48:27 INFO - 'TMOUT': '86400', 16:48:27 INFO - 'USER': 'cltbld', 16:48:27 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1490312862.66852-788313833', 16:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:27 INFO - '_': '/tools/buildbot/bin/python'} 16:48:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:48:27 INFO - Running setup.py (path:/tmp/pip-YVElS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:48:27 INFO - Running setup.py (path:/tmp/pip-OXTWTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:48:27 INFO - Running setup.py (path:/tmp/pip-qgb_k_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:48:27 INFO - Running setup.py (path:/tmp/pip-fN1aJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:48:27 INFO - Running setup.py (path:/tmp/pip-wIi9ZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:48:27 INFO - Running setup.py (path:/tmp/pip-Krr4eu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:48:28 INFO - Running setup.py (path:/tmp/pip-jNuAMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:48:28 INFO - Running setup.py (path:/tmp/pip-59Kl4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:48:28 INFO - Running setup.py (path:/tmp/pip-ToCoK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:48:28 INFO - Running setup.py (path:/tmp/pip-5vY72J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:48:28 INFO - Running setup.py (path:/tmp/pip-NDGcmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:48:28 INFO - Running setup.py (path:/tmp/pip-HtoLaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:48:28 INFO - Running setup.py (path:/tmp/pip-AiK6OV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:48:28 INFO - Running setup.py (path:/tmp/pip-c3Hk1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:48:28 INFO - Running setup.py (path:/tmp/pip-uy2o6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:48:28 INFO - Running setup.py (path:/tmp/pip-mMzl1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:48:28 INFO - Running setup.py (path:/tmp/pip-nwzpue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:48:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:48:28 INFO - Running setup.py install for manifestparser 16:48:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:48:28 INFO - Running setup.py install for mozcrash 16:48:29 INFO - Running setup.py install for mozdebug 16:48:29 INFO - Running setup.py install for mozdevice 16:48:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:48:29 INFO - Running setup.py install for mozfile 16:48:29 INFO - Running setup.py install for mozhttpd 16:48:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:48:29 INFO - Running setup.py install for mozinfo 16:48:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:48:29 INFO - Running setup.py install for mozInstall 16:48:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:48:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:48:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:48:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:48:29 INFO - Running setup.py install for mozleak 16:48:29 INFO - Running setup.py install for mozlog 16:48:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:48:29 INFO - Running setup.py install for moznetwork 16:48:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:48:29 INFO - Running setup.py install for mozprocess 16:48:30 INFO - Running setup.py install for mozprofile 16:48:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:48:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:48:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:48:30 INFO - Running setup.py install for mozrunner 16:48:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:48:30 INFO - Running setup.py install for mozscreenshot 16:48:30 INFO - Running setup.py install for moztest 16:48:30 INFO - Running setup.py install for mozversion 16:48:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:48:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:48:30 INFO - Cleaning up... 16:48:30 INFO - Return code: 0 16:48:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:48:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:30 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 0x1e8f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f87a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x212cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212a290>, '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 0x212ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212b040>, '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': '781b77c4c33858b1f599d705000001c1-1490312862.66852-788313833', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:48:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:48:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:48:30 INFO - Using env: {'DISPLAY': ':0', 16:48:30 INFO - 'HOME': '/home/cltbld', 16:48:30 INFO - 'LANG': 'en_US.UTF-8', 16:48:30 INFO - 'LANGUAGE': 'en_US:en', 16:48:30 INFO - 'LOGNAME': 'cltbld', 16:48:30 INFO - 'MAIL': '/var/mail/cltbld', 16:48:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:30 INFO - 'MOZ_NO_REMOTE': '1', 16:48:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:30 INFO - 'NO_EM_RESTART': '1', 16:48:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:30 INFO - 'PWD': '/builds/slave/test', 16:48:30 INFO - 'SHELL': '/bin/bash', 16:48:30 INFO - 'SHLVL': '1', 16:48:30 INFO - 'TERM': 'linux', 16:48:30 INFO - 'TMOUT': '86400', 16:48:30 INFO - 'USER': 'cltbld', 16:48:30 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1490312862.66852-788313833', 16:48:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:30 INFO - '_': '/tools/buildbot/bin/python'} 16:48:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:48:30 INFO - Running setup.py (path:/tmp/pip-mZM1f1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:48:30 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:48:30 INFO - Running setup.py (path:/tmp/pip-OJILvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:48:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:48:31 INFO - Running setup.py (path:/tmp/pip-YUzZWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:48:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:48:31 INFO - Running setup.py (path:/tmp/pip-IVdQ2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:48:31 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)) 16:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:48:31 INFO - Running setup.py (path:/tmp/pip-DrT9qt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:48:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:48:31 INFO - Running setup.py (path:/tmp/pip-K_svG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:48:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:48:31 INFO - Running setup.py (path:/tmp/pip-AID6U0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:48:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:48:31 INFO - Running setup.py (path:/tmp/pip-SYPDZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:48:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:48:31 INFO - Running setup.py (path:/tmp/pip-_PC700-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:48:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:48:31 INFO - Running setup.py (path:/tmp/pip-tqhBmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:48:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:48:31 INFO - Running setup.py (path:/tmp/pip-h5Oj6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:48:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:48:31 INFO - Running setup.py (path:/tmp/pip-YUFxqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:48:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:48:31 INFO - Running setup.py (path:/tmp/pip-Km9e7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:48:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:48:31 INFO - Running setup.py (path:/tmp/pip-fQoAmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:48:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:48:31 INFO - Running setup.py (path:/tmp/pip-vAQuYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:48:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:48:31 INFO - Running setup.py (path:/tmp/pip-WIvilc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:48:32 INFO - Running setup.py (path:/tmp/pip-zWou4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:48:32 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)) 16:48:32 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)) 16:48:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:34 INFO - Downloading blessings-1.6.tar.gz 16:48:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:48:34 INFO - Installing collected packages: blessings 16:48:34 INFO - Running setup.py install for blessings 16:48:34 INFO - Successfully installed blessings 16:48:34 INFO - Cleaning up... 16:48:34 INFO - Return code: 0 16:48:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:48:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:48:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:48:34 INFO - Reading from file tmpfile_stdout 16:48:34 INFO - Current package versions: 16:48:34 INFO - argparse == 1.2.1 16:48:34 INFO - blessings == 1.6 16:48:34 INFO - blobuploader == 1.2.4 16:48:34 INFO - docopt == 0.6.1 16:48:34 INFO - functools32 == 3.2.3-2 16:48:34 INFO - jsonschema == 2.5.1 16:48:34 INFO - manifestparser == 1.1 16:48:34 INFO - mozInstall == 1.12 16:48:34 INFO - mozcrash == 1.0 16:48:34 INFO - mozdebug == 0.1 16:48:34 INFO - mozdevice == 0.49 16:48:34 INFO - mozfile == 1.2 16:48:34 INFO - mozhttpd == 0.7 16:48:34 INFO - mozinfo == 0.9 16:48:34 INFO - mozleak == 0.1 16:48:34 INFO - mozlog == 3.4 16:48:34 INFO - moznetwork == 0.27 16:48:34 INFO - mozprocess == 0.25 16:48:34 INFO - mozprofile == 0.28 16:48:34 INFO - mozrunner == 6.13 16:48:34 INFO - mozscreenshot == 0.1 16:48:34 INFO - mozsystemmonitor == 0.3 16:48:34 INFO - moztest == 0.8 16:48:34 INFO - mozversion == 1.4 16:48:34 INFO - psutil == 3.1.1 16:48:34 INFO - requests == 1.2.3 16:48:34 INFO - wsgiref == 0.1.2 16:48:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:34 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 0x1e8f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f87a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x212cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212a290>, '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 0x212ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212b040>, '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': '781b77c4c33858b1f599d705000001c1-1490312862.66852-788313833', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:48:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:48:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:48:34 INFO - Using env: {'DISPLAY': ':0', 16:48:34 INFO - 'HOME': '/home/cltbld', 16:48:34 INFO - 'LANG': 'en_US.UTF-8', 16:48:34 INFO - 'LANGUAGE': 'en_US:en', 16:48:34 INFO - 'LOGNAME': 'cltbld', 16:48:34 INFO - 'MAIL': '/var/mail/cltbld', 16:48:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:34 INFO - 'MOZ_NO_REMOTE': '1', 16:48:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:34 INFO - 'NO_EM_RESTART': '1', 16:48:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:34 INFO - 'PWD': '/builds/slave/test', 16:48:34 INFO - 'SHELL': '/bin/bash', 16:48:34 INFO - 'SHLVL': '1', 16:48:34 INFO - 'TERM': 'linux', 16:48:34 INFO - 'TMOUT': '86400', 16:48:34 INFO - 'USER': 'cltbld', 16:48:34 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1490312862.66852-788313833', 16:48:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:34 INFO - '_': '/tools/buildbot/bin/python'} 16:48:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:48:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:48:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:48:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:48:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:48:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:48:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:48:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:48:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:48:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:48:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:48:34 INFO - Cleaning up... 16:48:34 INFO - Return code: 0 16:48:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:34 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 0x1e8f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f87a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x212cb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212a290>, '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 0x212ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212b040>, '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': '781b77c4c33858b1f599d705000001c1-1490312862.66852-788313833', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:48:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:48:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:48:34 INFO - Using env: {'DISPLAY': ':0', 16:48:34 INFO - 'HOME': '/home/cltbld', 16:48:34 INFO - 'LANG': 'en_US.UTF-8', 16:48:34 INFO - 'LANGUAGE': 'en_US:en', 16:48:34 INFO - 'LOGNAME': 'cltbld', 16:48:34 INFO - 'MAIL': '/var/mail/cltbld', 16:48:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:34 INFO - 'MOZ_NO_REMOTE': '1', 16:48:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:34 INFO - 'NO_EM_RESTART': '1', 16:48:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:34 INFO - 'PWD': '/builds/slave/test', 16:48:34 INFO - 'SHELL': '/bin/bash', 16:48:34 INFO - 'SHLVL': '1', 16:48:34 INFO - 'TERM': 'linux', 16:48:34 INFO - 'TMOUT': '86400', 16:48:34 INFO - 'USER': 'cltbld', 16:48:34 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1490312862.66852-788313833', 16:48:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:34 INFO - '_': '/tools/buildbot/bin/python'} 16:48:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:48:35 INFO - Cleaning up... 16:48:35 INFO - Return code: 0 16:48:35 INFO - Running post-action listener: _resource_record_post_action 16:48:35 INFO - Running post-action listener: _start_resource_monitoring 16:48:35 INFO - Starting resource monitoring. 16:48:35 INFO - [mozharness: 2017-03-23 23:48:35.082659Z] Finished create-virtualenv step (success) 16:48:35 INFO - [mozharness: 2017-03-23 23:48:35.083161Z] Running install step. 16:48:35 INFO - Running pre-action listener: _resource_record_pre_action 16:48:35 INFO - Running main action method: install 16:48:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:48:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:48:35 INFO - Reading from file tmpfile_stdout 16:48:35 INFO - Detecting whether we're running mozinstall >=1.0... 16:48:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:48:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:48:35 INFO - Reading from file tmpfile_stdout 16:48:35 INFO - Output received: 16:48:35 INFO - Usage: mozinstall [options] installer 16:48:35 INFO - Options: 16:48:35 INFO - -h, --help show this help message and exit 16:48:35 INFO - -d DEST, --destination=DEST 16:48:35 INFO - Directory to install application into. [default: 16:48:35 INFO - "/builds/slave/test"] 16:48:35 INFO - --app=APP Application being installed. [default: firefox] 16:48:35 INFO - mkdir: /builds/slave/test/build/application 16:48:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:48:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:48:51 INFO - Reading from file tmpfile_stdout 16:48:51 INFO - Output received: 16:48:51 INFO - /builds/slave/test/build/application/firefox/firefox 16:48:51 INFO - Running post-action listener: _resource_record_post_action 16:48:51 INFO - [mozharness: 2017-03-23 23:48:51.019392Z] Finished install step (success) 16:48:51 INFO - [mozharness: 2017-03-23 23:48:51.019662Z] Running run-tests step. 16:48:51 INFO - Running pre-action listener: _resource_record_pre_action 16:48:51 INFO - Running main action method: run_tests 16:48:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:48:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:48:51 INFO - Python 2.7.3 16:48:51 INFO - Return code: 0 16:48:51 INFO - grabbing minidump binary from tooltool 16:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:51 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 0x212a290>, '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 0x212ab90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212b040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:48:51 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:48:51 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:48:51 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:48:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:48:51 INFO - Return code: 0 16:48:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:48:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:48:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:48:51 INFO - ENV: RUST_BACKTRACE is now 1 16:48:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:48:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:48:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-080', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:48:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-080 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:48:51 INFO - Using env: {'DISPLAY': ':0', 16:48:51 INFO - 'HOME': '/home/cltbld', 16:48:51 INFO - 'LANG': 'en_US.UTF-8', 16:48:51 INFO - 'LANGUAGE': 'en_US:en', 16:48:51 INFO - 'LOGNAME': 'cltbld', 16:48:51 INFO - 'MAIL': '/var/mail/cltbld', 16:48:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:48:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:48:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:51 INFO - 'MOZ_NO_REMOTE': '1', 16:48:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:48:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:51 INFO - 'NO_EM_RESTART': '1', 16:48:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:48:51 INFO - 'PWD': '/builds/slave/test', 16:48:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:48:51 INFO - 'RUST_BACKTRACE': '1', 16:48:51 INFO - 'SHELL': '/bin/bash', 16:48:51 INFO - 'SHLVL': '1', 16:48:51 INFO - 'TERM': 'linux', 16:48:51 INFO - 'TMOUT': '86400', 16:48:51 INFO - 'USER': 'cltbld', 16:48:51 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1490312862.66852-788313833', 16:48:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:51 INFO - '_': '/tools/buildbot/bin/python'} 16:48:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-080', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:48:51 INFO - mozversion application_buildid: 20170323231546 16:48:51 INFO - mozversion application_changeset: 01d1dedf400d4be413b1a0d48090dca7acf29637 16:48:51 INFO - mozversion application_display_name: Nightly 16:48:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:48:51 INFO - mozversion application_name: Firefox 16:48:51 INFO - mozversion application_remotingname: firefox 16:48:51 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:48:51 INFO - mozversion application_vendor: Mozilla 16:48:51 INFO - mozversion application_version: 55.0a1 16:48:51 INFO - mozversion platform_buildid: 20170323231546 16:48:51 INFO - mozversion platform_changeset: 01d1dedf400d4be413b1a0d48090dca7acf29637 16:48:51 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:48:51 INFO - mozversion platform_version: 55.0a1 16:48:51 INFO - using testdate: 1490312931 16:48:51 INFO - actual date: 1490312931 16:48:51 INFO - starting webserver on 'localhost:49667' 16:48:51 INFO - SUITE-START | Running 2 tests 16:48:51 INFO - TEST-START | dromaeo_css 16:48:51 INFO - operating with platform_type : linux_ 16:48:51 INFO - Initialising browser for dromaeo_css test... 16:48:51 INFO - TEST-INFO | started process 17316 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_ukuEk/profile http://localhost:49667/getInfo.html) 16:48:56 INFO - PID 17316 | __metrics Screen width/height:1600/1200 16:48:56 INFO - PID 17316 | colorDepth:24 16:48:56 INFO - PID 17316 | Browser inner width/height: 1024/697 16:48:56 INFO - PID 17316 | __metrics 16:48:57 ERROR - PID 17316 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3392: TypeError: this.tabs is undefined 16:48:58 INFO - TEST-INFO | 17316: exit 0 16:48:58 INFO - Browser initialized. 16:48:58 INFO - Running cycle 1/1 for dromaeo_css test... 16:48:58 INFO - TEST-INFO | started process 17448 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_ukuEk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:49:10 INFO - PID 17448 | RSS: Main: 155496448 16:49:10 INFO - PID 17448 | 16:52:15 INFO - PID 17448 | Cycle 1(1): loaded http://localhost:49667/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49667/tests/dromaeo/cssquery-ext.html) 16:52:16 INFO - PID 17448 | RSS: Main: 165675008 16:52:16 INFO - PID 17448 | 16:53:58 INFO - PID 17448 | ************************* 16:53:58 INFO - PID 17448 | A coding exception was thrown and uncaught in a Task. 16:53:58 INFO - PID 17448 | 16:53:58 ERROR - PID 17448 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:53:58 INFO - PID 17448 | Full stack: 16:53:58 INFO - PID 17448 | ************************* 16:55:19 INFO - PID 17448 | Cycle 1(1): loaded http://localhost:49667/tests/dromaeo/cssquery-ext.html (next: http://localhost:49667/tests/dromaeo/cssquery-jquery.html) 16:55:19 INFO - PID 17448 | RSS: Main: 161095680 16:55:19 INFO - PID 17448 | 16:58:21 INFO - PID 17448 | Cycle 1(1): loaded http://localhost:49667/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49667/tests/dromaeo/cssquery-mootools.html) 16:58:22 INFO - PID 17448 | RSS: Main: 169140224 16:58:22 INFO - PID 17448 | 17:01:24 INFO - PID 17448 | Cycle 1(1): loaded http://localhost:49667/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49667/tests/dromaeo/cssquery-prototype.html) 17:01:25 INFO - PID 17448 | RSS: Main: 161206272 17:01:25 INFO - PID 17448 | 17:04:27 INFO - PID 17448 | Cycle 1(1): loaded http://localhost:49667/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49667/tests/dromaeo/cssquery-yui.html) 17:04:28 INFO - PID 17448 | RSS: Main: 168378368 17:04:28 INFO - PID 17448 | 17:07:31 INFO - PID 17448 | Cycle 1(1): loaded http://localhost:49667/tests/dromaeo/cssquery-yui.html (next: http://localhost:49667/tests/dromaeo/cssquery-dojo.html) 17:07:31 INFO - PID 17448 | RSS: Main: 163184640 17:07:31 INFO - PID 17448 | 17:07:31 INFO - PID 17448 | __start_tp_report 17:07:31 INFO - PID 17448 | _x_x_mozilla_page_load 17:07:31 INFO - PID 17448 | _x_x_mozilla_page_load_details 17:07:31 INFO - PID 17448 | |i|pagename|runs| 17:07:31 INFO - PID 17448 | |0;dojo.html;2691.340621547721;2705.6617922759656;2721.4693134838703;2736.0423851651913;2747.6840163381216;5073.822416215433;5119.334486516752;5135.075686376451;5166.380034395868;5192.896142077157;5101.54086132248;5174.611904107188;5244.763985620647;5247.055530004598;5297.390800057994;4783.999999999991;4799.784009719571;4801.975990120044;4833.903321933559;4851.151048566504;4835.226363781796;4837.274408838684;4892.192788189945;4892.779824907888;4936.062148191832;4667.4632417272105;4697.365855609483;4770;4797.7601119943865;4798.928016079762;4789.473157952622;4793.880152996203;4811.446683631392;4836.419629644465;4863.319135321058;4686.015936653307;4752.07334569759;4762.499937506546;4771.260454629538;4807;5003.74981250936;5045.344105266328;5193.766280517348;5201.271821944931;5268.868278293035;5577.944220557783;5601.29983752031;5640.774369025234;5654.406287339812;5656.8020119295625;5650.886982260332;5676.858078548028;5682.573806964494;5697.6296540724725;5700.9429905701245;5050.4697006814495;5263.605229607795;5271.762770675252;5279.524842764131;5345.064613692588;5576.749046292845;5639.887202255932;5652.095664693629;5656;5660.235868157828;5436.374816896028;5445.1015582429245;5528.640638358494;5553.833384998376;5560.138178582326;5624.353199382042;5626.774929002794;5638.915416268759;5639.774409023676;5665.6034077614995;5601.159826026129;5601.551875849922;5607.551395888319;5615.606907516516;5619.887602247933;5400.054990376669;5456.508914197741;5521.4478552145265;5601.663900166003;5603.663780173202;4649.093426781813;4650.069986002813;4652.046330502239;4699.624030077585;4716.151092803259;4025.77858217795;4041.818118184689;4044.8179831907637;4051.0480037191824;4084.1423301106506;4706.388169537938;4738.95261047392;4780.569748722632;4793.760311984387;4905.117078925828;5648.971755141198;5679.716014199274;5682.488576028178;5699.487046165782;5708.115242137475;4811.615070794328;4830.492798256203;4845.3216549683075;4848.296996935424;4892.241702536113;4865.051314993542;4907.944791869765;4993.700377977333;5017.422996355466;5023.271625614266;5225.294585231097;5250.65870718402;5255.89488210226;5273.8681532960445;5295.867603309948;5573.219749235192;5590.189422533791;5594.356648985418;5596.720163991866;5601.943980560142;5093.8726531837;5138.434772174983;5140.511651393112;5140.588752899834;5142.948570514247;5353.116735738559;5446.863828404322;5449.073657478159;5452.591055670761;5458.9454105458435;5540.22436858832;5544.251526043932;5549.639273447375;5550.38945715979;5553.444655534414;5362.490563396471;5375.3280839895015;5375.489328513785;5459.645123067146;5464.207689885024;5233.842984710464;5259.526642602184;5444.183372493999;5480.862978425412;5500.7524661391135;5353.223782551586;5356.276902618097;5387.730613469389;5429.53848922846;5440.510354068153;5491.835244942658;5519.3652729936575;5523.061079616556;5523.447655234605;5529.474699903502;5213.60897932649;5253.106971814877;5393.649412788156;5411.540019098264;5412.052890744026 17:07:31 INFO - PID 17448 | |1;ext.html;632.1907957814;678.9083473731046;696.5924933913661;1198.2870192235616;1202.2065436811706;33483.66516334839;34421.655783442155;34430.65569344303;34515.893569578766;34530.48204276932;34123.65876341236;34449;34562.65437345626;34639.480407793904;34663.65336346636;6932.7920162395085;7022.719091236345;7300.868365403371;7527.548347099191;7553.24467553243;7615.428842836782;7743.380529557622;7747.264009919077;7769.339606133457;7776.222377762235;7654.234576542329;7739.3421559167255;7755.340796032344;7764.805879853021;7773.144954055049;7680.692772289101;7681.50070245435;7714.187166015981;7723.613819309068;7747.845043099134;7481.7755467336065;7521.285477879593;7589.354904833096;7592.354649854769;7594.050743657043;34840.65159348425;35061.12347191341;35157;35195.64804351975;35205.29589408197;2684.8254863433813;2729.9181024569293;2730.8224965377385;2736.7536921677147;2777.3334399744117;23849.284521464382;23974.160904368437;24153.41002506018;24590.155738319518;25187.118450854316;2883.740463358287;2898.087102562686;2951.0556621881005;2951.2031751426994;2953.1731115287753;121084;122012;159777;160261;161197.19401402917;38214;38680;38805;38824.6117538821;38906.41640375397;39659.20681586352;39791.40312895309;42779.35830962538;42809.143817123484;42909;11683.18217724751;11723.648290551297;11753.118516111326;11801.055915526736;11819.586314478953;9164.129407706258;9222.031686672937;9235.907640923639;9237.399569027992;9271.072892710676;13186;13198.736025279633;13213.14114582549;13281.601551953458;13373.53192638253;5549.5837812164245;5581.553475721932;5603.299587551556;5681.403452637496;5707.486326230659;869.913008699125;889.1686273334453;893.1515060692368;910.8269428808505;932.8227636748996;20564.897175514026;21339.35981920545;21558.13767449316;21592.460188495414;21636.4590885226;962.5091203486272;967.8596603492595;978.8335982882927;998.8951160128082;1008.2387797213057;10788.892111078945;11248.325100493832;11273.379964101889;11289.0968722502;13499.932500337633;199575;200428;201599;202179;202707;46766;47061.29408058882;47149.528504714515;47194.29208561874;47314.763426182646;1233.444949772606;1242.683115805482;1259.0871618076822;1261.3188878005958;1265.13970500059;24166.87916560406;24424.26727198187;25502.489950201263;25517.2344829648;25566.744332556435;30559.388812224075;30730.231744206572;30777.846110769304;30805.69194308028;31002.224944376572;242968;242976;243397;243558;243828.02773875574;27656.170314890587;28591.42817143687;28949.276268093465;29019.7098029017;29042.854785725936;35797.64202357943;35887;36258.27483450369;36492.270154596226;37152.81423592973;27532.761025753487;27566.5865012021;27656;28256.43487130287;28330;27642.585361219197;27800.443991120468;28165.71834281713;28330.43339133247;28578.71421285844;30595.2351191222;30974.380512389176;31044.534331984585;31453.8427307862;31533.8423307882;27171.64141792942;27221.863890681212;27618.72381276242;28034.439311214068;28099;21779.673304900756;22372;22469.77530224677;22901;22936 17:07:31 INFO - PID 17448 | |2;jquery.html;414.4632700652655;426.2115087088886;426.50012852124416;434.8586709319471;445.5499945055495;17037.977721336727;17198;17470.737938930924;17826.19782109805;17870;18339.90830045851;18813.623727525443;19414.44684425246;19587.118579663915;19613.31353402631;5792.536597072224;5793.33376661684;5918.970405147989;5926.703664816763;5939.524838012949;5740.368559458456;5871.031279838843;5876.0598304271325;5893.764249430018;5907.616004959686;5544.667319960815;5728.198052272685;5729.627574207663;5759.308882934054;5775.682337471438;5622.465865742748;5724.5992780505385;5749.770009199627;5755.309362876461;5793.073108302693;5268.710220937847;5283.947160528384;5302.946970530323;5306.7611957462;5307.150855863082;22857.199998000156;23147.652785208236;23213.53572928532;23299.534009319887;23421.88289058561;1610.3397606981198;1614.1203044340862;1625.19552821353;1631.0140544828027;1669.2154687297073;13796.172229666152;13804;14204.573862784133;14333.498327558485;14818.777718334233;1676.3378465506057;1685.9495907043963;1690.3407671008317;1711.8031426385876;1725.094325479121;81174;82175.589122054;82666.17333826705;82931.17068829294;84023.15976840275;11177.552897884156;11496.195266331277;11586.188966772414;11605.477753501113;11636.88363116358;15863.286152122952;15900.681986360209;15958.76061859073;15975.08299004127;15988.120653364176;7248.891266631004;7368.336849683555;7464.776056718307;7630;7668.156502784689;6742.932570674328;6763.2898545652;6881.65591720412;6931.133608298963;6954.3393377629045;7129.500934934608;7139.857202855914;7140.500164988505;7146.535475194096;7218.927810721825;2089.9268525601533;2116.4285642876644;2129.7763734807622;2136.5833662435675;2239.6080685879906;826.1696994520588;841.3227351981591;850.6342272822745;853.4538990494506;876.7150676030316;16763.748543771853;17900.820991790177;17953.281868725106;18059.367922122925;18130.09349532518;880.7886107334193;885.4333226734894;892.5983307511646;895.3374502867831;900.0468982308275;9087.681931132378;9796.804063918682;9855.497967784182;9893.851592226123;10019;401670;402241;405099;433850;437349;89484;89968.5501572488;90736;91086.54456727806;92043.53978230066;1016.6594190946116;1027.8355463125863;1055.7730088030958;1058.5342449322427;1061.2889364126054;14932.178730169944;16107.919460402623;17863;17938.282468701105;18200.90899545547;38389.80805096068;40082.59917400789;43621.781891090344;45176.54823451855;45375.319370210134;50449.747751261006;51297.38323550898;53314.73342633417;56021.71989140191;56038.439615603325;10639.840402393815;11603.6518904433;11833.940830295793;12439.937800310941;12730.936345318214;12769.808452873029;12830.55093071738;12925.224486530462;12943.482260709467;12949.417276222404;11456.427178640868;11642.147673819629;11695.532178712756;11946.522139114339;12203.389830508617;10146.949265253626;10160.491975401348;10212.795744085226;10272.948635256776;10386.636467723594;11015.669529914116;11389;11419.657410277705;11463.885361146282;11663.358515281741;11743.47154378072;11746.17776755619;11752.471138798946;11956.58151964677;12218.755624887275;11510.194286399872;11526.481308340977;11565.942170289094;11710.180287379802;12045.759084818079 17:07:31 INFO - PID 17448 | |3;mootools.html;1230.3110258255376;1254.7866862633352;1255.3095797311476;1268.156675810586;1287.2598256002798;9496.145346918776;9950.800983980334;10154.543045562948;10162.59349626014;10238.590456381746;9914.603415863357;10014.248931330161;10041;10106.44414557201;10120.69637910862;2210.7126073610407;2263.5359751251035;2264.52444986553;2274.55646149001;2282.2354511238755;2173.304542546378;2220.4892874638845;2223.044091040852;2240.2383189715492;2241.551689662066;2198.736151661795;2230.520438105807;2245.079517397867;2245.932622021342;2279.076973825595;2113.7991890770354;2191.791779780918;2195.7584665686763;2197.692323074763;2198.999999999992;1840.1075478392968;1912.4645099372199;2164.3290579920276;2169.370882444089;2172.2071443923014;9982.700518984442;10234.488275586265;10245.385276883411;10258.948705256425;10260.538275777533;5485.533729632986;5682.403347648478;5682.687452190128;5682.715864206773;5698.487136157766;3388.2884594234993;3459.4637831136215;3496.7552271341015;3502.176988407722;3510.1926556891804;1115.6151127860876;1124.662601219639;1139.7207684117361;1166.3410173252084;1194.8566172059323;14326.49857254991;14358.138511689333;14418.206998614967;14513.346899389553;14556.490522831757;4585.197590421662;4624.838130665411;4766.142094422968;4770.713757174581;4907.312976183337;10804.297720648132;10848.240623156304;10940.617078402218;10946.288491248044;10969.50637221311;5506.311711036121;5518.255035570227;5537.695426751487;5541;5564.27664403633;4730.95269047312;4786.2581299898575;4845.75771211438;4863.683860549124;5003;3836.7889766063136;3863.130795570974;3870.41943708446;3941.586133456003;3950.0322421007036;1122.8989390954853;1123.101518784985;1127.3799410324452;1138.3056335635256;1142.994285028586;677.3023785500942;693.2546717717217;705.8658854817671;714.1537278325201;724.7608289264635;5437.646552974044;5500.50495455411;5516.88296112695;5518.751656175482;5693.373728889819;552.8009916430082;562.2437821130573;564.1875698993437;568.9971550142305;574.2075935209384;3319.751018673609;3395.219099607104;3407.5910890693276;3432.502287168347;3441.6730410610953;12279.447424865724;13166.078374513883;13176.736465270833;13191.208527488381;13260.668483287802;12884.226946383247;12897.203725703532;13049.934750326378;13143.60569182926;13161.078724489385;8928.285737141014;9076.27389808827;9092.090790920987;9351.812963740687;9482.478463684425;5939.376365481562;6113.1135985281;6178.783742568989;6327.462165715781;6346.555741098079;11031.448427578429;11719.589814356457;11728.472218750007;11834.644960651194;11894.702632434259;11256.831147532957;11272.887271127183;11292.548298067984;11433.942830285796;11447.25592836463;7888.092869319872;8060.596970151586;8074.677012919652;8162.224588664068;8167.305779008851;8828.24959878392;9329.393589416666;9438.433693978383;9439.339246252697;9441.905580944378;7648.426368022309;7866.960665196638;7918.168592297726;7938.285554300141;8063.596820159086;7592.962035189788;7614.581198034161;7629.0845098588525;7736.883946740691;7826.843463130592;7409.66656500448;7413.629318533944;7431.182569917413;7485.625718714152;7518.473706840688;5296.321695140913;5381.139017757297;5439;5495.340559132929;5602.943970560243;4965.751712414292;4971.726555039508;5053.343065401475;5061.569766569883;5295.7087360195555 17:07:31 INFO - PID 17448 | |4;prototype.html;396.8055652730162;399.1139669932749;399.4108689682718;399.60638770810766;404.9959500404995;5546.694931778756;5619.971900140494;5637.408072152426;5637.548996080314;5638.605297629162;5325.547328477074;5330.973345133279;5486.1222204447295;5504.972475137629;5505.587080968923;4415.470143582758;4417.845375411861;4421.197769917868;4428.424304840374;4434.046679963807;4433.135538569964;4437.600615944564;4440.933385999213;4458.754768487732;4465.9106817863785;4275.657947364203;4373.234683930315;4413.801378937956;4416.779161041951;4421.88945276369;4391.758453285068;4394.4946331172005;4396.2746146885565;4405.911881762363;4422.115576884636;3948.861789837342;3967.1867267210155;3974.225026119908;3990.7805070721097;4013.7591744495426;5141.53726164647;5408.567314614861;5458.4814442627885;5488.396276409591;5495.340559132889;4930.531599498042;4941.234108713119;4941.332920055783;4942.110420124376;4943.3573635427165;5807.157962095514;5870;5904.2029326040865;5914.556408269354;5916.497097746696;3914.862979795722;4070.5929407059352;4081.102287436356;4098.344264917599;4112.403701463271;5844.6785426801935;6094.603850749687;6130.570860039799;6183.505319574423;6196.752129914798;4105.495647654928;4203.222403855236;4212.178625168124;4213.789310534522;4215.093754842724;4184.121334519724;4234.174336004449;4238.449001629769;4238.618524332825;4277.315629499328;4868.683535570177;4875.683080599821;4877.512248775094;4914.680545764514;4919.237518184687;5835.928245472881;5867.921794352969;5891.469767720926;5897.287247865944;5938.970305148447;1601.879859010579;1616.1676736480722;1623.0586259969425;1627.4548026411048;1632.4612877750315;1086.3319058778952;1141.6746227325173;1147.208426185929;1153.2734377342222;1162.5001249462644;5085.74571271435;5122.462141475092;5131.640785145079;5139.560922941582;5145.871353216199;6113.816585502442;6119.785807496716;6133.723982420802;6146.293176284695;6159.23009623797;4962.181240095344;5104.285400043997;5108.463611320758;5111.284420181178;5120.231965205175;3212.1969507623094;3230.9676903230666;3255.316383559432;3258.7393008559256;3260.755443341759;5355.437679043722;5637.392069075795;5658.434156584391;5676.091825307931;5682.40334764852;6171.444569988723;6208.782692605737;6237.09562113491;6247.375262473807;6250.937490625127;5625.803096891589;5657.547396208293;5672.092465205547;5680.971595141998;5693.8861222774485;5932.9703351484695;6034.517238620812;6076.33160352352;6081.695915204311;6113.29697084841;6008.759649613967;6019.398060194121;6020.668863212565;6024.8795024100145;6038.426349496791;5349;5466.5900057495055;5537.944620553743;5630.774769009357;5645.745941432563;4164.583541645811;4189.72766770159;4206.221848957953;4211.263028969979;4213;5910.172575839472;6065.363136870565;6076.605020673819;6079;6111.358307377662;5799.449052340021;5832.3292821326095;5847.707614619337;5865.768188680254;5901;5813.09896965971;5830.271216097988;5838.781263119988;5843.152742852348;5868.178455016387;5567.66594004361;5706.4864162225595;5735.97132014354;5750.654960702372;5787.9421205789085;5879;5888.381719919346;5890.793822216202;5905.498032667099;5926.666500037457;5603.523700485504;5741.712914354349;5745.6552606843725;5746.339170995389;5758.712064396847 17:07:31 INFO - PID 17448 | |5;yui.html;679.5922446532085;682.3756263019337;686.3822559696273;707.8548897476014;726.5604309392819;11807.881921180786;12113.454894529756;12286.631401057972;12290.631281061582;12918.031147663916;12419.379031048435;12630.115891887572;12630.30533320667;12654.05094617905;12670.556530521433;816.7549735079467;833.4332653795417;835.4945258118811;836.3894357119307;837.8366218587378;805.9314958228529;834.5743670727942;841.6927821345196;841.7727213652311;842.3135144856952;904.1410659873114;906.8005038891466;906.9183773460387;910.968116115936;912.6486302773413;898.6764764684708;900.6892622045384;903.6791938861708;906.7415786500816;907.188066680324;666.3802663522922;668.6322522612544;668.729164688302;669.1468377818272;669.7220653428822;13260.13809102415;13513;13554.390052447565;13564.864351356458;13570.728585428236;13569.728605427936;14250.501232456814;14340.426382944774;14349.641258968504;14452.286589931231;9531.904680953172;9613;9797.853032204523;9904.653337133166;10112.94943525285;2506.6240063990367;2513.8868750906254;2531.316544532984;2566.3712390464457;2629.474105178953;64899;65785;66244.3375566243;67142;67610.32389676089;10797.784044319069;10895.782084358269;10975.615853445091;11039.503222355013;11043.613473528549;21999.450013749465;22023.33929982103;22182.667259991114;22212.222572209896;22526.324210273717;5953.613015154001;5996.820095397145;6022.39776022403;6024.397560244028;6229.221347331583;2867.168521128891;2893.8263704177816;2927.9707202928125;2959.319356548006;3002.309468822183;3392.490341797926;3476.791392516457;3503.702185314277;3505.053635518396;3528.929421411609;615.8922188617064;620.2804746494045;623.9688015599202;635.0569404434411;641.6567136581906;524.8346770767196;541.3828235811178;542.3004324421452;553.7563472072276;575.3900865083025;7717.1896950819355;7930.365570754326;8076.475029123206;8215.630296636666;8356.331493480508;487.06969687895946;493.1148588284039;497.0952865784238;499.8175665881927;504.84349851546136;3611.8735844245325;3690.9630903691154;3706.258748250361;3758.3047136279874;3763.2661630981697;62962.68518657469;63662.36337636657;64410;64447.67776161089;66995.3300466989;43466.34800477995;44474.77762611166;46115;49272.01455970861;55421.445785541626;38347;41443;44647.77676111599;46009;47027.529724702996;8678.522681252593;9212.677556285498;9240.768980775265;9244.214241789523;9254.213391861767;24437;24858.627120593566;25147.74852251454;25168.24495265145;25899.741002589733;30295.242618934702;30920.845395772878;31260.687393125776;31533.369332613678;31891.521627176076;10773;10898.50956706966;11161.218714689894;11221.382823944761;11338.634625669012;11711.472983715923;11900.821487677866;12082.939585302018;12094.395280235776;12665.493380264686;11062.778744425228;11306.717332066764;11416.133264421791;11566.768664626828;11859.856998962998;10441.947790261;10482.895171048192;11619.593314233962;11620.070394368262;11622.6513204604;10465.267431279737;11008.174386921173;11345.489452974802;11627.360495172847;11662.183647144619;8387;8545.529995850287;8676.652933882575;8694.521801300989;8706.869396958924;8384;8956.492182188998;9095;9320.580573874056;9410.858837117587 17:07:31 INFO - PID 17448 | __end_tp_report 17:07:31 INFO - PID 17448 | __start_cc_report 17:07:31 INFO - PID 17448 | _x_x_mozilla_cycle_collect,384 17:07:31 INFO - PID 17448 | __end_cc_report 17:07:31 INFO - PID 17448 | __startTimestamp1490314051820__endTimestamp 17:07:31 INFO - PID 17448 | 17:07:31 INFO - PID 17448 | ------- Summary: start ------- 17:07:31 INFO - PID 17448 | Number of tests: 6 17:07:31 INFO - PID 17448 | 17:07:31 INFO - PID 17448 | [#0] dojo.html Cycles:165 Average:5141.96 Median:5268.87 stddev:575.08 (10.9%) stddev-sans-first:543.77 17:07:31 INFO - PID 17448 | Values: 2691.3 2705.7 2721.5 2736.0 2747.7 5073.8 5119.3 5135.1 5166.4 5192.9 5101.5 5174.6 5244.8 5247.1 5297.4 4784.0 4799.8 4802.0 4833.9 4851.2 4835.2 4837.3 4892.2 4892.8 4936.1 4667.5 4697.4 4770.0 4797.8 4798.9 4789.5 4793.9 4811.4 4836.4 4863.3 4686.0 4752.1 4762.5 4771.3 4807.0 5003.7 5045.3 5193.8 5201.3 5268.9 5577.9 5601.3 5640.8 5654.4 5656.8 5650.9 5676.9 5682.6 5697.6 5700.9 5050.5 5263.6 5271.8 5279.5 5345.1 5576.7 5639.9 5652.1 5656.0 5660.2 5436.4 5445.1 5528.6 5553.8 5560.1 5624.4 5626.8 5638.9 5639.8 5665.6 5601.2 5601.6 5607.6 5615.6 5619.9 5400.1 5456.5 5521.4 5601.7 5603.7 4649.1 4650.1 4652.0 4699.6 4716.2 4025.8 4041.8 4044.8 4051.0 4084.1 4706.4 4739.0 4780.6 4793.8 4905.1 5649.0 5679.7 5682.5 5699.5 5708.1 4811.6 4830.5 4845.3 4848.3 4892.2 4865.1 4907.9 4993.7 5017.4 5023.3 5225.3 5250.7 5255.9 5273.9 5295.9 5573.2 5590.2 5594.4 5596.7 5601.9 5093.9 5138.4 5140.5 5140.6 5142.9 5353.1 5446.9 5449.1 5452.6 5458.9 5540.2 5544.3 5549.6 5550.4 5553.4 5362.5 5375.3 5375.5 5459.6 5464.2 5233.8 5259.5 5444.2 5480.9 5500.8 5353.2 5356.3 5387.7 5429.5 5440.5 5491.8 5519.4 5523.1 5523.4 5529.5 5213.6 5253.1 5393.6 5411.5 5412.1 17:07:31 INFO - PID 17448 | 17:07:31 INFO - PID 17448 | [#1] ext.html Cycles:180 Average:33988.17 Median:30754.04 stddev:52317.23 (170.1%) stddev-sans-first:52404.04 17:07:31 INFO - PID 17448 | Values: 632.2 678.9 696.6 1198.3 1202.2 33483.7 34421.7 34430.7 34515.9 34530.5 34123.7 34449.0 34562.7 34639.5 34663.7 6932.8 7022.7 7300.9 7527.5 7553.2 7615.4 7743.4 7747.3 7769.3 7776.2 7654.2 7739.3 7755.3 7764.8 7773.1 7680.7 7681.5 7714.2 7723.6 7747.8 7481.8 7521.3 7589.4 7592.4 7594.1 34840.7 35061.1 35157.0 35195.6 35205.3 2684.8 2729.9 2730.8 2736.8 2777.3 23849.3 23974.2 24153.4 24590.2 25187.1 2883.7 2898.1 2951.1 2951.2 2953.2 121084.0 122012.0 159777.0 160261.0 161197.2 38214.0 38680.0 38805.0 38824.6 38906.4 39659.2 39791.4 42779.4 42809.1 42909.0 11683.2 11723.6 11753.1 11801.1 11819.6 9164.1 9222.0 9235.9 9237.4 9271.1 13186.0 13198.7 13213.1 13281.6 13373.5 5549.6 5581.6 5603.3 5681.4 5707.5 869.9 889.2 893.2 910.8 932.8 20564.9 21339.4 21558.1 21592.5 21636.5 962.5 967.9 978.8 998.9 1008.2 10788.9 11248.3 11273.4 11289.1 13499.9 199575.0 200428.0 201599.0 202179.0 202707.0 46766.0 47061.3 47149.5 47194.3 47314.8 1233.4 1242.7 1259.1 1261.3 1265.1 24166.9 24424.3 25502.5 25517.2 25566.7 30559.4 30730.2 30777.8 30805.7 31002.2 242968.0 242976.0 243397.0 243558.0 243828.0 27656.2 28591.4 28949.3 29019.7 29042.9 35797.6 35887.0 36258.3 36492.3 37152.8 27532.8 27566.6 27656.0 28256.4 28330.0 27642.6 27800.4 28165.7 28330.4 28578.7 30595.2 30974.4 31044.5 31453.8 31533.8 27171.6 27221.9 27618.7 28034.4 28099.0 21779.7 22372.0 22469.8 22901.0 22936.0 17:07:31 INFO - PID 17448 | 17:07:31 INFO - PID 17448 | [#2] jquery.html Cycles:180 Average:26987.25 Median:12548.40 stddev:69038.85 (550.2%) stddev-sans-first:69203.69 17:07:31 INFO - PID 17448 | Values: 414.5 426.2 426.5 434.9 445.5 17038.0 17198.0 17470.7 17826.2 17870.0 18339.9 18813.6 19414.4 19587.1 19613.3 5792.5 5793.3 5919.0 5926.7 5939.5 5740.4 5871.0 5876.1 5893.8 5907.6 5544.7 5728.2 5729.6 5759.3 5775.7 5622.5 5724.6 5749.8 5755.3 5793.1 5268.7 5283.9 5302.9 5306.8 5307.2 22857.2 23147.7 23213.5 23299.5 23421.9 1610.3 1614.1 1625.2 1631.0 1669.2 13796.2 13804.0 14204.6 14333.5 14818.8 1676.3 1685.9 1690.3 1711.8 1725.1 81174.0 82175.6 82666.2 82931.2 84023.2 11177.6 11496.2 11586.2 11605.5 11636.9 15863.3 15900.7 15958.8 15975.1 15988.1 7248.9 7368.3 7464.8 7630.0 7668.2 6742.9 6763.3 6881.7 6931.1 6954.3 7129.5 7139.9 7140.5 7146.5 7218.9 2089.9 2116.4 2129.8 2136.6 2239.6 826.2 841.3 850.6 853.5 876.7 16763.7 17900.8 17953.3 18059.4 18130.1 880.8 885.4 892.6 895.3 900.0 9087.7 9796.8 9855.5 9893.9 10019.0 401670.0 402241.0 405099.0 433850.0 437349.0 89484.0 89968.6 90736.0 91086.5 92043.5 1016.7 1027.8 1055.8 1058.5 1061.3 14932.2 16107.9 17863.0 17938.3 18200.9 38389.8 40082.6 43621.8 45176.5 45375.3 50449.7 51297.4 53314.7 56021.7 56038.4 10639.8 11603.7 11833.9 12439.9 12730.9 12769.8 12830.6 12925.2 12943.5 12949.4 11456.4 11642.1 11695.5 11946.5 12203.4 10146.9 10160.5 10212.8 10272.9 10386.6 11015.7 11389.0 11419.7 11463.9 11663.4 11743.5 11746.2 11752.5 11956.6 12218.8 11510.2 11526.5 11565.9 11710.2 12045.8 17:07:31 INFO - PID 17448 | 17:07:31 INFO - PID 17448 | [#3] mootools.html Cycles:180 Average:6213.08 Median:3673.49 stddev:3951.69 (107.6%) stddev-sans-first:3945.04 17:07:31 INFO - PID 17448 | Values: 1230.3 1254.8 1255.3 1268.2 1287.3 9496.1 9950.8 10154.5 10162.6 10238.6 9914.6 10014.2 10041.0 10106.4 10120.7 2210.7 2263.5 2264.5 2274.6 2282.2 2173.3 2220.5 2223.0 2240.2 2241.6 2198.7 2230.5 2245.1 2245.9 2279.1 2113.8 2191.8 2195.8 2197.7 2199.0 1840.1 1912.5 2164.3 2169.4 2172.2 9982.7 10234.5 10245.4 10258.9 10260.5 5485.5 5682.4 5682.7 5682.7 5698.5 3388.3 3459.5 3496.8 3502.2 3510.2 1115.6 1124.7 1139.7 1166.3 1194.9 14326.5 14358.1 14418.2 14513.3 14556.5 4585.2 4624.8 4766.1 4770.7 4907.3 10804.3 10848.2 10940.6 10946.3 10969.5 5506.3 5518.3 5537.7 5541.0 5564.3 4731.0 4786.3 4845.8 4863.7 5003.0 3836.8 3863.1 3870.4 3941.6 3950.0 1122.9 1123.1 1127.4 1138.3 1143.0 677.3 693.3 705.9 714.2 724.8 5437.6 5500.5 5516.9 5518.8 5693.4 552.8 562.2 564.2 569.0 574.2 3319.8 3395.2 3407.6 3432.5 3441.7 12279.4 13166.1 13176.7 13191.2 13260.7 12884.2 12897.2 13049.9 13143.6 13161.1 8928.3 9076.3 9092.1 9351.8 9482.5 5939.4 6113.1 6178.8 6327.5 6346.6 11031.4 11719.6 11728.5 11834.6 11894.7 11256.8 11272.9 11292.5 11433.9 11447.3 7888.1 8060.6 8074.7 8162.2 8167.3 8828.2 9329.4 9438.4 9439.3 9441.9 7648.4 7867.0 7918.2 7938.3 8063.6 7593.0 7614.6 7629.1 7736.9 7826.8 7409.7 7413.6 7431.2 7485.6 7518.5 5296.3 5381.1 5439.0 5495.3 5602.9 4965.8 4971.7 5053.3 5061.6 5295.7 17:07:31 INFO - PID 17448 | 17:07:31 INFO - PID 17448 | [#4] prototype.html Cycles:180 Average:4870.48 Median:5433.52 stddev:1389.96 (25.6%) stddev-sans-first:1352.69 17:07:31 INFO - PID 17448 | Values: 396.8 399.1 399.4 399.6 405.0 5546.7 5620.0 5637.4 5637.5 5638.6 5325.5 5331.0 5486.1 5505.0 5505.6 4415.5 4417.8 4421.2 4428.4 4434.0 4433.1 4437.6 4440.9 4458.8 4465.9 4275.7 4373.2 4413.8 4416.8 4421.9 4391.8 4394.5 4396.3 4405.9 4422.1 3948.9 3967.2 3974.2 3990.8 4013.8 5141.5 5408.6 5458.5 5488.4 5495.3 4930.5 4941.2 4941.3 4942.1 4943.4 5807.2 5870.0 5904.2 5914.6 5916.5 3914.9 4070.6 4081.1 4098.3 4112.4 5844.7 6094.6 6130.6 6183.5 6196.8 4105.5 4203.2 4212.2 4213.8 4215.1 4184.1 4234.2 4238.4 4238.6 4277.3 4868.7 4875.7 4877.5 4914.7 4919.2 5835.9 5867.9 5891.5 5897.3 5939.0 1601.9 1616.2 1623.1 1627.5 1632.5 1086.3 1141.7 1147.2 1153.3 1162.5 5085.7 5122.5 5131.6 5139.6 5145.9 6113.8 6119.8 6133.7 6146.3 6159.2 4962.2 5104.3 5108.5 5111.3 5120.2 3212.2 3231.0 3255.3 3258.7 3260.8 5355.4 5637.4 5658.4 5676.1 5682.4 6171.4 6208.8 6237.1 6247.4 6250.9 5625.8 5657.5 5672.1 5681.0 5693.9 5933.0 6034.5 6076.3 6081.7 6113.3 6008.8 6019.4 6020.7 6024.9 6038.4 5349.0 5466.6 5537.9 5630.8 5645.7 4164.6 4189.7 4206.2 4211.3 4213.0 5910.2 6065.4 6076.6 6079.0 6111.4 5799.4 5832.3 5847.7 5865.8 5901.0 5813.1 5830.3 5838.8 5843.2 5868.2 5567.7 5706.5 5736.0 5750.7 5787.9 5879.0 5888.4 5890.8 5905.5 5926.7 5603.5 5741.7 5745.7 5746.3 5758.7 17:07:31 INFO - PID 17448 | 17:07:31 INFO - PID 17448 | [#5] yui.html Cycles:180 Average:13636.04 Median:45328.39 stddev:16806.20 (37.1%) stddev-sans-first:16825.18 17:07:31 INFO - PID 17448 | Values: 679.6 682.4 686.4 707.9 726.6 11807.9 12113.5 12286.6 12290.6 12918.0 12419.4 12630.1 12630.3 12654.1 12670.6 816.8 833.4 835.5 836.4 837.8 805.9 834.6 841.7 841.8 842.3 904.1 906.8 906.9 911.0 912.6 898.7 900.7 903.7 906.7 907.2 666.4 668.6 668.7 669.1 669.7 13260.1 13513.0 13554.4 13564.9 13570.7 13569.7 14250.5 14340.4 14349.6 14452.3 9531.9 9613.0 9797.9 9904.7 10112.9 2506.6 2513.9 2531.3 2566.4 2629.5 64899.0 65785.0 66244.3 67142.0 67610.3 10797.8 10895.8 10975.6 11039.5 11043.6 21999.5 22023.3 22182.7 22212.2 22526.3 5953.6 5996.8 6022.4 6024.4 6229.2 2867.2 2893.8 2928.0 2959.3 3002.3 3392.5 3476.8 3503.7 3505.1 3528.9 615.9 620.3 624.0 635.1 641.7 524.8 541.4 542.3 553.8 575.4 7717.2 7930.4 8076.5 8215.6 8356.3 487.1 493.1 497.1 499.8 504.8 3611.9 3691.0 3706.3 3758.3 3763.3 62962.7 63662.4 64410.0 64447.7 66995.3 43466.3 44474.8 46115.0 49272.0 55421.4 38347.0 41443.0 44647.8 46009.0 47027.5 8678.5 9212.7 9240.8 9244.2 9254.2 24437.0 24858.6 25147.7 25168.2 25899.7 30295.2 30920.8 31260.7 31533.4 31891.5 10773.0 10898.5 11161.2 11221.4 11338.6 11711.5 11900.8 12082.9 12094.4 12665.5 11062.8 11306.7 11416.1 11566.8 11859.9 10441.9 10482.9 11619.6 11620.1 11622.7 10465.3 11008.2 11345.5 11627.4 11662.2 8387.0 8545.5 8676.7 8694.5 8706.9 8384.0 8956.5 9095.0 9320.6 9410.9 17:07:31 INFO - PID 17448 | -------- Summary: end -------- 17:07:31 INFO - PID 17448 | 17:07:32 INFO - TEST-INFO | 17448: exit 0 17:07:32 INFO - TEST-OK | dromaeo_css | took 1121420ms 17:07:32 INFO - TEST-START | kraken 17:07:32 INFO - operating with platform_type : linux_ 17:07:32 INFO - Initialising browser for kraken test... 17:07:32 INFO - TEST-INFO | started process 17827 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGYaA8D/profile http://localhost:49667/getInfo.html) 17:07:37 INFO - PID 17827 | __metrics Screen width/height:1600/1200 17:07:37 INFO - PID 17827 | colorDepth:24 17:07:37 INFO - PID 17827 | Browser inner width/height: 1024/697 17:07:37 INFO - PID 17827 | __metrics 17:07:38 ERROR - PID 17827 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3392: TypeError: this.tabs is undefined 17:07:39 INFO - TEST-INFO | 17827: exit 0 17:07:39 INFO - Browser initialized. 17:07:39 INFO - Running cycle 1/1 for kraken test... 17:07:39 INFO - TEST-INFO | started process 17960 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGYaA8D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:07:51 INFO - PID 17960 | RSS: Main: 155803648 17:07:51 INFO - PID 17960 | 17:07:54 INFO - PID 17960 | Cycle 1(1): loaded http://localhost:49667/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49667/tests/kraken/driver.html?testName=audio-beat-detection) 17:07:55 INFO - PID 17960 | RSS: Main: 161738752 17:07:55 INFO - PID 17960 | 17:07:58 INFO - PID 17960 | Cycle 1(1): loaded http://localhost:49667/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49667/tests/kraken/driver.html?testName=audio-dft) 17:07:58 INFO - PID 17960 | RSS: Main: 160780288 17:07:58 INFO - PID 17960 | 17:08:01 INFO - PID 17960 | Cycle 1(1): loaded http://localhost:49667/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49667/tests/kraken/driver.html?testName=audio-fft) 17:08:02 INFO - PID 17960 | RSS: Main: 157310976 17:08:02 INFO - PID 17960 | 17:08:04 INFO - PID 17960 | Cycle 1(1): loaded http://localhost:49667/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49667/tests/kraken/driver.html?testName=audio-oscillator) 17:08:05 INFO - PID 17960 | RSS: Main: 157999104 17:08:05 INFO - PID 17960 | 17:08:07 INFO - PID 17960 | Cycle 1(1): loaded http://localhost:49667/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49667/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:08:07 INFO - PID 17960 | RSS: Main: 158593024 17:08:07 INFO - PID 17960 | 17:08:11 INFO - PID 17960 | Cycle 1(1): loaded http://localhost:49667/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49667/tests/kraken/driver.html?testName=imaging-darkroom) 17:08:11 INFO - PID 17960 | RSS: Main: 162766848 17:08:11 INFO - PID 17960 | 17:08:15 INFO - PID 17960 | Cycle 1(1): loaded http://localhost:49667/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49667/tests/kraken/driver.html?testName=imaging-desaturate) 17:08:15 INFO - PID 17960 | RSS: Main: 161062912 17:08:15 INFO - PID 17960 | 17:08:18 INFO - PID 17960 | Cycle 1(1): loaded http://localhost:49667/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49667/tests/kraken/driver.html?testName=json-parse-financial) 17:08:19 INFO - PID 17960 | RSS: Main: 161513472 17:08:19 INFO - PID 17960 | 17:08:21 INFO - PID 17960 | Cycle 1(1): loaded http://localhost:49667/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49667/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:08:21 INFO - PID 17960 | RSS: Main: 161939456 17:08:21 INFO - PID 17960 | 17:08:23 INFO - PID 17960 | Cycle 1(1): loaded http://localhost:49667/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49667/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:08:24 INFO - PID 17960 | RSS: Main: 162271232 17:08:24 INFO - PID 17960 | 17:08:26 INFO - PID 17960 | Cycle 1(1): loaded http://localhost:49667/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49667/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:08:27 INFO - PID 17960 | RSS: Main: 162652160 17:08:27 INFO - PID 17960 | 17:08:29 INFO - PID 17960 | Cycle 1(1): loaded http://localhost:49667/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49667/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:08:30 INFO - PID 17960 | RSS: Main: 163627008 17:08:30 INFO - PID 17960 | 17:08:33 INFO - PID 17960 | Cycle 1(1): loaded http://localhost:49667/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49667/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:08:34 INFO - PID 17960 | RSS: Main: 166289408 17:08:34 INFO - PID 17960 | 17:08:36 INFO - PID 17960 | Cycle 1(1): loaded http://localhost:49667/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49667/tests/kraken/driver.html?testName=ai-astar) 17:08:36 INFO - PID 17960 | RSS: Main: 167522304 17:08:36 INFO - PID 17960 | 17:08:36 INFO - PID 17960 | __start_tp_report 17:08:36 INFO - PID 17960 | _x_x_mozilla_page_load 17:08:36 INFO - PID 17960 | _x_x_mozilla_page_load_details 17:08:36 INFO - PID 17960 | |i|pagename|runs| 17:08:36 INFO - PID 17960 | |0;ai-astar;104;112;114;113;111;114;112;110;112;113 17:08:36 INFO - PID 17960 | |1;audio-beat-detection;145;127;123;174;126;126;129;126;152;129 17:08:36 INFO - PID 17960 | |2;audio-dft;165;165;167;166;167;172;164;166;164;164 17:08:36 INFO - PID 17960 | |3;audio-fft;76;75;76;111;76;76;76;76;98;76 17:08:36 INFO - PID 17960 | |4;audio-oscillator;85;84;108;84;83;84;99;84;89;103 17:08:36 INFO - PID 17960 | |5;imaging-gaussian-blur;115;114;115;115;115;114;117;114;114;116 17:08:36 INFO - PID 17960 | |6;imaging-darkroom;152;151;150;150;150;150;151;151;151;150 17:08:36 INFO - PID 17960 | |7;imaging-desaturate;94;95;98;95;96;95;94;95;94;94 17:08:36 INFO - PID 17960 | |8;json-parse-financial;68;69;67;68;75;69;69;69;68;69 17:08:36 INFO - PID 17960 | |9;json-stringify-tinderbox;56;56;55;57;55;56;55;56;55;56 17:08:36 INFO - PID 17960 | |10;stanford-crypto-aes;85;83;82;84;82;90;82;84;83;83 17:08:36 INFO - PID 17960 | |11;stanford-crypto-ccm;135;133;133;143;144;139;134;142;188;138 17:08:36 INFO - PID 17960 | |12;stanford-crypto-pbkdf2;191;197;195;187;195;208;196;195;194;193 17:08:36 INFO - PID 17960 | |13;stanford-crypto-sha256-iterative;72;74;71;75;71;75;71;70;73;73 17:08:36 INFO - PID 17960 | __end_tp_report 17:08:36 INFO - PID 17960 | __start_cc_report 17:08:36 INFO - PID 17960 | _x_x_mozilla_cycle_collect,867 17:08:36 INFO - PID 17960 | __end_cc_report 17:08:36 INFO - PID 17960 | __startTimestamp1490314116661__endTimestamp 17:08:36 INFO - PID 17960 | 17:08:36 INFO - PID 17960 | ------- Summary: start ------- 17:08:36 INFO - PID 17960 | Number of tests: 14 17:08:36 INFO - PID 17960 | 17:08:36 INFO - PID 17960 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.50 stddev:2.92 (2.6%) stddev-sans-first:1.32 17:08:36 INFO - PID 17960 | Values: 104.0 112.0 114.0 113.0 111.0 114.0 112.0 110.0 112.0 113.0 17:08:36 INFO - PID 17960 | 17:08:36 INFO - PID 17960 | [#1] audio-beat-detection Cycles:10 Average:135.70 Median:129.00 stddev:16.43 (12.7%) stddev-sans-first:17.07 17:08:36 INFO - PID 17960 | Values: 145.0 127.0 123.0 174.0 126.0 126.0 129.0 126.0 152.0 129.0 17:08:36 INFO - PID 17960 | 17:08:36 INFO - PID 17960 | [#2] audio-dft Cycles:10 Average:166.00 Median:166.00 stddev:2.40 (1.4%) stddev-sans-first:2.52 17:08:36 INFO - PID 17960 | Values: 165.0 165.0 167.0 166.0 167.0 172.0 164.0 166.0 164.0 164.0 17:08:36 INFO - PID 17960 | 17:08:36 INFO - PID 17960 | [#3] audio-fft Cycles:10 Average:81.60 Median:76.00 stddev:12.46 (16.4%) stddev-sans-first:13.05 17:08:36 INFO - PID 17960 | Values: 76.0 75.0 76.0 111.0 76.0 76.0 76.0 76.0 98.0 76.0 17:08:36 INFO - PID 17960 | 17:08:36 INFO - PID 17960 | [#4] audio-oscillator Cycles:10 Average:90.30 Median:84.00 stddev:9.38 (11.2%) stddev-sans-first:9.75 17:08:36 INFO - PID 17960 | Values: 85.0 84.0 108.0 84.0 83.0 84.0 99.0 84.0 89.0 103.0 17:08:36 INFO - PID 17960 | 17:08:36 INFO - PID 17960 | [#5] imaging-gaussian-blur Cycles:10 Average:114.90 Median:115.00 stddev:0.99 (0.9%) stddev-sans-first:1.05 17:08:36 INFO - PID 17960 | Values: 115.0 114.0 115.0 115.0 115.0 114.0 117.0 114.0 114.0 116.0 17:08:36 INFO - PID 17960 | 17:08:36 INFO - PID 17960 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:151.00 stddev:0.70 (0.5%) stddev-sans-first:0.53 17:08:36 INFO - PID 17960 | Values: 152.0 151.0 150.0 150.0 150.0 150.0 151.0 151.0 151.0 150.0 17:08:36 INFO - PID 17960 | 17:08:36 INFO - PID 17960 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:1.25 (1.3%) stddev-sans-first:1.27 17:08:36 INFO - PID 17960 | Values: 94.0 95.0 98.0 95.0 96.0 95.0 94.0 95.0 94.0 94.0 17:08:36 INFO - PID 17960 | 17:08:36 INFO - PID 17960 | [#8] json-parse-financial Cycles:10 Average:69.10 Median:69.00 stddev:2.18 (3.2%) stddev-sans-first:2.28 17:08:36 INFO - PID 17960 | Values: 68.0 69.0 67.0 68.0 75.0 69.0 69.0 69.0 68.0 69.0 17:08:36 INFO - PID 17960 | 17:08:36 INFO - PID 17960 | [#9] json-stringify-tinderbox Cycles:10 Average:55.70 Median:56.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 17:08:36 INFO - PID 17960 | Values: 56.0 56.0 55.0 57.0 55.0 56.0 55.0 56.0 55.0 56.0 17:08:36 INFO - PID 17960 | 17:08:36 INFO - PID 17960 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:83.50 stddev:2.39 (2.9%) stddev-sans-first:2.50 17:08:36 INFO - PID 17960 | Values: 85.0 83.0 82.0 84.0 82.0 90.0 82.0 84.0 83.0 83.0 17:08:36 INFO - PID 17960 | 17:08:36 INFO - PID 17960 | [#11] stanford-crypto-ccm Cycles:10 Average:142.90 Median:140.50 stddev:16.37 (11.7%) stddev-sans-first:17.12 17:08:36 INFO - PID 17960 | Values: 135.0 133.0 133.0 143.0 144.0 139.0 134.0 142.0 188.0 138.0 17:08:36 INFO - PID 17960 | 17:08:36 INFO - PID 17960 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.10 Median:195.00 stddev:5.36 (2.8%) stddev-sans-first:5.48 17:08:36 INFO - PID 17960 | Values: 191.0 197.0 195.0 187.0 195.0 208.0 196.0 195.0 194.0 193.0 17:08:36 INFO - PID 17960 | 17:08:36 INFO - PID 17960 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:73.00 stddev:1.78 (2.4%) stddev-sans-first:1.88 17:08:36 INFO - PID 17960 | Values: 72.0 74.0 71.0 75.0 71.0 75.0 71.0 70.0 73.0 73.0 17:08:36 INFO - PID 17960 | -------- Summary: end -------- 17:08:36 INFO - PID 17960 | 17:08:37 INFO - TEST-INFO | 17960: exit 0 17:08:37 INFO - TEST-OK | kraken | took 65130ms 17:08:37 INFO - SUITE-END | took 1186s 17:08:38 INFO - Completed test suite (00:19:47) 17:08:38 INFO - javascript benchmark 17:08:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6683.983617706521, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2691.340621547721, 2705.6617922759656, 2721.4693134838703, 2736.0423851651913, 2747.6840163381216, 5073.822416215433, 5119.334486516752, 5135.075686376451, 5166.380034395868, 5192.896142077157, 5101.54086132248, 5174.611904107188, 5244.763985620647, 5247.055530004598, 5297.390800057994, 4783.999999999991, 4799.784009719571, 4801.975990120044, 4833.903321933559, 4851.151048566504, 4835.226363781796, 4837.274408838684, 4892.192788189945, 4892.779824907888, 4936.062148191832, 4667.4632417272105, 4697.365855609483, 4770.0, 4797.7601119943865, 4798.928016079762, 4789.473157952622, 4793.880152996203, 4811.446683631392, 4836.419629644465, 4863.319135321058, 4686.015936653307, 4752.07334569759, 4762.499937506546, 4771.260454629538, 4807.0, 5003.74981250936, 5045.344105266328, 5193.766280517348, 5201.271821944931, 5268.868278293035, 5577.944220557783, 5601.29983752031, 5640.774369025234, 5654.406287339812, 5656.8020119295625, 5650.886982260332, 5676.858078548028, 5682.573806964494, 5697.6296540724725, 5700.9429905701245, 5050.4697006814495, 5263.605229607795, 5271.762770675252, 5279.524842764131, 5345.064613692588, 5576.749046292845, 5639.887202255932, 5652.095664693629, 5656.0, 5660.235868157828, 5436.374816896028, 5445.1015582429245, 5528.640638358494, 5553.833384998376, 5560.138178582326, 5624.353199382042, 5626.774929002794, 5638.915416268759, 5639.774409023676, 5665.6034077614995, 5601.159826026129, 5601.551875849922, 5607.551395888319, 5615.606907516516, 5619.887602247933, 5400.054990376669, 5456.508914197741, 5521.4478552145265, 5601.663900166003, 5603.663780173202, 4649.093426781813, 4650.069986002813, 4652.046330502239, 4699.624030077585, 4716.151092803259, 4025.77858217795, 4041.818118184689, 4044.8179831907637, 4051.0480037191824, 4084.1423301106506, 4706.388169537938, 4738.95261047392, 4780.569748722632, 4793.760311984387, 4905.117078925828, 5648.971755141198, 5679.716014199274, 5682.488576028178, 5699.487046165782, 5708.115242137475, 4811.615070794328, 4830.492798256203, 4845.3216549683075, 4848.296996935424, 4892.241702536113, 4865.051314993542, 4907.944791869765, 4993.700377977333, 5017.422996355466, 5023.271625614266, 5225.294585231097, 5250.65870718402, 5255.89488210226, 5273.8681532960445, 5295.867603309948, 5573.219749235192, 5590.189422533791, 5594.356648985418, 5596.720163991866, 5601.943980560142, 5093.8726531837, 5138.434772174983, 5140.511651393112, 5140.588752899834, 5142.948570514247, 5353.116735738559, 5446.863828404322, 5449.073657478159, 5452.591055670761, 5458.9454105458435, 5540.22436858832, 5544.251526043932, 5549.639273447375, 5550.38945715979, 5553.444655534414, 5362.490563396471, 5375.3280839895015, 5375.489328513785, 5459.645123067146, 5464.207689885024, 5233.842984710464, 5259.526642602184, 5444.183372493999, 5480.862978425412, 5500.7524661391135, 5353.223782551586, 5356.276902618097, 5387.730613469389, 5429.53848922846, 5440.510354068153, 5491.835244942658, 5519.3652729936575, 5523.061079616556, 5523.447655234605, 5529.474699903502, 5213.60897932649, 5253.106971814877, 5393.649412788156, 5411.540019098264, 5412.052890744026], "value": 5101.533777074891, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [632.1907957814, 678.9083473731046, 696.5924933913661, 1198.2870192235616, 1202.2065436811706, 33483.66516334839, 34421.655783442155, 34430.65569344303, 34515.893569578766, 34530.48204276932, 34123.65876341236, 34449.0, 34562.65437345626, 34639.480407793904, 34663.65336346636, 6932.7920162395085, 7022.719091236345, 7300.868365403371, 7527.548347099191, 7553.24467553243, 7615.428842836782, 7743.380529557622, 7747.264009919077, 7769.339606133457, 7776.222377762235, 7654.234576542329, 7739.3421559167255, 7755.340796032344, 7764.805879853021, 7773.144954055049, 7680.692772289101, 7681.50070245435, 7714.187166015981, 7723.613819309068, 7747.845043099134, 7481.7755467336065, 7521.285477879593, 7589.354904833096, 7592.354649854769, 7594.050743657043, 34840.65159348425, 35061.12347191341, 35157.0, 35195.64804351975, 35205.29589408197, 2684.8254863433813, 2729.9181024569293, 2730.8224965377385, 2736.7536921677147, 2777.3334399744117, 23849.284521464382, 23974.160904368437, 24153.41002506018, 24590.155738319518, 25187.118450854316, 2883.740463358287, 2898.087102562686, 2951.0556621881005, 2951.2031751426994, 2953.1731115287753, 121084.0, 122012.0, 159777.0, 160261.0, 161197.19401402917, 38214.0, 38680.0, 38805.0, 38824.6117538821, 38906.41640375397, 39659.20681586352, 39791.40312895309, 42779.35830962538, 42809.143817123484, 42909.0, 11683.18217724751, 11723.648290551297, 11753.118516111326, 11801.055915526736, 11819.586314478953, 9164.129407706258, 9222.031686672937, 9235.907640923639, 9237.399569027992, 9271.072892710676, 13186.0, 13198.736025279633, 13213.14114582549, 13281.601551953458, 13373.53192638253, 5549.5837812164245, 5581.553475721932, 5603.299587551556, 5681.403452637496, 5707.486326230659, 869.913008699125, 889.1686273334453, 893.1515060692368, 910.8269428808505, 932.8227636748996, 20564.897175514026, 21339.35981920545, 21558.13767449316, 21592.460188495414, 21636.4590885226, 962.5091203486272, 967.8596603492595, 978.8335982882927, 998.8951160128082, 1008.2387797213057, 10788.892111078945, 11248.325100493832, 11273.379964101889, 11289.0968722502, 13499.932500337633, 199575.0, 200428.0, 201599.0, 202179.0, 202707.0, 46766.0, 47061.29408058882, 47149.528504714515, 47194.29208561874, 47314.763426182646, 1233.444949772606, 1242.683115805482, 1259.0871618076822, 1261.3188878005958, 1265.13970500059, 24166.87916560406, 24424.26727198187, 25502.489950201263, 25517.2344829648, 25566.744332556435, 30559.388812224075, 30730.231744206572, 30777.846110769304, 30805.69194308028, 31002.224944376572, 242968.0, 242976.0, 243397.0, 243558.0, 243828.02773875574, 27656.170314890587, 28591.42817143687, 28949.276268093465, 29019.7098029017, 29042.854785725936, 35797.64202357943, 35887.0, 36258.27483450369, 36492.270154596226, 37152.81423592973, 27532.761025753487, 27566.5865012021, 27656.0, 28256.43487130287, 28330.0, 27642.585361219197, 27800.443991120468, 28165.71834281713, 28330.43339133247, 28578.71421285844, 30595.2351191222, 30974.380512389176, 31044.534331984585, 31453.8427307862, 31533.8423307882, 27171.64141792942, 27221.863890681212, 27618.72381276242, 28034.439311214068, 28099.0, 21779.673304900756, 22372.0, 22469.77530224677, 22901.0, 22936.0], "value": 15076.69811881396, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.4632700652655, 426.2115087088886, 426.50012852124416, 434.8586709319471, 445.5499945055495, 17037.977721336727, 17198.0, 17470.737938930924, 17826.19782109805, 17870.0, 18339.90830045851, 18813.623727525443, 19414.44684425246, 19587.118579663915, 19613.31353402631, 5792.536597072224, 5793.33376661684, 5918.970405147989, 5926.703664816763, 5939.524838012949, 5740.368559458456, 5871.031279838843, 5876.0598304271325, 5893.764249430018, 5907.616004959686, 5544.667319960815, 5728.198052272685, 5729.627574207663, 5759.308882934054, 5775.682337471438, 5622.465865742748, 5724.5992780505385, 5749.770009199627, 5755.309362876461, 5793.073108302693, 5268.710220937847, 5283.947160528384, 5302.946970530323, 5306.7611957462, 5307.150855863082, 22857.199998000156, 23147.652785208236, 23213.53572928532, 23299.534009319887, 23421.88289058561, 1610.3397606981198, 1614.1203044340862, 1625.19552821353, 1631.0140544828027, 1669.2154687297073, 13796.172229666152, 13804.0, 14204.573862784133, 14333.498327558485, 14818.777718334233, 1676.3378465506057, 1685.9495907043963, 1690.3407671008317, 1711.8031426385876, 1725.094325479121, 81174.0, 82175.589122054, 82666.17333826705, 82931.17068829294, 84023.15976840275, 11177.552897884156, 11496.195266331277, 11586.188966772414, 11605.477753501113, 11636.88363116358, 15863.286152122952, 15900.681986360209, 15958.76061859073, 15975.08299004127, 15988.120653364176, 7248.891266631004, 7368.336849683555, 7464.776056718307, 7630.0, 7668.156502784689, 6742.932570674328, 6763.2898545652, 6881.65591720412, 6931.133608298963, 6954.3393377629045, 7129.500934934608, 7139.857202855914, 7140.500164988505, 7146.535475194096, 7218.927810721825, 2089.9268525601533, 2116.4285642876644, 2129.7763734807622, 2136.5833662435675, 2239.6080685879906, 826.1696994520588, 841.3227351981591, 850.6342272822745, 853.4538990494506, 876.7150676030316, 16763.748543771853, 17900.820991790177, 17953.281868725106, 18059.367922122925, 18130.09349532518, 880.7886107334193, 885.4333226734894, 892.5983307511646, 895.3374502867831, 900.0468982308275, 9087.681931132378, 9796.804063918682, 9855.497967784182, 9893.851592226123, 10019.0, 401670.0, 402241.0, 405099.0, 433850.0, 437349.0, 89484.0, 89968.5501572488, 90736.0, 91086.54456727806, 92043.53978230066, 1016.6594190946116, 1027.8355463125863, 1055.7730088030958, 1058.5342449322427, 1061.2889364126054, 14932.178730169944, 16107.919460402623, 17863.0, 17938.282468701105, 18200.90899545547, 38389.80805096068, 40082.59917400789, 43621.781891090344, 45176.54823451855, 45375.319370210134, 50449.747751261006, 51297.38323550898, 53314.73342633417, 56021.71989140191, 56038.439615603325, 10639.840402393815, 11603.6518904433, 11833.940830295793, 12439.937800310941, 12730.936345318214, 12769.808452873029, 12830.55093071738, 12925.224486530462, 12943.482260709467, 12949.417276222404, 11456.427178640868, 11642.147673819629, 11695.532178712756, 11946.522139114339, 12203.389830508617, 10146.949265253626, 10160.491975401348, 10212.795744085226, 10272.948635256776, 10386.636467723594, 11015.669529914116, 11389.0, 11419.657410277705, 11463.885361146282, 11663.358515281741, 11743.47154378072, 11746.17776755619, 11752.471138798946, 11956.58151964677, 12218.755624887275, 11510.194286399872, 11526.481308340977, 11565.942170289094, 11710.180287379802, 12045.759084818079], "value": 9221.568980354235, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1230.3110258255376, 1254.7866862633352, 1255.3095797311476, 1268.156675810586, 1287.2598256002798, 9496.145346918776, 9950.800983980334, 10154.543045562948, 10162.59349626014, 10238.590456381746, 9914.603415863357, 10014.248931330161, 10041.0, 10106.44414557201, 10120.69637910862, 2210.7126073610407, 2263.5359751251035, 2264.52444986553, 2274.55646149001, 2282.2354511238755, 2173.304542546378, 2220.4892874638845, 2223.044091040852, 2240.2383189715492, 2241.551689662066, 2198.736151661795, 2230.520438105807, 2245.079517397867, 2245.932622021342, 2279.076973825595, 2113.7991890770354, 2191.791779780918, 2195.7584665686763, 2197.692323074763, 2198.999999999992, 1840.1075478392968, 1912.4645099372199, 2164.3290579920276, 2169.370882444089, 2172.2071443923014, 9982.700518984442, 10234.488275586265, 10245.385276883411, 10258.948705256425, 10260.538275777533, 5485.533729632986, 5682.403347648478, 5682.687452190128, 5682.715864206773, 5698.487136157766, 3388.2884594234993, 3459.4637831136215, 3496.7552271341015, 3502.176988407722, 3510.1926556891804, 1115.6151127860876, 1124.662601219639, 1139.7207684117361, 1166.3410173252084, 1194.8566172059323, 14326.49857254991, 14358.138511689333, 14418.206998614967, 14513.346899389553, 14556.490522831757, 4585.197590421662, 4624.838130665411, 4766.142094422968, 4770.713757174581, 4907.312976183337, 10804.297720648132, 10848.240623156304, 10940.617078402218, 10946.288491248044, 10969.50637221311, 5506.311711036121, 5518.255035570227, 5537.695426751487, 5541.0, 5564.27664403633, 4730.95269047312, 4786.2581299898575, 4845.75771211438, 4863.683860549124, 5003.0, 3836.7889766063136, 3863.130795570974, 3870.41943708446, 3941.586133456003, 3950.0322421007036, 1122.8989390954853, 1123.101518784985, 1127.3799410324452, 1138.3056335635256, 1142.994285028586, 677.3023785500942, 693.2546717717217, 705.8658854817671, 714.1537278325201, 724.7608289264635, 5437.646552974044, 5500.50495455411, 5516.88296112695, 5518.751656175482, 5693.373728889819, 552.8009916430082, 562.2437821130573, 564.1875698993437, 568.9971550142305, 574.2075935209384, 3319.751018673609, 3395.219099607104, 3407.5910890693276, 3432.502287168347, 3441.6730410610953, 12279.447424865724, 13166.078374513883, 13176.736465270833, 13191.208527488381, 13260.668483287802, 12884.226946383247, 12897.203725703532, 13049.934750326378, 13143.60569182926, 13161.078724489385, 8928.285737141014, 9076.27389808827, 9092.090790920987, 9351.812963740687, 9482.478463684425, 5939.376365481562, 6113.1135985281, 6178.783742568989, 6327.462165715781, 6346.555741098079, 11031.448427578429, 11719.589814356457, 11728.472218750007, 11834.644960651194, 11894.702632434259, 11256.831147532957, 11272.887271127183, 11292.548298067984, 11433.942830285796, 11447.25592836463, 7888.092869319872, 8060.596970151586, 8074.677012919652, 8162.224588664068, 8167.305779008851, 8828.24959878392, 9329.393589416666, 9438.433693978383, 9439.339246252697, 9441.905580944378, 7648.426368022309, 7866.960665196638, 7918.168592297726, 7938.285554300141, 8063.596820159086, 7592.962035189788, 7614.581198034161, 7629.0845098588525, 7736.883946740691, 7826.843463130592, 7409.66656500448, 7413.629318533944, 7431.182569917413, 7485.625718714152, 7518.473706840688, 5296.321695140913, 5381.139017757297, 5439.0, 5495.340559132929, 5602.943970560243, 4965.751712414292, 4971.726555039508, 5053.343065401475, 5061.569766569883, 5295.7087360195555], "value": 4658.512645959773, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.8055652730162, 399.1139669932749, 399.4108689682718, 399.60638770810766, 404.9959500404995, 5546.694931778756, 5619.971900140494, 5637.408072152426, 5637.548996080314, 5638.605297629162, 5325.547328477074, 5330.973345133279, 5486.1222204447295, 5504.972475137629, 5505.587080968923, 4415.470143582758, 4417.845375411861, 4421.197769917868, 4428.424304840374, 4434.046679963807, 4433.135538569964, 4437.600615944564, 4440.933385999213, 4458.754768487732, 4465.9106817863785, 4275.657947364203, 4373.234683930315, 4413.801378937956, 4416.779161041951, 4421.88945276369, 4391.758453285068, 4394.4946331172005, 4396.2746146885565, 4405.911881762363, 4422.115576884636, 3948.861789837342, 3967.1867267210155, 3974.225026119908, 3990.7805070721097, 4013.7591744495426, 5141.53726164647, 5408.567314614861, 5458.4814442627885, 5488.396276409591, 5495.340559132889, 4930.531599498042, 4941.234108713119, 4941.332920055783, 4942.110420124376, 4943.3573635427165, 5807.157962095514, 5870.0, 5904.2029326040865, 5914.556408269354, 5916.497097746696, 3914.862979795722, 4070.5929407059352, 4081.102287436356, 4098.344264917599, 4112.403701463271, 5844.6785426801935, 6094.603850749687, 6130.570860039799, 6183.505319574423, 6196.752129914798, 4105.495647654928, 4203.222403855236, 4212.178625168124, 4213.789310534522, 4215.093754842724, 4184.121334519724, 4234.174336004449, 4238.449001629769, 4238.618524332825, 4277.315629499328, 4868.683535570177, 4875.683080599821, 4877.512248775094, 4914.680545764514, 4919.237518184687, 5835.928245472881, 5867.921794352969, 5891.469767720926, 5897.287247865944, 5938.970305148447, 1601.879859010579, 1616.1676736480722, 1623.0586259969425, 1627.4548026411048, 1632.4612877750315, 1086.3319058778952, 1141.6746227325173, 1147.208426185929, 1153.2734377342222, 1162.5001249462644, 5085.74571271435, 5122.462141475092, 5131.640785145079, 5139.560922941582, 5145.871353216199, 6113.816585502442, 6119.785807496716, 6133.723982420802, 6146.293176284695, 6159.23009623797, 4962.181240095344, 5104.285400043997, 5108.463611320758, 5111.284420181178, 5120.231965205175, 3212.1969507623094, 3230.9676903230666, 3255.316383559432, 3258.7393008559256, 3260.755443341759, 5355.437679043722, 5637.392069075795, 5658.434156584391, 5676.091825307931, 5682.40334764852, 6171.444569988723, 6208.782692605737, 6237.09562113491, 6247.375262473807, 6250.937490625127, 5625.803096891589, 5657.547396208293, 5672.092465205547, 5680.971595141998, 5693.8861222774485, 5932.9703351484695, 6034.517238620812, 6076.33160352352, 6081.695915204311, 6113.29697084841, 6008.759649613967, 6019.398060194121, 6020.668863212565, 6024.8795024100145, 6038.426349496791, 5349.0, 5466.5900057495055, 5537.944620553743, 5630.774769009357, 5645.745941432563, 4164.583541645811, 4189.72766770159, 4206.221848957953, 4211.263028969979, 4213.0, 5910.172575839472, 6065.363136870565, 6076.605020673819, 6079.0, 6111.358307377662, 5799.449052340021, 5832.3292821326095, 5847.707614619337, 5865.768188680254, 5901.0, 5813.09896965971, 5830.271216097988, 5838.781263119988, 5843.152742852348, 5868.178455016387, 5567.66594004361, 5706.4864162225595, 5735.97132014354, 5750.654960702372, 5787.9421205789085, 5879.0, 5888.381719919346, 5890.793822216202, 5905.498032667099, 5926.666500037457, 5603.523700485504, 5741.712914354349, 5745.6552606843725, 5746.339170995389, 5758.712064396847], "value": 4456.834512746658, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.5922446532085, 682.3756263019337, 686.3822559696273, 707.8548897476014, 726.5604309392819, 11807.881921180786, 12113.454894529756, 12286.631401057972, 12290.631281061582, 12918.031147663916, 12419.379031048435, 12630.115891887572, 12630.30533320667, 12654.05094617905, 12670.556530521433, 816.7549735079467, 833.4332653795417, 835.4945258118811, 836.3894357119307, 837.8366218587378, 805.9314958228529, 834.5743670727942, 841.6927821345196, 841.7727213652311, 842.3135144856952, 904.1410659873114, 906.8005038891466, 906.9183773460387, 910.968116115936, 912.6486302773413, 898.6764764684708, 900.6892622045384, 903.6791938861708, 906.7415786500816, 907.188066680324, 666.3802663522922, 668.6322522612544, 668.729164688302, 669.1468377818272, 669.7220653428822, 13260.13809102415, 13513.0, 13554.390052447565, 13564.864351356458, 13570.728585428236, 13569.728605427936, 14250.501232456814, 14340.426382944774, 14349.641258968504, 14452.286589931231, 9531.904680953172, 9613.0, 9797.853032204523, 9904.653337133166, 10112.94943525285, 2506.6240063990367, 2513.8868750906254, 2531.316544532984, 2566.3712390464457, 2629.474105178953, 64899.0, 65785.0, 66244.3375566243, 67142.0, 67610.32389676089, 10797.784044319069, 10895.782084358269, 10975.615853445091, 11039.503222355013, 11043.613473528549, 21999.450013749465, 22023.33929982103, 22182.667259991114, 22212.222572209896, 22526.324210273717, 5953.613015154001, 5996.820095397145, 6022.39776022403, 6024.397560244028, 6229.221347331583, 2867.168521128891, 2893.8263704177816, 2927.9707202928125, 2959.319356548006, 3002.309468822183, 3392.490341797926, 3476.791392516457, 3503.702185314277, 3505.053635518396, 3528.929421411609, 615.8922188617064, 620.2804746494045, 623.9688015599202, 635.0569404434411, 641.6567136581906, 524.8346770767196, 541.3828235811178, 542.3004324421452, 553.7563472072276, 575.3900865083025, 7717.1896950819355, 7930.365570754326, 8076.475029123206, 8215.630296636666, 8356.331493480508, 487.06969687895946, 493.1148588284039, 497.0952865784238, 499.8175665881927, 504.84349851546136, 3611.8735844245325, 3690.9630903691154, 3706.258748250361, 3758.3047136279874, 3763.2661630981697, 62962.68518657469, 63662.36337636657, 64410.0, 64447.67776161089, 66995.3300466989, 43466.34800477995, 44474.77762611166, 46115.0, 49272.01455970861, 55421.445785541626, 38347.0, 41443.0, 44647.77676111599, 46009.0, 47027.529724702996, 8678.522681252593, 9212.677556285498, 9240.768980775265, 9244.214241789523, 9254.213391861767, 24437.0, 24858.627120593566, 25147.74852251454, 25168.24495265145, 25899.741002589733, 30295.242618934702, 30920.845395772878, 31260.687393125776, 31533.369332613678, 31891.521627176076, 10773.0, 10898.50956706966, 11161.218714689894, 11221.382823944761, 11338.634625669012, 11711.472983715923, 11900.821487677866, 12082.939585302018, 12094.395280235776, 12665.493380264686, 11062.778744425228, 11306.717332066764, 11416.133264421791, 11566.768664626828, 11859.856998962998, 10441.947790261, 10482.895171048192, 11619.593314233962, 11620.070394368262, 11622.6513204604, 10465.267431279737, 11008.174386921173, 11345.489452974802, 11627.360495172847, 11662.183647144619, 8387.0, 8545.529995850287, 8676.652933882575, 8694.521801300989, 8706.869396958924, 8384.0, 8956.492182188998, 9095.0, 9320.580573874056, 9410.858837117587], "value": 6054.70628331433, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1564.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 114.0, 113.0, 111.0, 114.0, 112.0, 110.0, 112.0, 113.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 127.0, 123.0, 174.0, 126.0, 126.0, 129.0, 126.0, 152.0, 129.0], "value": 135.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 167.0, 166.0, 167.0, 172.0, 164.0, 166.0, 164.0, 164.0], "value": 166.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 111.0, 76.0, 76.0, 76.0, 76.0, 98.0, 76.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 108.0, 84.0, 83.0, 84.0, 99.0, 84.0, 89.0, 103.0], "value": 90.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 115.0, 115.0, 115.0, 114.0, 117.0, 114.0, 114.0, 116.0], "value": 114.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 150.0, 150.0, 150.0, 150.0, 151.0, 151.0, 151.0, 150.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 98.0, 95.0, 96.0, 95.0, 94.0, 95.0, 94.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 67.0, 68.0, 75.0, 69.0, 69.0, 69.0, 68.0, 69.0], "value": 69.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 57.0, 55.0, 56.0, 55.0, 56.0, 55.0, 56.0], "value": 55.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 82.0, 84.0, 82.0, 90.0, 82.0, 84.0, 83.0, 83.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 133.0, 133.0, 143.0, 144.0, 139.0, 134.0, 142.0, 188.0, 138.0], "value": 142.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 197.0, 195.0, 187.0, 195.0, 208.0, 196.0, 195.0, 194.0, 193.0], "value": 195.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 71.0, 75.0, 71.0, 75.0, 71.0, 70.0, 73.0, 73.0], "value": 72.5, "unit": "score"}]}]} 17:08:38 INFO - Return code: 0 17:08:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:08:38 ERROR - # TBPL SUCCESS # 17:08:38 INFO - Running post-action listener: _resource_record_post_action 17:08:38 INFO - [mozharness: 2017-03-24 00:08:38.466035Z] Finished run-tests step (success) 17:08:38 INFO - Running post-run listener: _resource_record_post_run 17:08:38 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 360419328; Read time: 12; Write time: 322840 17:08:38 INFO - TinderboxPrint: CPU usage
13.3% 17:08:38 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 17:08:38 INFO - TinderboxPrint: I/O write bytes / time
360,419,328 / 322,840 17:08:38 INFO - TinderboxPrint: CPU idle
8,323.0 (86.7%) 17:08:38 INFO - TinderboxPrint: CPU user
1,218.3 (12.7%) 17:08:38 INFO - TinderboxPrint: Swap in / out
0 / 0 17:08:38 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 106213376; Read time: 0; Write time: 142020 17:08:38 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 253669376; Read time: 12; Write time: 180820 17:08:39 INFO - Running post-run listener: _upload_blobber_files 17:08:39 INFO - Blob upload gear active. 17:08:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:08:39 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:08:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:08:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:08:39 INFO - (blobuploader) - INFO - Open directory for files ... 17:08:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:08:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:08:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:08:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:08:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:08:40 INFO - (blobuploader) - INFO - Done attempting. 17:08:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:08:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:08:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:08:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:08:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:08:41 INFO - (blobuploader) - INFO - Done attempting. 17:08:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:08:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:08:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:08:41 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:08:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:08:41 INFO - (blobuploader) - INFO - Done attempting. 17:08:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:08:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:08:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:08:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:08:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:08:45 INFO - (blobuploader) - INFO - Done attempting. 17:08:45 INFO - (blobuploader) - INFO - Iteration through files over. 17:08:45 INFO - Return code: 0 17:08:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:08:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:08:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/013b1296f651fcaf83e1bac984074ae7524c0c0c0a6612034c06466bdab5c53afcb172d7ddd5c5554d3229870e3becbf79681a3b5a2a9ebfd862b360f66491b9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dc630c45707e2e47bc1f55f9c64676510795c572ab1fac74d65b4096a6a2d770e0028a0d55592bc8188359591c780e2254cf661676ca8991e03f7904a27f7ab6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8937f19e1d84abb83854876218532f37dec083326ae148ed6dfd8eb09dc246f66536abf259ea950680bba2e80efae226465179feb719e656a14876f338534a2c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/12f576b95844e5eaea0bb5545ad45c701a3a8a6ca59d888ea58ef648696fb53c8fd37458c78d1352a3a623429c220eb1c2ac5f34181304d3788e1d9d6eb0e68f"} 17:08:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:08:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:08:45 INFO - Contents: 17:08:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/013b1296f651fcaf83e1bac984074ae7524c0c0c0a6612034c06466bdab5c53afcb172d7ddd5c5554d3229870e3becbf79681a3b5a2a9ebfd862b360f66491b9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dc630c45707e2e47bc1f55f9c64676510795c572ab1fac74d65b4096a6a2d770e0028a0d55592bc8188359591c780e2254cf661676ca8991e03f7904a27f7ab6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8937f19e1d84abb83854876218532f37dec083326ae148ed6dfd8eb09dc246f66536abf259ea950680bba2e80efae226465179feb719e656a14876f338534a2c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/12f576b95844e5eaea0bb5545ad45c701a3a8a6ca59d888ea58ef648696fb53c8fd37458c78d1352a3a623429c220eb1c2ac5f34181304d3788e1d9d6eb0e68f"} 17:08:45 INFO - Running post-run listener: copy_logs_to_upload_dir 17:08:45 INFO - Copying logs to upload dir... 17:08:45 INFO - mkdir: /builds/slave/test/build/upload/logs 17:08:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.162651 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-03-23 17:08:45.351075) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 17:08:45.354908) ========= 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=781b77c4c33858b1f599d705000001c1-1490312862.66852-788313833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/013b1296f651fcaf83e1bac984074ae7524c0c0c0a6612034c06466bdab5c53afcb172d7ddd5c5554d3229870e3becbf79681a3b5a2a9ebfd862b360f66491b9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dc630c45707e2e47bc1f55f9c64676510795c572ab1fac74d65b4096a6a2d770e0028a0d55592bc8188359591c780e2254cf661676ca8991e03f7904a27f7ab6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8937f19e1d84abb83854876218532f37dec083326ae148ed6dfd8eb09dc246f66536abf259ea950680bba2e80efae226465179feb719e656a14876f338534a2c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/12f576b95844e5eaea0bb5545ad45c701a3a8a6ca59d888ea58ef648696fb53c8fd37458c78d1352a3a623429c220eb1c2ac5f34181304d3788e1d9d6eb0e68f"} build_url:https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011296 build_url: 'https://queue.taskcluster.net/v1/task/Bg3_ZOuERsGBA1k1GNxQSA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/013b1296f651fcaf83e1bac984074ae7524c0c0c0a6612034c06466bdab5c53afcb172d7ddd5c5554d3229870e3becbf79681a3b5a2a9ebfd862b360f66491b9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dc630c45707e2e47bc1f55f9c64676510795c572ab1fac74d65b4096a6a2d770e0028a0d55592bc8188359591c780e2254cf661676ca8991e03f7904a27f7ab6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8937f19e1d84abb83854876218532f37dec083326ae148ed6dfd8eb09dc246f66536abf259ea950680bba2e80efae226465179feb719e656a14876f338534a2c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/12f576b95844e5eaea0bb5545ad45c701a3a8a6ca59d888ea58ef648696fb53c8fd37458c78d1352a3a623429c220eb1c2ac5f34181304d3788e1d9d6eb0e68f"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 17:08:45.392636) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 17:08:45.392933) ========= 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=781b77c4c33858b1f599d705000001c1-1490312862.66852-788313833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004550 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 17:08:45.445010) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 17:08:45.445360) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 17:08:45.445844) ========= ========= Total master_lag: 0.17 =========