builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-021 starttime: 1489614980.72 results: success (0) revision: ff04d410e74b69acfab17ef7e73e7397602d5a68 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-15 14:56:20.719617) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-15 14:56:20.720058) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-15 14:56:20.720350) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-15 14:56:20.735384) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 14:56:20.735797) ========= 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=df17445c3590ff7897617a0e00000225-1489614980.556820-239714012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-15 14:56:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2017-03-15 14:56:21 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.172495 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 14:56:20.922733) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 14:56:20.923251) ========= 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=df17445c3590ff7897617a0e00000225-1489614980.556820-239714012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017369 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 14:56:20.972954) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 14:56:20.973284) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ff04d410e74b69acfab17ef7e73e7397602d5a68 --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 ff04d410e74b69acfab17ef7e73e7397602d5a68 --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=df17445c3590ff7897617a0e00000225-1489614980.556820-239714012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-15 14:56:21,473 truncating revision to first 12 chars 2017-03-15 14:56:21,473 Setting DEBUG logging. 2017-03-15 14:56:21,473 attempt 1/10 2017-03-15 14:56:21,473 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ff04d410e74b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-15 14:56:22,038 unpacking tar archive at: mozilla-central-ff04d410e74b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.877364 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 14:56:21.864766) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-15 14:56:21.865118) ========= script_repo_revision: ff04d410e74b69acfab17ef7e73e7397602d5a68 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-15 14:56:21.865513) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-15 14:56:21.865781) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-15 14:56:21.874489) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-15 14:56:21.874791) ========= /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=df17445c3590ff7897617a0e00000225-1489614980.556820-239714012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:56:22 INFO - MultiFileLogger online at 20170315 14:56:22 in /builds/slave/test 14:56:22 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 14:56:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:56:22 INFO - {'append_to_log': False, 14:56:22 INFO - 'base_work_dir': '/builds/slave/test', 14:56:22 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 14:56:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:56:22 INFO - 'branch': 'Firefox-Non-PGO', 14:56:22 INFO - 'buildbot_json_path': 'buildprops.json', 14:56:22 INFO - 'config_files': ('talos/linux_config.py',), 14:56:22 INFO - 'default_actions': ('clobber', 14:56:22 INFO - 'read-buildbot-config', 14:56:22 INFO - 'download-and-extract', 14:56:22 INFO - 'populate-webroot', 14:56:22 INFO - 'create-virtualenv', 14:56:22 INFO - 'install', 14:56:22 INFO - 'run-tests'), 14:56:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:56:22 INFO - 'download_minidump_stackwalk': True, 14:56:22 INFO - 'download_symbols': 'ondemand', 14:56:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:56:22 INFO - 'tooltool.py': '/tools/tooltool.py', 14:56:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:56:22 INFO - '/tools/misc-python/virtualenv.py')}, 14:56:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:56:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:56:22 INFO - 'gecko_profile': False, 14:56:22 INFO - 'gecko_profile_interval': 0, 14:56:22 INFO - 'installer_path': 'installer.exe', 14:56:22 INFO - 'log_level': 'info', 14:56:22 INFO - 'log_name': 'talos', 14:56:22 INFO - 'log_to_console': True, 14:56:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:56:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:56:22 INFO - 'opt_config_files': (), 14:56:22 INFO - 'pip_index': False, 14:56:22 INFO - 'suite': 'dromaeojs-e10s', 14:56:22 INFO - 'system_bits': '32', 14:56:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:56:22 INFO - 'title': 'talos-linux64-ix-021', 14:56:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:56:22 INFO - 'use_talos_json': True, 14:56:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:56:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:56:22 INFO - 'work_dir': 'build'} 14:56:22 INFO - [mozharness: 2017-03-15 21:56:22.479629Z] Running clobber step. 14:56:22 INFO - Running pre-action listener: _resource_record_pre_action 14:56:22 INFO - Running main action method: clobber 14:56:22 INFO - rmtree: /builds/slave/test/build 14:56:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:56:23 INFO - Running post-action listener: _resource_record_post_action 14:56:23 INFO - [mozharness: 2017-03-15 21:56:23.429781Z] Finished clobber step (success) 14:56:23 INFO - [mozharness: 2017-03-15 21:56:23.429881Z] Running read-buildbot-config step. 14:56:23 INFO - Running pre-action listener: _resource_record_pre_action 14:56:23 INFO - Running main action method: read_buildbot_config 14:56:23 INFO - Using buildbot properties: 14:56:23 INFO - { 14:56:23 INFO - "project": "", 14:56:23 INFO - "product": "firefox", 14:56:23 INFO - "who": "kwierso@gmail.com", 14:56:23 INFO - "installer_path": "public/build/target.tar.bz2", 14:56:23 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 14:56:23 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 14:56:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 14:56:23 INFO - "stage_platform": "linux64", 14:56:23 INFO - "basedir": "/builds/slave/test", 14:56:23 INFO - "buildnumber": 466, 14:56:23 INFO - "platform": "ubuntu64_hw", 14:56:23 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:56:23 INFO - "slavebuilddir": "test", 14:56:23 INFO - "taskId": "Yc6PYlFEQwO90o_mx4RtGA", 14:56:23 INFO - "branch": "mozilla-central", 14:56:23 INFO - "script_repo_revision": "production", 14:56:23 INFO - "revision": "ff04d410e74b69acfab17ef7e73e7397602d5a68", 14:56:23 INFO - "slavename": "talos-linux64-ix-021", 14:56:23 INFO - "repo_path": "mozilla-central" 14:56:23 INFO - } 14:56:23 INFO - Finding installer, test and symbols from parent task. 14:56:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Yc6PYlFEQwO90o_mx4RtGA'}, attempt #1 14:56:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Yc6PYlFEQwO90o_mx4RtGA'}, attempt #1 14:56:24 INFO - Task dependencies: MaOVz0A5TrG585fazLri1A 14:56:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MaOVz0A5TrG585fazLri1A'}, attempt #1 14:56:24 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/MaOVz0A5TrG585fazLri1A/artifacts/public/build/target.tar.bz2 14:56:24 INFO - Set test_url: https://queue.taskcluster.net/v1/task/MaOVz0A5TrG585fazLri1A/artifacts/public/build/test_packages.json 14:56:24 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/MaOVz0A5TrG585fazLri1A/artifacts/public/build/target.crashreporter-symbols.zip 14:56:24 INFO - Running post-action listener: _resource_record_post_action 14:56:24 INFO - [mozharness: 2017-03-15 21:56:24.832914Z] Finished read-buildbot-config step (success) 14:56:24 INFO - [mozharness: 2017-03-15 21:56:24.833132Z] Running download-and-extract step. 14:56:24 INFO - Running pre-action listener: _resource_record_pre_action 14:56:24 INFO - Running main action method: download_and_extract 14:56:24 INFO - mkdir: /builds/slave/test/build/tests 14:56:24 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')]} 14:56:24 INFO - trying https://queue.taskcluster.net/v1/task/MaOVz0A5TrG585fazLri1A/artifacts/public/build/target.test_packages.json 14:56:24 INFO - Downloading https://queue.taskcluster.net/v1/task/MaOVz0A5TrG585fazLri1A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:56:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MaOVz0A5TrG585fazLri1A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:56:25 INFO - Downloaded 896 bytes. 14:56:25 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:56:25 INFO - Using the following test package requirements: 14:56:25 INFO - {u'common': [u'target.common.tests.zip'], 14:56:25 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:56:25 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:56:25 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:56:25 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:56:25 INFO - u'mozbase': [u'target.common.tests.zip'], 14:56:25 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:56:25 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:56:25 INFO - u'web-platform': [u'target.common.tests.zip', 14:56:25 INFO - u'target.web-platform.tests.zip'], 14:56:25 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:56:25 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 14:56:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MaOVz0A5TrG585fazLri1A/artifacts/public/build/target.common.tests.zip 14:56:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MaOVz0A5TrG585fazLri1A/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:56:25 INFO - Fetch https://queue.taskcluster.net/v1/task/MaOVz0A5TrG585fazLri1A/artifacts/public/build/target.common.tests.zip into memory 14:56:26 INFO - Expected file size: 58185971 14:56:26 INFO - Obtained file size: 58185971 14:56:36 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 14:56:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MaOVz0A5TrG585fazLri1A/artifacts/public/build/target.common.tests.zip 14:56:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MaOVz0A5TrG585fazLri1A/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:56:36 INFO - Fetch https://queue.taskcluster.net/v1/task/MaOVz0A5TrG585fazLri1A/artifacts/public/build/target.common.tests.zip into memory 14:56:37 INFO - Expected file size: 58185971 14:56:37 INFO - Obtained file size: 58185971 14:56:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MaOVz0A5TrG585fazLri1A/artifacts/public/build/target.talos.tests.zip 14:56:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MaOVz0A5TrG585fazLri1A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:56:48 INFO - Fetch https://queue.taskcluster.net/v1/task/MaOVz0A5TrG585fazLri1A/artifacts/public/build/target.talos.tests.zip into memory 14:56:49 INFO - Expected file size: 14404452 14:56:49 INFO - Obtained file size: 14404452 14:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:56:49 INFO - trying https://queue.taskcluster.net/v1/task/MaOVz0A5TrG585fazLri1A/artifacts/public/build/target.tar.bz2 14:56:49 INFO - Downloading https://queue.taskcluster.net/v1/task/MaOVz0A5TrG585fazLri1A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:56:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MaOVz0A5TrG585fazLri1A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:56:50 INFO - Downloaded 61708212 bytes. 14:56:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MaOVz0A5TrG585fazLri1A/artifacts/public/build/target.tar.bz2 14:56:50 INFO - mkdir: /builds/slave/test/properties 14:56:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:56:50 INFO - Writing to file /builds/slave/test/properties/build_url 14:56:50 INFO - Contents: 14:56:50 INFO - build_url:https://queue.taskcluster.net/v1/task/MaOVz0A5TrG585fazLri1A/artifacts/public/build/target.tar.bz2 14:56:50 INFO - Running post-action listener: _resource_record_post_action 14:56:50 INFO - Running post-action listener: set_extra_try_arguments 14:56:50 INFO - [mozharness: 2017-03-15 21:56:50.610340Z] Finished download-and-extract step (success) 14:56:50 INFO - [mozharness: 2017-03-15 21:56:50.610436Z] Running populate-webroot step. 14:56:50 INFO - Running pre-action listener: _resource_record_pre_action 14:56:50 INFO - Running main action method: populate_webroot 14:56:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:56:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:56:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:56:50 INFO - '--tppagecycles', 14:56:50 INFO - '7'], 14:56:50 INFO - 'tests': ['tsvgm']}}, 14:56:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:56:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:56:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:56:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:56:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:56:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:56:50 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:56:50 INFO - 'talos_options': ['--disable-e10s'], 14:56:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:56:50 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:56:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:56:50 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:56:50 INFO - 'talos_options': ['--disable-e10s'], 14:56:50 INFO - 'tests': ['damp', 'tps']}, 14:56:50 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:56:50 INFO - 'tests': ['damp', 'tps']}, 14:56:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:56:50 INFO - 'tests': ['dromaeo_dom']}, 14:56:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:56:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:56:50 INFO - 'tests': ['basic_compositor_video']}, 14:56:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:56:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:56:50 INFO - 'tests': ['a11yr', 14:56:50 INFO - 'ts_paint', 14:56:50 INFO - 'tpaint', 14:56:50 INFO - 'sessionrestore', 14:56:50 INFO - 'sessionrestore_no_auto_restore', 14:56:50 INFO - 'tabpaint']}, 14:56:50 INFO - 'other-e10s': {'tests': ['a11yr', 14:56:50 INFO - 'ts_paint', 14:56:50 INFO - 'tpaint', 14:56:50 INFO - 'sessionrestore', 14:56:50 INFO - 'sessionrestore_no_auto_restore', 14:56:50 INFO - 'tabpaint']}, 14:56:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:56:50 INFO - 'ts_paint', 14:56:50 INFO - 'tpaint', 14:56:50 INFO - 'sessionrestore', 14:56:50 INFO - 'sessionrestore_no_auto_restore', 14:56:50 INFO - 'tabpaint']}, 14:56:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:56:50 INFO - 'ts_paint', 14:56:50 INFO - 'tpaint', 14:56:50 INFO - 'sessionrestore', 14:56:50 INFO - 'sessionrestore_no_auto_restore', 14:56:50 INFO - 'tabpaint']}, 14:56:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:56:50 INFO - 'tests': ['a11yr', 14:56:50 INFO - 'ts_paint', 14:56:50 INFO - 'tpaint', 14:56:50 INFO - 'sessionrestore', 14:56:50 INFO - 'sessionrestore_no_auto_restore', 14:56:50 INFO - 'tabpaint']}, 14:56:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:56:50 INFO - 'tests': ['a11yr', 14:56:50 INFO - 'ts_paint', 14:56:50 INFO - 'tpaint', 14:56:50 INFO - 'sessionrestore', 14:56:50 INFO - 'sessionrestore_no_auto_restore', 14:56:50 INFO - 'tabpaint']}, 14:56:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:56:50 INFO - 'tests': ['tsvgx', 14:56:50 INFO - 'tsvgr_opacity', 14:56:50 INFO - 'tart', 14:56:50 INFO - 'tscrollx', 14:56:50 INFO - 'cart', 14:56:50 INFO - 'tsvg_static']}, 14:56:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:56:50 INFO - 'tsvgr_opacity', 14:56:50 INFO - 'tart', 14:56:50 INFO - 'tscrollx', 14:56:50 INFO - 'cart', 14:56:50 INFO - 'tsvg_static']}, 14:56:50 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:56:50 INFO - 'talos_options': ['--disable-e10s'], 14:56:50 INFO - 'tests': ['tp5o']}, 14:56:50 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:56:50 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:56:50 INFO - 'talos_options': ['--disable-e10s', 14:56:50 INFO - '--xperf_path', 14:56:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:56:50 INFO - 'tests': ['tp5n']}, 14:56:50 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:56:50 INFO - 'talos_options': ['--xperf_path', 14:56:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:56:50 INFO - 'tests': ['tp5n']}}, 14:56:50 INFO - 'talos.zip': {'path': '', 14:56:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:56:50 INFO - Running post-action listener: _resource_record_post_action 14:56:50 INFO - [mozharness: 2017-03-15 21:56:50.623507Z] Finished populate-webroot step (success) 14:56:50 INFO - [mozharness: 2017-03-15 21:56:50.623597Z] Running create-virtualenv step. 14:56:50 INFO - Running pre-action listener: _resource_record_pre_action 14:56:50 INFO - Running main action method: create_virtualenv 14:56:50 INFO - Creating virtualenv /builds/slave/test/build/venv 14:56:50 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 14:56:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:56:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:56:50 INFO - Using real prefix '/usr' 14:56:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:56:51 INFO - Installing distribute.............................................................................................................................................................................................done. 14:56:53 INFO - Installing pip.................done. 14:56:53 INFO - Return code: 0 14:56:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:56:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:56:53 INFO - Reading from file tmpfile_stdout 14:56:53 INFO - Output received: 14:56:53 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) 14:56:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:56:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:56:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:56:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23dda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2582b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2580290>, '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 0x2580b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2581040>, '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': 'df17445c3590ff7897617a0e00000225-1489614980.556820-239714012', '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 14:56:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:56:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:56:53 INFO - Using env: {'DISPLAY': ':0', 14:56:53 INFO - 'HOME': '/home/cltbld', 14:56:53 INFO - 'LANG': 'en_US.UTF-8', 14:56:53 INFO - 'LANGUAGE': 'en_US:en', 14:56:53 INFO - 'LOGNAME': 'cltbld', 14:56:53 INFO - 'MAIL': '/var/mail/cltbld', 14:56:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:53 INFO - 'MOZ_NO_REMOTE': '1', 14:56:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:56:53 INFO - 'NO_EM_RESTART': '1', 14:56:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:56:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:53 INFO - 'PWD': '/builds/slave/test', 14:56:53 INFO - 'SHELL': '/bin/bash', 14:56:53 INFO - 'SHLVL': '1', 14:56:53 INFO - 'TERM': 'linux', 14:56:53 INFO - 'TMOUT': '86400', 14:56:53 INFO - 'USER': 'cltbld', 14:56:53 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1489614980.556820-239714012', 14:56:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:53 INFO - '_': '/tools/buildbot/bin/python'} 14:56:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:56:53 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 14:56:53 INFO - Cleaning up... 14:56:53 INFO - Return code: 0 14:56:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:56:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:56:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:56:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x22e51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23dda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2582b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2580290>, '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 0x2580b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2581040>, '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': 'df17445c3590ff7897617a0e00000225-1489614980.556820-239714012', '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 14:56:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:56:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:56:53 INFO - Using env: {'DISPLAY': ':0', 14:56:53 INFO - 'HOME': '/home/cltbld', 14:56:53 INFO - 'LANG': 'en_US.UTF-8', 14:56:53 INFO - 'LANGUAGE': 'en_US:en', 14:56:53 INFO - 'LOGNAME': 'cltbld', 14:56:53 INFO - 'MAIL': '/var/mail/cltbld', 14:56:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:53 INFO - 'MOZ_NO_REMOTE': '1', 14:56:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:56:53 INFO - 'NO_EM_RESTART': '1', 14:56:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:56:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:53 INFO - 'PWD': '/builds/slave/test', 14:56:53 INFO - 'SHELL': '/bin/bash', 14:56:53 INFO - 'SHLVL': '1', 14:56:53 INFO - 'TERM': 'linux', 14:56:53 INFO - 'TMOUT': '86400', 14:56:53 INFO - 'USER': 'cltbld', 14:56:53 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1489614980.556820-239714012', 14:56:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:53 INFO - '_': '/tools/buildbot/bin/python'} 14:56:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:56:54 INFO - Downloading/unpacking psutil>=3.1.1 14:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:56:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:56:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:56:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:56:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:56:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:56:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:56:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:56:56 INFO - Installing collected packages: psutil 14:56:56 INFO - Running setup.py install for psutil 14:56:56 INFO - building 'psutil._psutil_linux' extension 14:56:56 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 14:56:56 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 14:56:56 INFO - building 'psutil._psutil_posix' extension 14:56:56 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 14:56:56 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 14:56:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:56:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:56:56 INFO - Successfully installed psutil 14:56:56 INFO - Cleaning up... 14:56:56 INFO - Return code: 0 14:56:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:56:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:56:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:56:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23dda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2582b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2580290>, '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 0x2580b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2581040>, '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': 'df17445c3590ff7897617a0e00000225-1489614980.556820-239714012', '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 14:56:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:56:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:56:56 INFO - Using env: {'DISPLAY': ':0', 14:56:56 INFO - 'HOME': '/home/cltbld', 14:56:56 INFO - 'LANG': 'en_US.UTF-8', 14:56:56 INFO - 'LANGUAGE': 'en_US:en', 14:56:56 INFO - 'LOGNAME': 'cltbld', 14:56:56 INFO - 'MAIL': '/var/mail/cltbld', 14:56:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:56 INFO - 'MOZ_NO_REMOTE': '1', 14:56:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:56:56 INFO - 'NO_EM_RESTART': '1', 14:56:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:56:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:56 INFO - 'PWD': '/builds/slave/test', 14:56:56 INFO - 'SHELL': '/bin/bash', 14:56:56 INFO - 'SHLVL': '1', 14:56:56 INFO - 'TERM': 'linux', 14:56:56 INFO - 'TMOUT': '86400', 14:56:56 INFO - 'USER': 'cltbld', 14:56:56 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1489614980.556820-239714012', 14:56:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:56 INFO - '_': '/tools/buildbot/bin/python'} 14:56:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:56:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:56:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:56:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:56:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:56:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:56:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:56:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:56:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:56:59 INFO - Installing collected packages: mozsystemmonitor 14:56:59 INFO - Running setup.py install for mozsystemmonitor 14:56:59 INFO - Successfully installed mozsystemmonitor 14:56:59 INFO - Cleaning up... 14:56:59 INFO - Return code: 0 14:56:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:56:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:56:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:56:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:56:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:59 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 0x22e51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23dda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2582b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2580290>, '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 0x2580b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2581040>, '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': 'df17445c3590ff7897617a0e00000225-1489614980.556820-239714012', '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 14:56:59 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 14:56:59 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 14:56:59 INFO - Using env: {'DISPLAY': ':0', 14:56:59 INFO - 'HOME': '/home/cltbld', 14:56:59 INFO - 'LANG': 'en_US.UTF-8', 14:56:59 INFO - 'LANGUAGE': 'en_US:en', 14:56:59 INFO - 'LOGNAME': 'cltbld', 14:56:59 INFO - 'MAIL': '/var/mail/cltbld', 14:56:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:59 INFO - 'MOZ_NO_REMOTE': '1', 14:56:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:56:59 INFO - 'NO_EM_RESTART': '1', 14:56:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:56:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:59 INFO - 'PWD': '/builds/slave/test', 14:56:59 INFO - 'SHELL': '/bin/bash', 14:56:59 INFO - 'SHLVL': '1', 14:56:59 INFO - 'TERM': 'linux', 14:56:59 INFO - 'TMOUT': '86400', 14:56:59 INFO - 'USER': 'cltbld', 14:56:59 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1489614980.556820-239714012', 14:56:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:59 INFO - '_': '/tools/buildbot/bin/python'} 14:56:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:56:59 INFO - Downloading/unpacking jsonschema==2.5.1 14:56:59 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 14:56:59 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 14:56:59 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 14:56:59 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 14:56:59 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 14:56:59 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 14:57:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:57:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:01 INFO - Downloading functools32-3.2.3-2.tar.gz 14:57:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:57:01 INFO - warning: no files found matching '*.txt' 14:57:01 INFO - no previously-included directories found matching 'build' 14:57:01 INFO - no previously-included directories found matching 'dist' 14:57:01 INFO - no previously-included directories found matching '.git*' 14:57:01 INFO - Installing collected packages: jsonschema, functools32 14:57:01 INFO - Running setup.py install for functools32 14:57:01 INFO - warning: no files found matching '*.txt' 14:57:01 INFO - no previously-included directories found matching 'build' 14:57:01 INFO - no previously-included directories found matching 'dist' 14:57:01 INFO - no previously-included directories found matching '.git*' 14:57:01 INFO - Successfully installed jsonschema functools32 14:57:01 INFO - Cleaning up... 14:57:01 INFO - Return code: 0 14:57:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:57:01 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')]} 14:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:01 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')]} 14:57:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:01 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 0x22e51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23dda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2582b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2580290>, '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 0x2580b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2581040>, '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': 'df17445c3590ff7897617a0e00000225-1489614980.556820-239714012', '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 14:57:01 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 14:57:01 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 14:57:01 INFO - Using env: {'DISPLAY': ':0', 14:57:01 INFO - 'HOME': '/home/cltbld', 14:57:01 INFO - 'LANG': 'en_US.UTF-8', 14:57:01 INFO - 'LANGUAGE': 'en_US:en', 14:57:01 INFO - 'LOGNAME': 'cltbld', 14:57:01 INFO - 'MAIL': '/var/mail/cltbld', 14:57:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:01 INFO - 'MOZ_NO_REMOTE': '1', 14:57:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:01 INFO - 'NO_EM_RESTART': '1', 14:57:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:01 INFO - 'PWD': '/builds/slave/test', 14:57:01 INFO - 'SHELL': '/bin/bash', 14:57:01 INFO - 'SHLVL': '1', 14:57:01 INFO - 'TERM': 'linux', 14:57:01 INFO - 'TMOUT': '86400', 14:57:01 INFO - 'USER': 'cltbld', 14:57:01 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1489614980.556820-239714012', 14:57:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:01 INFO - '_': '/tools/buildbot/bin/python'} 14:57:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:57:02 INFO - Cleaning up... 14:57:02 INFO - Return code: 0 14:57:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:57:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:02 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 0x22e51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23dda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2582b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2580290>, '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 0x2580b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2581040>, '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': 'df17445c3590ff7897617a0e00000225-1489614980.556820-239714012', '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 14:57:02 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 14:57:02 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 14:57:02 INFO - Using env: {'DISPLAY': ':0', 14:57:02 INFO - 'HOME': '/home/cltbld', 14:57:02 INFO - 'LANG': 'en_US.UTF-8', 14:57:02 INFO - 'LANGUAGE': 'en_US:en', 14:57:02 INFO - 'LOGNAME': 'cltbld', 14:57:02 INFO - 'MAIL': '/var/mail/cltbld', 14:57:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:02 INFO - 'MOZ_NO_REMOTE': '1', 14:57:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:02 INFO - 'NO_EM_RESTART': '1', 14:57:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:02 INFO - 'PWD': '/builds/slave/test', 14:57:02 INFO - 'SHELL': '/bin/bash', 14:57:02 INFO - 'SHLVL': '1', 14:57:02 INFO - 'TERM': 'linux', 14:57:02 INFO - 'TMOUT': '86400', 14:57:02 INFO - 'USER': 'cltbld', 14:57:02 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1489614980.556820-239714012', 14:57:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:02 INFO - '_': '/tools/buildbot/bin/python'} 14:57:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:02 INFO - Downloading/unpacking blobuploader==1.2.4 14:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:04 INFO - Downloading blobuploader-1.2.4.tar.gz 14:57:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:57:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:57:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:05 INFO - Downloading docopt-0.6.1.tar.gz 14:57:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:57:05 INFO - Installing collected packages: blobuploader, requests, docopt 14:57:05 INFO - Running setup.py install for blobuploader 14:57:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:57:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:57:05 INFO - Running setup.py install for requests 14:57:05 INFO - Running setup.py install for docopt 14:57:05 INFO - Successfully installed blobuploader requests docopt 14:57:05 INFO - Cleaning up... 14:57:05 INFO - Return code: 0 14:57:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:57:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:57:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:05 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 0x22e51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23dda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2582b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2580290>, '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 0x2580b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2581040>, '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': 'df17445c3590ff7897617a0e00000225-1489614980.556820-239714012', '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 14:57:05 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 14:57:05 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 14:57:05 INFO - Using env: {'DISPLAY': ':0', 14:57:05 INFO - 'HOME': '/home/cltbld', 14:57:05 INFO - 'LANG': 'en_US.UTF-8', 14:57:05 INFO - 'LANGUAGE': 'en_US:en', 14:57:05 INFO - 'LOGNAME': 'cltbld', 14:57:05 INFO - 'MAIL': '/var/mail/cltbld', 14:57:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:05 INFO - 'MOZ_NO_REMOTE': '1', 14:57:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:05 INFO - 'NO_EM_RESTART': '1', 14:57:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:05 INFO - 'PWD': '/builds/slave/test', 14:57:05 INFO - 'SHELL': '/bin/bash', 14:57:05 INFO - 'SHLVL': '1', 14:57:05 INFO - 'TERM': 'linux', 14:57:05 INFO - 'TMOUT': '86400', 14:57:05 INFO - 'USER': 'cltbld', 14:57:05 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1489614980.556820-239714012', 14:57:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:05 INFO - '_': '/tools/buildbot/bin/python'} 14:57:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:57:06 INFO - Running setup.py (path:/tmp/pip-Zs_WeN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:57:06 INFO - Running setup.py (path:/tmp/pip-b2aWMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:57:06 INFO - Running setup.py (path:/tmp/pip-PixLDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:57:06 INFO - Running setup.py (path:/tmp/pip-URLxeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:57:06 INFO - Running setup.py (path:/tmp/pip-JBvyp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:57:06 INFO - Running setup.py (path:/tmp/pip-mE6mPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:57:06 INFO - Running setup.py (path:/tmp/pip-nHZ18U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:57:06 INFO - Running setup.py (path:/tmp/pip-PIu9Gn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:57:06 INFO - Running setup.py (path:/tmp/pip-YtmTPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:57:06 INFO - Running setup.py (path:/tmp/pip-yU1Ugt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:57:06 INFO - Running setup.py (path:/tmp/pip-Qd3JUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:57:06 INFO - Running setup.py (path:/tmp/pip-WjUqsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:57:06 INFO - Running setup.py (path:/tmp/pip-L5V1yo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:57:07 INFO - Running setup.py (path:/tmp/pip-jJKb9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:57:07 INFO - Running setup.py (path:/tmp/pip-fqqClK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:57:07 INFO - Running setup.py (path:/tmp/pip-N5AMyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:57:07 INFO - Running setup.py (path:/tmp/pip-_wZj6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:57:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:57:07 INFO - Running setup.py install for manifestparser 14:57:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:57:07 INFO - Running setup.py install for mozcrash 14:57:07 INFO - Running setup.py install for mozdebug 14:57:07 INFO - Running setup.py install for mozdevice 14:57:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:57:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:57:07 INFO - Running setup.py install for mozfile 14:57:07 INFO - Running setup.py install for mozhttpd 14:57:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:57:07 INFO - Running setup.py install for mozinfo 14:57:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:57:07 INFO - Running setup.py install for mozInstall 14:57:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:57:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:57:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:57:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:57:08 INFO - Running setup.py install for mozleak 14:57:08 INFO - Running setup.py install for mozlog 14:57:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:57:08 INFO - Running setup.py install for moznetwork 14:57:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:57:08 INFO - Running setup.py install for mozprocess 14:57:08 INFO - Running setup.py install for mozprofile 14:57:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:57:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:57:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:57:08 INFO - Running setup.py install for mozrunner 14:57:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:57:08 INFO - Running setup.py install for mozscreenshot 14:57:08 INFO - Running setup.py install for moztest 14:57:08 INFO - Running setup.py install for mozversion 14:57:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:57:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:57:09 INFO - Cleaning up... 14:57:09 INFO - Return code: 0 14:57:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:57:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:57:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:09 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 0x22e51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23dda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2582b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2580290>, '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 0x2580b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2581040>, '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': 'df17445c3590ff7897617a0e00000225-1489614980.556820-239714012', '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 14:57:09 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 14:57:09 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 14:57:09 INFO - Using env: {'DISPLAY': ':0', 14:57:09 INFO - 'HOME': '/home/cltbld', 14:57:09 INFO - 'LANG': 'en_US.UTF-8', 14:57:09 INFO - 'LANGUAGE': 'en_US:en', 14:57:09 INFO - 'LOGNAME': 'cltbld', 14:57:09 INFO - 'MAIL': '/var/mail/cltbld', 14:57:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:09 INFO - 'MOZ_NO_REMOTE': '1', 14:57:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:09 INFO - 'NO_EM_RESTART': '1', 14:57:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:09 INFO - 'PWD': '/builds/slave/test', 14:57:09 INFO - 'SHELL': '/bin/bash', 14:57:09 INFO - 'SHLVL': '1', 14:57:09 INFO - 'TERM': 'linux', 14:57:09 INFO - 'TMOUT': '86400', 14:57:09 INFO - 'USER': 'cltbld', 14:57:09 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1489614980.556820-239714012', 14:57:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:09 INFO - '_': '/tools/buildbot/bin/python'} 14:57:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:57:09 INFO - Running setup.py (path:/tmp/pip-az2Sxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:57:09 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)) 14:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:57:09 INFO - Running setup.py (path:/tmp/pip-VWq9ef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:57:09 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)) 14:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:57:09 INFO - Running setup.py (path:/tmp/pip-oE1EfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:57:09 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)) 14:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:57:09 INFO - Running setup.py (path:/tmp/pip-82Av7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:57:09 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)) 14:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:57:09 INFO - Running setup.py (path:/tmp/pip-6tY7Dl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:57:09 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)) 14:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:57:09 INFO - Running setup.py (path:/tmp/pip-0nusy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:57:09 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)) 14:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:57:09 INFO - Running setup.py (path:/tmp/pip-fyXtdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:57:09 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)) 14:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:57:09 INFO - Running setup.py (path:/tmp/pip-JeCSrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:57:09 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)) 14:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:57:09 INFO - Running setup.py (path:/tmp/pip-RhH5jf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:57:09 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)) 14:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:57:09 INFO - Running setup.py (path:/tmp/pip-GLXIz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:57:10 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)) 14:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:57:10 INFO - Running setup.py (path:/tmp/pip-36Mibg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:57:10 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)) 14:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:57:10 INFO - Running setup.py (path:/tmp/pip-HEOBiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:57:10 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)) 14:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:57:10 INFO - Running setup.py (path:/tmp/pip-avCOJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:57:10 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)) 14:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:57:10 INFO - Running setup.py (path:/tmp/pip-hvE82V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:57:10 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)) 14:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:57:10 INFO - Running setup.py (path:/tmp/pip-Q7mDNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:57:10 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)) 14:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:57:10 INFO - Running setup.py (path:/tmp/pip-iP3wkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:57:10 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)) 14:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:57:10 INFO - Running setup.py (path:/tmp/pip-5QlGvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:57:10 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)) 14:57:10 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)) 14:57:10 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)) 14:57:10 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)) 14:57:10 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)) 14:57:10 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)) 14:57:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:12 INFO - Downloading blessings-1.6.tar.gz 14:57:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:57:12 INFO - Installing collected packages: blessings 14:57:12 INFO - Running setup.py install for blessings 14:57:12 INFO - Successfully installed blessings 14:57:12 INFO - Cleaning up... 14:57:12 INFO - Return code: 0 14:57:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:57:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:57:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:57:13 INFO - Reading from file tmpfile_stdout 14:57:13 INFO - Current package versions: 14:57:13 INFO - argparse == 1.2.1 14:57:13 INFO - blessings == 1.6 14:57:13 INFO - blobuploader == 1.2.4 14:57:13 INFO - docopt == 0.6.1 14:57:13 INFO - functools32 == 3.2.3-2 14:57:13 INFO - jsonschema == 2.5.1 14:57:13 INFO - manifestparser == 1.1 14:57:13 INFO - mozInstall == 1.12 14:57:13 INFO - mozcrash == 1.0 14:57:13 INFO - mozdebug == 0.1 14:57:13 INFO - mozdevice == 0.49 14:57:13 INFO - mozfile == 1.2 14:57:13 INFO - mozhttpd == 0.7 14:57:13 INFO - mozinfo == 0.9 14:57:13 INFO - mozleak == 0.1 14:57:13 INFO - mozlog == 3.4 14:57:13 INFO - moznetwork == 0.27 14:57:13 INFO - mozprocess == 0.25 14:57:13 INFO - mozprofile == 0.28 14:57:13 INFO - mozrunner == 6.13 14:57:13 INFO - mozscreenshot == 0.1 14:57:13 INFO - mozsystemmonitor == 0.3 14:57:13 INFO - moztest == 0.8 14:57:13 INFO - mozversion == 1.4 14:57:13 INFO - psutil == 3.1.1 14:57:13 INFO - requests == 1.2.3 14:57:13 INFO - wsgiref == 0.1.2 14:57:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:57:13 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')]} 14:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:13 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')]} 14:57:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:13 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 0x22e51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23dda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2582b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2580290>, '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 0x2580b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2581040>, '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': 'df17445c3590ff7897617a0e00000225-1489614980.556820-239714012', '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 14:57:13 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 14:57:13 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 14:57:13 INFO - Using env: {'DISPLAY': ':0', 14:57:13 INFO - 'HOME': '/home/cltbld', 14:57:13 INFO - 'LANG': 'en_US.UTF-8', 14:57:13 INFO - 'LANGUAGE': 'en_US:en', 14:57:13 INFO - 'LOGNAME': 'cltbld', 14:57:13 INFO - 'MAIL': '/var/mail/cltbld', 14:57:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:13 INFO - 'MOZ_NO_REMOTE': '1', 14:57:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:13 INFO - 'NO_EM_RESTART': '1', 14:57:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:13 INFO - 'PWD': '/builds/slave/test', 14:57:13 INFO - 'SHELL': '/bin/bash', 14:57:13 INFO - 'SHLVL': '1', 14:57:13 INFO - 'TERM': 'linux', 14:57:13 INFO - 'TMOUT': '86400', 14:57:13 INFO - 'USER': 'cltbld', 14:57:13 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1489614980.556820-239714012', 14:57:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:13 INFO - '_': '/tools/buildbot/bin/python'} 14:57:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:13 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)) 14:57:13 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)) 14:57:13 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)) 14:57:13 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)) 14:57:13 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)) 14:57:13 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)) 14:57:13 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)) 14:57:13 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)) 14:57:13 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)) 14:57:13 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)) 14:57:13 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)) 14:57:13 INFO - Cleaning up... 14:57:13 INFO - Return code: 0 14:57:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:57:13 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')]} 14:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:13 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')]} 14:57:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:13 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 0x22e51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23dda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2582b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2580290>, '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 0x2580b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2581040>, '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': 'df17445c3590ff7897617a0e00000225-1489614980.556820-239714012', '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 14:57:13 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 14:57:13 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 14:57:13 INFO - Using env: {'DISPLAY': ':0', 14:57:13 INFO - 'HOME': '/home/cltbld', 14:57:13 INFO - 'LANG': 'en_US.UTF-8', 14:57:13 INFO - 'LANGUAGE': 'en_US:en', 14:57:13 INFO - 'LOGNAME': 'cltbld', 14:57:13 INFO - 'MAIL': '/var/mail/cltbld', 14:57:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:13 INFO - 'MOZ_NO_REMOTE': '1', 14:57:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:13 INFO - 'NO_EM_RESTART': '1', 14:57:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:13 INFO - 'PWD': '/builds/slave/test', 14:57:13 INFO - 'SHELL': '/bin/bash', 14:57:13 INFO - 'SHLVL': '1', 14:57:13 INFO - 'TERM': 'linux', 14:57:13 INFO - 'TMOUT': '86400', 14:57:13 INFO - 'USER': 'cltbld', 14:57:13 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1489614980.556820-239714012', 14:57:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:13 INFO - '_': '/tools/buildbot/bin/python'} 14:57:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:57:13 INFO - Cleaning up... 14:57:13 INFO - Return code: 0 14:57:13 INFO - Running post-action listener: _resource_record_post_action 14:57:13 INFO - Running post-action listener: _start_resource_monitoring 14:57:13 INFO - Starting resource monitoring. 14:57:13 INFO - [mozharness: 2017-03-15 21:57:13.545650Z] Finished create-virtualenv step (success) 14:57:13 INFO - [mozharness: 2017-03-15 21:57:13.546167Z] Running install step. 14:57:13 INFO - Running pre-action listener: _resource_record_pre_action 14:57:13 INFO - Running main action method: install 14:57:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:57:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:57:13 INFO - Reading from file tmpfile_stdout 14:57:13 INFO - Detecting whether we're running mozinstall >=1.0... 14:57:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:57:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:57:13 INFO - Reading from file tmpfile_stdout 14:57:13 INFO - Output received: 14:57:13 INFO - Usage: mozinstall [options] installer 14:57:13 INFO - Options: 14:57:13 INFO - -h, --help show this help message and exit 14:57:13 INFO - -d DEST, --destination=DEST 14:57:13 INFO - Directory to install application into. [default: 14:57:13 INFO - "/builds/slave/test"] 14:57:13 INFO - --app=APP Application being installed. [default: firefox] 14:57:13 INFO - mkdir: /builds/slave/test/build/application 14:57:13 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'] 14:57:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:57:29 INFO - Reading from file tmpfile_stdout 14:57:29 INFO - Output received: 14:57:29 INFO - /builds/slave/test/build/application/firefox/firefox 14:57:29 INFO - Running post-action listener: _resource_record_post_action 14:57:29 INFO - [mozharness: 2017-03-15 21:57:29.255678Z] Finished install step (success) 14:57:29 INFO - [mozharness: 2017-03-15 21:57:29.255956Z] Running run-tests step. 14:57:29 INFO - Running pre-action listener: _resource_record_pre_action 14:57:29 INFO - Running main action method: run_tests 14:57:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:57:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:57:29 INFO - Python 2.7.3 14:57:29 INFO - Return code: 0 14:57:29 INFO - grabbing minidump binary from tooltool 14:57:29 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')]} 14:57:29 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 0x2580290>, '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 0x2580b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2581040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:57:29 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 14:57:29 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 14:57:29 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 14:57:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:57:29 INFO - Return code: 0 14:57:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:57:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:57:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:57:29 INFO - ENV: RUST_BACKTRACE is now 1 14:57:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:57:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:57:29 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/MaOVz0A5TrG585fazLri1A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 14:57:29 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/MaOVz0A5TrG585fazLri1A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 14:57:29 INFO - Using env: {'DISPLAY': ':0', 14:57:29 INFO - 'HOME': '/home/cltbld', 14:57:29 INFO - 'LANG': 'en_US.UTF-8', 14:57:29 INFO - 'LANGUAGE': 'en_US:en', 14:57:29 INFO - 'LOGNAME': 'cltbld', 14:57:29 INFO - 'MAIL': '/var/mail/cltbld', 14:57:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:57:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:57:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:29 INFO - 'MOZ_NO_REMOTE': '1', 14:57:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:57:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:29 INFO - 'NO_EM_RESTART': '1', 14:57:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:29 INFO - 'PWD': '/builds/slave/test', 14:57:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:57:29 INFO - 'RUST_BACKTRACE': '1', 14:57:29 INFO - 'SHELL': '/bin/bash', 14:57:29 INFO - 'SHLVL': '1', 14:57:29 INFO - 'TERM': 'linux', 14:57:29 INFO - 'TMOUT': '86400', 14:57:29 INFO - 'USER': 'cltbld', 14:57:29 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1489614980.556820-239714012', 14:57:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:29 INFO - '_': '/tools/buildbot/bin/python'} 14:57:29 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/MaOVz0A5TrG585fazLri1A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 14:57:29 INFO - mozversion application_buildid: 20170315212515 14:57:29 INFO - mozversion application_changeset: ff04d410e74b69acfab17ef7e73e7397602d5a68 14:57:29 INFO - mozversion application_display_name: Nightly 14:57:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:57:29 INFO - mozversion application_name: Firefox 14:57:29 INFO - mozversion application_remotingname: firefox 14:57:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:57:29 INFO - mozversion application_vendor: Mozilla 14:57:29 INFO - mozversion application_version: 55.0a1 14:57:29 INFO - mozversion platform_buildid: 20170315212515 14:57:29 INFO - mozversion platform_changeset: ff04d410e74b69acfab17ef7e73e7397602d5a68 14:57:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:57:29 INFO - mozversion platform_version: 55.0a1 14:57:29 INFO - using testdate: 1489615049 14:57:29 INFO - actual date: 1489615049 14:57:29 INFO - starting webserver on 'localhost:47080' 14:57:29 INFO - SUITE-START | Running 2 tests 14:57:29 INFO - TEST-START | dromaeo_css 14:57:29 INFO - operating with platform_type : linux_ 14:57:29 INFO - Initialising browser for dromaeo_css test... 14:57:29 INFO - TEST-INFO | started process 10505 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ1OaLA/profile http://localhost:47080/getInfo.html) 14:57:34 INFO - PID 10505 | __metrics Screen width/height:1600/1200 14:57:34 INFO - PID 10505 | colorDepth:24 14:57:34 INFO - PID 10505 | Browser inner width/height: 1024/697 14:57:34 INFO - PID 10505 | __metrics 14:57:35 ERROR - PID 10505 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 14:57:36 INFO - TEST-INFO | 10505: exit 0 14:57:36 INFO - Browser initialized. 14:57:36 INFO - Running cycle 1/1 for dromaeo_css test... 14:57:36 INFO - TEST-INFO | started process 10638 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ1OaLA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:57:48 INFO - PID 10638 | RSS: Main: 155234304 14:57:48 INFO - PID 10638 | 15:00:53 INFO - PID 10638 | Cycle 1(1): loaded http://localhost:47080/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47080/tests/dromaeo/cssquery-ext.html) 15:00:54 INFO - PID 10638 | RSS: Main: 165695488 15:00:54 INFO - PID 10638 | 15:02:37 INFO - PID 10638 | ************************* 15:02:37 INFO - PID 10638 | A coding exception was thrown and uncaught in a Task. 15:02:37 INFO - PID 10638 | 15:02:37 ERROR - PID 10638 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:02:37 INFO - PID 10638 | Full stack: 15:02:37 INFO - PID 10638 | ************************* 15:03:57 INFO - PID 10638 | Cycle 1(1): loaded http://localhost:47080/tests/dromaeo/cssquery-ext.html (next: http://localhost:47080/tests/dromaeo/cssquery-jquery.html) 15:03:57 INFO - PID 10638 | RSS: Main: 160358400 15:03:57 INFO - PID 10638 | 15:06:59 INFO - PID 10638 | Cycle 1(1): loaded http://localhost:47080/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47080/tests/dromaeo/cssquery-mootools.html) 15:07:00 INFO - PID 10638 | RSS: Main: 168460288 15:07:00 INFO - PID 10638 | 15:10:02 INFO - PID 10638 | Cycle 1(1): loaded http://localhost:47080/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47080/tests/dromaeo/cssquery-prototype.html) 15:10:02 INFO - PID 10638 | RSS: Main: 161005568 15:10:02 INFO - PID 10638 | 15:13:05 INFO - PID 10638 | Cycle 1(1): loaded http://localhost:47080/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47080/tests/dromaeo/cssquery-yui.html) 15:13:06 INFO - PID 10638 | RSS: Main: 167890944 15:13:06 INFO - PID 10638 | 15:16:09 INFO - PID 10638 | Cycle 1(1): loaded http://localhost:47080/tests/dromaeo/cssquery-yui.html (next: http://localhost:47080/tests/dromaeo/cssquery-dojo.html) 15:16:09 INFO - PID 10638 | RSS: Main: 162545664 15:16:09 INFO - PID 10638 | 15:16:09 INFO - PID 10638 | __start_tp_report 15:16:09 INFO - PID 10638 | _x_x_mozilla_page_load 15:16:09 INFO - PID 10638 | _x_x_mozilla_page_load_details 15:16:09 INFO - PID 10638 | |i|pagename|runs| 15:16:09 INFO - PID 10638 | |0;dojo.html;2674.6477116847486;2685.7985651076174;2694.1782756259345;2718.660167479065;2728.31792051987;4888.706677599346;4949.084419382412;5028.446870844209;5043.621728370378;5074.2895994560795;5001.874953126174;5027.899442011167;5035.647504674675;5038.118329292368;5087.364079490064;4616.2613981762925;4664.97667511662;4666.650001249903;4669.6731228814;4694.342792009122;4648.325992731052;4676.929846052312;4677.415323084614;4688.367070445497;4733.124371991193;4528.773561321921;4556.179887620227;4577.29051996941;4630.236011058171;4649.325847752057;4635.0729854029;4637.698549594265;4644;4668.486466488684;4683.765811709435;4554.954450455486;4607.723536587782;4615.976920115378;4620.630349572026;4659.883502912454;4909.337239472661;4927.581155601778;4946.530079642464;4988.326575912241;5008.449070602267;5322.65402748824;5334.413214546396;5360.973195133999;5375.865603359908;5436.891262174734;5412.9458705412835;5415.972920135414;5422.40353561108;5433.8369848904595;5487.259220005328;4894.437139728977;4930.11257973561;4948.975255123773;5050.74746262689;5073.847784566469;5400.21696853954;5430.266913966564;5439.238506609078;5442.537384322298;5444.91832622511;5160.716160611202;5308.23030660552;5329.733513324319;5342.439043900335;5363.356397232357;5263.0000299942885;5381.515663590296;5392.191171324333;5394.163904594794;5395.05586522357;5273.841784746463;5300.814471493479;5315.867103322448;5331.893362132736;5391.7304134793885;5201.713905735145;5228.686278823283;5316.680999140064;5324.946750532445;5351.036813373552;4508.413906192174;4540.046590216026;4548.772561371984;4548.818047278071;4574.428196475441;3897.1231472918935;3952.110775075585;3956.643902048829;3980.283548961157;3983;4598;4641.327007583882;4676.0647870426055;4691.108689349013;4697.95302046982;5455.454454554513;5465.863353416196;5471.452854714496;5474.124140137559;5495.0383682855345;4687.484376718558;4693.131770622445;4704.95295047052;4722.811087556528;4763.666543342002;4723.126221649006;4727.881802954954;4753.786079626425;4857.441394239637;4902;4990.700557966534;5005;5006.173981293192;5006.173981293192;5031.245313203049;5293.364796224478;5355.598330125178;5356.785728570813;5363.356397232357;5443.7278136092245;5063.696178229318;5078.7206703631655;5087.64386492942;5125.1799712045895;5136.280920671184;5284.180951952453;5339.866503337447;5349.224362467498;5358.98179345923;5401.729913504388;5304.893902122013;5334.839954801362;5439.102548079522;5441.700706461183;5448.7548060336585;5221.190715439113;5230.424653288059;5267.552258058108;5284.709340986129;5305.1776974569;5244.842654720364;5274.077036518671;5290.735463226746;5295.099833028471;5303.708296043755;5053.191489361684;5174.379074511083;5215.530602245816;5228.398734145622;5231.215317702375;5190.6107041971245;5294;5296.523312901857;5335.67985920846;5339.492748188916;5139.665921715076;5141.871453213699;5144.897102058013;5149.407818100966;5149.56228720548 15:16:09 INFO - PID 10638 | |1;ext.html;675.8141511084451;703.750168690115;728.1589763822785;779.9922000779994;788.503242956937;31014.689853101492;32138;32142.03573892781;32172.195695107606;32212.67787322129;32850.8357458213;33185;33202.019697045456;33390.66609333906;33391.16522086949;7124.85750284994;7244.71021159153;7280.6723697433745;8774.561271936409;8983.416077954944;8921.687740929035;9044.3668943174;9046.050164732707;9048.230900373475;9056.139666731682;9001.324900632446;9057.637694492212;9081.046490118508;9081.59132839024;9238.86141707875;9169.449833010041;9217;9236.21492173166;9265.305102117369;9282.76793080175;9060.456372617664;9103.726888193365;9107.954460227722;9111.179993800524;9121.361504694674;33794.49308260378;33957.6604233957;33961.49057764136;33981;34003.82998085018;3415.0949998250485;3440.896773096786;3441.177496772661;3516.4373700207843;3530.117470632342;23729.28812135639;23962;24050.759492405028;24103.638445423334;24214.39464013396;2803.6635603727477;2806.3405099801735;2903.6805951345336;2983.8806447742063;2985.6118704568266;150890.24554877155;151188;151667;152133;152589;42280.788596056824;42341.36487952621;42417;42435;42495.36256956148;43340.133197335876;43841.78079109648;43881.78059109748;43935.56064439379;43967.12065758667;12667.809982850265;12879.162854414433;13023.869761302456;13054.216746995211;13138.014648901179;10183.287169898036;10221.897781022244;10243.282970192015;10288;10338.793224135625;12653;13296.800547991788;13325.600231993056;13325.73348533024;13629.18224906489;5370.516653501126;5462.657187535919;5463.426340234298;5466.234727138124;5651.660900345993;851.3614788908319;888.7111688701198;900.4417261298037;900.7522931193975;922.7739203894954;24191.637125443132;25221.747782522307;25336.873315633304;25369.492610147692;25467.745322546536;939.6147579492512;958.0563145301873;968.5157421289356;969.6945462179391;970.0784254957678;13101.541446049343;13397.53108641193;13631.931840340734;13688.384022719001;13702;215260;215656;216679;216946;217440;42947.35578966318;43325;43332.56667433348;43382.349264761055;43386.566134338886;1210.86680465147;1238.5169783784331;1239.78303796837;1244.122893360197;1245.3461932485336;21987.34037978863;23033.539329213658;23147.65278520857;23396.6490502646;23399.298021059396;29067;29131.417371652024;29161;29204.26989325284;29220.26949326284;149669;178230;178510;178653;178757;26093.608595871458;26771.33071673224;26800.463990719687;26913.865430673504;26975.730242698108;31848.36303273875;32487.18782030468;32594.185145371557;32601.510977335834;32825.34349312953;27284.454310913272;27430;27449.725502744717;27729.861350693925;28526.85736571304;27306.590401144396;27440.725592743816;27777.44445111127;28382;28655.42689146247;28137.155885323475;28380.574291385234;28965.56551651769;28995.85502072476;29032.274193145342;24098.67457289796;24496.755032449448;25170.37074073163;25895.352616184748;26350.077747278752;20010.29963951255;20263.898680506503;20358.59282814365;20411.0609492098;20610.175592976713 15:16:09 INFO - PID 10638 | |2;jquery.html;406.7722075637643;407.6107317511773;412.7090401267106;423.28676180635625;425.03517016372837;13306.467741290337;17530.29878804848;18073.909630451828;18139.546511337223;18244.270229190817;17331.133443327846;17538.29846806126;18003.549911252194;18851.717224241613;19124.33064842731;5625.831225063234;5650.943490565103;5810.883782324372;5838.474537291643;5882.617629854067;5190.870228244286;5220.686758794465;5223.268742376071;5225.660332078422;5232.084385232588;5201.40183878855;5208.76560554774;5326;5726.656400615955;5766.82699519013;5749.913751293734;5784.56615753818;5813.418658134195;5820.941790582104;5837.299524057098;5510.724463776795;5566.276384070045;5676.687782171979;5691;5692.686902220376;21873.234436794635;21897.890510547346;22191;22195.11219551216;22343;2203.10774136475;2203.9449013774624;2230.620794464945;2240.6078936186104;2257.074599414232;13755.518556850562;14028.71942561143;14110.365033573515;14941;14997.925010374987;1700.319872051177;1732.4802559232305;1774.3612299572144;1781.8752687311894;1792.686279901012;91365;92143;93567.53216233943;93990.53004734933;94844.52577737137;15776.526704198892;16487.91756041236;16695.998240105633;16755.2460139294;17351.392701255394;26010.34974125662;28694.856525717238;29066.854665726536;29094;29251.414971700447;8350;8435.662573497115;8537.359698022674;8671.566421679017;8765.167309105625;6900.723971041102;6991.440684745208;7000.439964802804;7157.105361829771;7164.605946672878;8359.623816928253;9147.758799094265;9215.354925155174;9307.627694892264;9377.202937750231;3666.138457462494;3746.662800347982;3759.0978165240695;3763.454299126611;3775.320442320409;835.4277320035795;856.6958729650884;866.9306455483546;880.8284980975416;886.7472770260574;18456;19134.52163695891;20167.394978150678;20177.39467815968;20401.48996275105;897.2507955856802;897.3539051882634;897.9326550508738;903.810199858024;911.9407238529475;10677;10766.407847568302;10830.317711916092;10870.347779133277;10880.78238435227;464976;475616.32877534325;481201;489034;490298;93236;94110;95059;95405;95849.12452626432;1157.976840463186;1228.502456505117;1233.216907263894;1247.1207798501853;1254.0531898416637;16280.511584652479;16319.918400407922;16432.917835410746;16800.57998550046;16898.577535561708;33626.32747345088;37369.03376018631;37969.24061518809;42528.5747142537;44043.779781100886;51569;51821;52135;53767.46232537625;54466.18300725413;10503.212259080752;10531.315464494783;10828.404437755999;11042.668719938414;11305.547778089114;12699.746005079662;12879.291638959947;12982.091253612156;13333.933330333286;13382.397792099573;10499.842502362624;10548.578056877946;10831.891681083403;10912.563497460013;11143.777124457627;9994.250431217833;10703.678889633324;10770.838437423288;11032.613858514913;11275.605353812578;11197.328160310408;11271.380074096003;11292.096632269562;11330.886691132982;11751.76496470083;10890.945545272223;10903.781924361627;11032.172587056164;11273.267237629529;11279.32324060559;10329.276950613385;10427.895721042692;10451.268411211142;10835.566577336818;10878.184136189659 15:16:09 INFO - PID 10638 | |3;mootools.html;1449.8332691740452;1458.9854101458975;1470.698506806105;1472.1461552299668;1533.2257210108894;7997.240262175084;8083.70660694289;8936.329775266857;9219.308551858612;9309.34834561581;9146.679866204684;9465.053494650532;9469.715908522738;9470.905290947088;9486.193673537757;2043.8160565549097;2063.762667293258;2074.844386671006;2077.553326034902;2085.833133349336;1956.520652440147;1998.5003749062735;2000.239908834648;2003.048551937825;2005.0175414047085;1982.3656429942423;1995.750531183602;1997.8901160436171;2004.2383894120214;2006.8494862885268;1959.9706004409945;1968.714536392215;1969.4091772468203;1973.6644770388996;1980.5939782344728;1830.7528483654803;1840.5306646805113;1892.4228110426313;1999.5800881814691;2022.9885057471265;9645.08371704687;9670;9700.660476883275;9730.41617502952;9733.124018838338;4582.747948862811;4714.222153344694;4741.454732705714;4760.309755085494;4760.833370832004;2633.3153380121116;2802.523570992936;2853.8145020573597;2854.9714502854913;2859.1422573227946;952.7189479103681;1010.368519675203;1036.6371769880482;1036.7978244242377;1047.4186826311395;12637.74724505514;12721.236725796389;12722.173058751245;12726.87273127266;12780.169288996185;3647.1611529348397;3932.9016774580864;3990.06233535119;4025.215083058834;4029.49631296088;11146.609868654557;11165.665030049111;11278.266912650652;11296.322220666787;11313.71715707114;4571.977140114344;4585.358049873021;4585.358049873021;4595.379623750818;4597.126545956257;3584.946225806615;3703.166787472797;4045.959540404558;4130.752154870717;4218.303979843292;3497.982510087433;3600.4419315006216;3600.98199509006;3640.7633503822167;3747.0445036515516;1011.2516737614112;1040.661784919904;1049.4490392543976;1054.3779170289565;1057.7778666479971;823.3372135430916;831.3556993330218;835.5362773660677;851.9574021298911;857.5883575883486;5279;5289.312389389432;5387.973060134675;5533.446655334515;5539.639923404966;856.9442986205877;865.9307255419551;867.8307729992717;875.3391189651772;900.7297810656777;3230.6607806180014;3256.3812875553567;3268.967310326914;3325.600927888669;3352.513885486591;11145.219834611662;11505.367204803817;11580.942095289469;11615.709607259887;11624.186306958602;11443.713907152222;11483.712907177387;11502.309861408343;11569.595064172714;11578.594749183738;8126.146754590801;8178.386621003448;8448.112948140357;8451.53516556583;8591.613377398033;5436.374816896107;5608.495235428831;5689.573282003949;5728.828135155952;5766.308043034863;10077.244206684381;10139.239557033105;10160.339577927707;10286.691399258034;10436.321639093434;10196.592136314464;10284.177265818866;10359.63741269052;10447.94776026115;10547.525361358605;7882.605869706606;8107.635156418093;8124.471909326111;8202.26179643835;8255.339572834278;9070;9098.181163695299;9135.954320228357;9169.77075573116;9175.495347755937;7852.646630901738;7908.4464087513325;7926.920730792618;7927.603619819101;7946.364290856834;7698.461107722405;7728.304452599293;7942.682292708227;8000.319972802145;8001.3598912088055;6862.348076932683;6940.375366217065;7020.7542736004;7102.857942841218;7181.35367816899;5065.189569668835;5150.793968241378;5203.11547036997;5203.401608814884;5240.423553409199;5119.360079990001;5216.921746173886;5224.52979231871;5258.106121959353;5270.077736396192 15:16:09 INFO - PID 10638 | |4;prototype.html;354.7162270183854;359.72301327977476;362.64641974075266;370.02867472883673;379.5843551311313;5082.364704411949;5268.789248430067;5382.461753824616;5418.187271909215;5454.345478542576;5133.563647090002;5230.9738451307785;5283.154695248761;5311.362636483627;5339.5461385782155;4601.102784956943;4629.629629629639;4634;4634.6987445816085;4650.627949764011;4495.258282383403;4613.838515651953;4615.746133962631;4632.58706094641;4636.211843986531;4577.679562430631;4603.838865639704;4616.722996620197;4624.953750462486;4631.861044168681;4593.56361145689;4596.517365676606;4605.769711514411;4612.46956599992;4630.513796051399;3886.844526218948;4054.736442131252;4471.2398892188085;4478.1043791241555;4481.7983190756495;5137.33214682089;5148.897022059537;5160.612954028463;5174.456682048369;5179.456157103487;5095.898082038376;5102.591792656579;5106.5659418949435;5121.871953201163;5122.462141475166;5410.6510995983945;5570.3315602128005;5587.525060369833;5605.355384130796;5615.887682246373;4477.77611119446;4495;4498.347739577775;4504.864854054351;4507.16617425774;5632.295963004624;5733.88532229353;5788.797392091299;5859.355470898197;5950.791722289742;4620.72929944268;4634.165850147006;4635.629149668019;4635.629149668019;4641.860744177612;4686.835960741358;4702.3416721659;4704.435467743824;4713;4720.103180395714;4858.562729354305;5046.6719663221775;5053.418856831511;5088.643794934393;5105.719185444762;5531.197976293495;5533.972330138324;5539.698170929828;5541.806036788774;5580.218769372291;1635.4357746577411;1638.5248277999485;1657.7430498272788;1665.76679264903;1666.5000499849996;1225.5526732742485;1228.5515786737776;1240.2434514945876;1247.7504499100216;1259.307380940479;4889.462159162489;4905.288733133676;4907.607391408679;4929;4930.309756634074;5761.798337058183;5780.739866706008;5802.912956305659;5825.242718446575;5828.154917536934;4753.548412900769;4848.95151048485;4922.680025798311;4937.827176048893;4944.157109661959;3056.2359410147465;3083.522054081621;3084.3677046205476;3089.891853785107;3092.0105566219045;5294.973525132426;5383.623146379716;5397.622166448311;5408.269883565747;5412.458754124556;5823.213866128019;5858.912116318259;5873.911891321633;5886.35182148999;5905.822825315247;5346.679199248058;5359.410464848864;5389.164679474688;5389.272448219519;5389.541888939484;5571.860703482445;5739;5765.971170144123;5816.534677225727;5817.95276850171;5355.22349259363;5671.291088613923;5695.487406133468;5705.486506214461;5709.25779648643;5239.633225674166;5264.473552644705;5335.505244065143;5363.973180134074;5371.677699338053;4626.467956184947;4636.698614590041;4646.071880169692;4656.790444430077;4662.810983199262;5701.173329867229;5730.828075157752;5757.6545407274025;5826.650400975955;5837.795677151279;5565.693886836263;5579.804706835242;5587.664740115606;5599.8880022400135;5607.5513958884;5574.303212098488;5593.776248950159;5596.41237670055;5597.481133489864;5630.5214056805635;5267.7366131694025;5519;5538.667679939055;5555.527780138734;5560.36055853582;5660.32076150848;5672.517835983987;5681.9147712783515;5688.715564221855;5689.573282003784;5243.790248390022;5483.629092726818;5523.226748255167;5528.143137813645;5529.944700552943 15:16:09 INFO - PID 10638 | |5;yui.html;673.952823302369;686.2999740264927;719.0508528742063;733.5635296998286;772.2933515833012;12140.210886292396;12615.873841261597;12971.221726696393;13070.869291307084;13279.601611951633;12846.48614055439;12893.613191604243;12975.870241297584;13134.474621015172;13165.539206127787;845.1295165979052;847.0343808058802;862.241227719609;863.9265662418702;863.9870401943975;876.4609764994515;883.770219742865;884.164464580968;885.3094586222725;885.8272636835819;920.5443305563755;926.7127190570944;927.717046300878;927.9211267042309;929.326238477102;905.2215095018279;916.9174774270315;916.9220616247594;919.0396036142214;921.6221349246844;670.8825955457825;674.4132604633951;674.578388507183;675.4393853101963;675.7398401615364;13145.211287322696;13573.11774734649;14880.776788348183;14953;14975.176365300013;12934.935325323408;13821.861781382258;14136.22250776207;14459.927700361432;14684.609083098623;9841.704748857546;9883.505824708807;9922;9942.90057099427;10063.69808905734;2813.3388653666575;2906.781991350636;2944.131481213047;2962.718541738553;3206;31188.37623247545;42453.36319955203;52208.2168767465;56351.71824140894;58209.417905820825;11045.477261369315;11269;11290.774184516264;11451.770964580663;11859.407029648482;19151.904240478707;19883.403497895088;19894.303699370743;20890.791092089188;21079;6410.935890641033;6647.66761661915;6736.5284430090405;6779.72881084751;6904.654767261617;3370.7134893534326;3448.965310406868;3477.739169562293;3491.2493813830147;3511.227529943408;3133.3576616793503;3259.282957749291;3259.331836973462;3264.069740124053;3277.2462333663393;518.9636725429184;522.0524747583124;522.1488972974028;523.3641126031889;534.9491798279157;620.6803496199461;655;662.5428454366568;664.1200409457488;670.8591195848829;8599.226069653761;8972.730818075468;9358.859617105749;9387.859182112274;9775.026333048507;622.791364892757;627.4290395739855;641.8652083062516;641.8748344072861;645.4513663386084;4012.578679238696;4306.590873866978;4313.977786754809;4342.413774140514;4353.869383918487;62141;62556.68721656362;62833;63317.366826332065;64222.35777642257;39805.402918956235;44529.777351113684;46044.30933536;46492.302615460794;52398.47601524012;45760.7711961438;45839.54160458419;46035.53964460312;46610.06779864384;46856.297155543376;8937.821243574963;9609.951950240204;9647.228221742384;9690.709278721368;9739.805203896025;32041.67958320387;32115.678843212205;32222.677773222906;32994.17514562155;33083.66916330902;38041.4293785599;38261;38452.80773596114;39133.60866391299;39586.604133959445;11616.361100139573;11666.88333116658;11764.529418823151;11866.110041746731;12335.198212116184;11337.26307789991;11346.262492937933;11511.712207194887;11636.88363116358;11720.88279117198;12699.55551555691;12743.490260389852;13233.933830330787;13450.86549134496;13476.460941562227;11747.588834390755;11975.700607484534;12269.447874845475;12781.16922400041;12848.421821018264;11783.175177737476;12373.814392784296;12387.75224495523;12522.623588363092;12603.873961260637;9843.60625574969;9844.458554779556;10191.796164076824;10200.2349823765;10478.318909270873;9347.719568412958;9906.356086854332;9944;9956.402615843073;10002.349847259904 15:16:09 INFO - PID 10638 | __end_tp_report 15:16:09 INFO - PID 10638 | __start_cc_report 15:16:09 INFO - PID 10638 | _x_x_mozilla_cycle_collect,376 15:16:09 INFO - PID 10638 | __end_cc_report 15:16:09 INFO - PID 10638 | __startTimestamp1489616169935__endTimestamp 15:16:09 INFO - PID 10638 | 15:16:09 INFO - PID 10638 | ------- Summary: start ------- 15:16:09 INFO - PID 10638 | Number of tests: 6 15:16:09 INFO - PID 10638 | 15:16:09 INFO - PID 10638 | [#0] dojo.html Cycles:165 Average:4966.24 Median:5087.36 stddev:533.99 (10.5%) stddev-sans-first:504.46 15:16:09 INFO - PID 10638 | Values: 2674.6 2685.8 2694.2 2718.7 2728.3 4888.7 4949.1 5028.4 5043.6 5074.3 5001.9 5027.9 5035.6 5038.1 5087.4 4616.3 4665.0 4666.7 4669.7 4694.3 4648.3 4676.9 4677.4 4688.4 4733.1 4528.8 4556.2 4577.3 4630.2 4649.3 4635.1 4637.7 4644.0 4668.5 4683.8 4555.0 4607.7 4616.0 4620.6 4659.9 4909.3 4927.6 4946.5 4988.3 5008.4 5322.7 5334.4 5361.0 5375.9 5436.9 5412.9 5416.0 5422.4 5433.8 5487.3 4894.4 4930.1 4949.0 5050.7 5073.8 5400.2 5430.3 5439.2 5442.5 5444.9 5160.7 5308.2 5329.7 5342.4 5363.4 5263.0 5381.5 5392.2 5394.2 5395.1 5273.8 5300.8 5315.9 5331.9 5391.7 5201.7 5228.7 5316.7 5324.9 5351.0 4508.4 4540.0 4548.8 4548.8 4574.4 3897.1 3952.1 3956.6 3980.3 3983.0 4598.0 4641.3 4676.1 4691.1 4698.0 5455.5 5465.9 5471.5 5474.1 5495.0 4687.5 4693.1 4705.0 4722.8 4763.7 4723.1 4727.9 4753.8 4857.4 4902.0 4990.7 5005.0 5006.2 5006.2 5031.2 5293.4 5355.6 5356.8 5363.4 5443.7 5063.7 5078.7 5087.6 5125.2 5136.3 5284.2 5339.9 5349.2 5359.0 5401.7 5304.9 5334.8 5439.1 5441.7 5448.8 5221.2 5230.4 5267.6 5284.7 5305.2 5244.8 5274.1 5290.7 5295.1 5303.7 5053.2 5174.4 5215.5 5228.4 5231.2 5190.6 5294.0 5296.5 5335.7 5339.5 5139.7 5141.9 5144.9 5149.4 5149.6 15:16:09 INFO - PID 10638 | 15:16:09 INFO - PID 10638 | [#1] ext.html Cycles:180 Average:32490.33 Median:29182.63 stddev:47134.16 (161.5%) stddev-sans-first:47205.84 15:16:09 INFO - PID 10638 | Values: 675.8 703.8 728.2 780.0 788.5 31014.7 32138.0 32142.0 32172.2 32212.7 32850.8 33185.0 33202.0 33390.7 33391.2 7124.9 7244.7 7280.7 8774.6 8983.4 8921.7 9044.4 9046.1 9048.2 9056.1 9001.3 9057.6 9081.0 9081.6 9238.9 9169.4 9217.0 9236.2 9265.3 9282.8 9060.5 9103.7 9108.0 9111.2 9121.4 33794.5 33957.7 33961.5 33981.0 34003.8 3415.1 3440.9 3441.2 3516.4 3530.1 23729.3 23962.0 24050.8 24103.6 24214.4 2803.7 2806.3 2903.7 2983.9 2985.6 150890.2 151188.0 151667.0 152133.0 152589.0 42280.8 42341.4 42417.0 42435.0 42495.4 43340.1 43841.8 43881.8 43935.6 43967.1 12667.8 12879.2 13023.9 13054.2 13138.0 10183.3 10221.9 10243.3 10288.0 10338.8 12653.0 13296.8 13325.6 13325.7 13629.2 5370.5 5462.7 5463.4 5466.2 5651.7 851.4 888.7 900.4 900.8 922.8 24191.6 25221.7 25336.9 25369.5 25467.7 939.6 958.1 968.5 969.7 970.1 13101.5 13397.5 13631.9 13688.4 13702.0 215260.0 215656.0 216679.0 216946.0 217440.0 42947.4 43325.0 43332.6 43382.3 43386.6 1210.9 1238.5 1239.8 1244.1 1245.3 21987.3 23033.5 23147.7 23396.6 23399.3 29067.0 29131.4 29161.0 29204.3 29220.3 149669.0 178230.0 178510.0 178653.0 178757.0 26093.6 26771.3 26800.5 26913.9 26975.7 31848.4 32487.2 32594.2 32601.5 32825.3 27284.5 27430.0 27449.7 27729.9 28526.9 27306.6 27440.7 27777.4 28382.0 28655.4 28137.2 28380.6 28965.6 28995.9 29032.3 24098.7 24496.8 25170.4 25895.4 26350.1 20010.3 20263.9 20358.6 20411.1 20610.2 15:16:09 INFO - PID 10638 | 15:16:09 INFO - PID 10638 | [#2] jquery.html Cycles:180 Average:29607.83 Median:28880.86 stddev:79380.65 (274.9%) stddev-sans-first:79573.05 15:16:09 INFO - PID 10638 | Values: 406.8 407.6 412.7 423.3 425.0 13306.5 17530.3 18073.9 18139.5 18244.3 17331.1 17538.3 18003.5 18851.7 19124.3 5625.8 5650.9 5810.9 5838.5 5882.6 5190.9 5220.7 5223.3 5225.7 5232.1 5201.4 5208.8 5326.0 5726.7 5766.8 5749.9 5784.6 5813.4 5820.9 5837.3 5510.7 5566.3 5676.7 5691.0 5692.7 21873.2 21897.9 22191.0 22195.1 22343.0 2203.1 2203.9 2230.6 2240.6 2257.1 13755.5 14028.7 14110.4 14941.0 14997.9 1700.3 1732.5 1774.4 1781.9 1792.7 91365.0 92143.0 93567.5 93990.5 94844.5 15776.5 16487.9 16696.0 16755.2 17351.4 26010.3 28694.9 29066.9 29094.0 29251.4 8350.0 8435.7 8537.4 8671.6 8765.2 6900.7 6991.4 7000.4 7157.1 7164.6 8359.6 9147.8 9215.4 9307.6 9377.2 3666.1 3746.7 3759.1 3763.5 3775.3 835.4 856.7 866.9 880.8 886.7 18456.0 19134.5 20167.4 20177.4 20401.5 897.3 897.4 897.9 903.8 911.9 10677.0 10766.4 10830.3 10870.3 10880.8 464976.0 475616.3 481201.0 489034.0 490298.0 93236.0 94110.0 95059.0 95405.0 95849.1 1158.0 1228.5 1233.2 1247.1 1254.1 16280.5 16319.9 16432.9 16800.6 16898.6 33626.3 37369.0 37969.2 42528.6 44043.8 51569.0 51821.0 52135.0 53767.5 54466.2 10503.2 10531.3 10828.4 11042.7 11305.5 12699.7 12879.3 12982.1 13333.9 13382.4 10499.8 10548.6 10831.9 10912.6 11143.8 9994.3 10703.7 10770.8 11032.6 11275.6 11197.3 11271.4 11292.1 11330.9 11751.8 10890.9 10903.8 11032.2 11273.3 11279.3 10329.3 10427.9 10451.3 10835.6 10878.2 15:16:09 INFO - PID 10638 | 15:16:09 INFO - PID 10638 | [#3] mootools.html Cycles:180 Average:5757.88 Median:4037.73 stddev:3622.29 (89.7%) stddev-sans-first:3617.99 15:16:09 INFO - PID 10638 | Values: 1449.8 1459.0 1470.7 1472.1 1533.2 7997.2 8083.7 8936.3 9219.3 9309.3 9146.7 9465.1 9469.7 9470.9 9486.2 2043.8 2063.8 2074.8 2077.6 2085.8 1956.5 1998.5 2000.2 2003.0 2005.0 1982.4 1995.8 1997.9 2004.2 2006.8 1960.0 1968.7 1969.4 1973.7 1980.6 1830.8 1840.5 1892.4 1999.6 2023.0 9645.1 9670.0 9700.7 9730.4 9733.1 4582.7 4714.2 4741.5 4760.3 4760.8 2633.3 2802.5 2853.8 2855.0 2859.1 952.7 1010.4 1036.6 1036.8 1047.4 12637.7 12721.2 12722.2 12726.9 12780.2 3647.2 3932.9 3990.1 4025.2 4029.5 11146.6 11165.7 11278.3 11296.3 11313.7 4572.0 4585.4 4585.4 4595.4 4597.1 3584.9 3703.2 4046.0 4130.8 4218.3 3498.0 3600.4 3601.0 3640.8 3747.0 1011.3 1040.7 1049.4 1054.4 1057.8 823.3 831.4 835.5 852.0 857.6 5279.0 5289.3 5388.0 5533.4 5539.6 856.9 865.9 867.8 875.3 900.7 3230.7 3256.4 3269.0 3325.6 3352.5 11145.2 11505.4 11580.9 11615.7 11624.2 11443.7 11483.7 11502.3 11569.6 11578.6 8126.1 8178.4 8448.1 8451.5 8591.6 5436.4 5608.5 5689.6 5728.8 5766.3 10077.2 10139.2 10160.3 10286.7 10436.3 10196.6 10284.2 10359.6 10447.9 10547.5 7882.6 8107.6 8124.5 8202.3 8255.3 9070.0 9098.2 9136.0 9169.8 9175.5 7852.6 7908.4 7926.9 7927.6 7946.4 7698.5 7728.3 7942.7 8000.3 8001.4 6862.3 6940.4 7020.8 7102.9 7181.4 5065.2 5150.8 5203.1 5203.4 5240.4 5119.4 5216.9 5224.5 5258.1 5270.1 15:16:09 INFO - PID 10638 | 15:16:09 INFO - PID 10638 | [#4] prototype.html Cycles:180 Average:4800.25 Median:5176.96 stddev:1266.04 (24.5%) stddev-sans-first:1224.83 15:16:09 INFO - PID 10638 | Values: 354.7 359.7 362.6 370.0 379.6 5082.4 5268.8 5382.5 5418.2 5454.3 5133.6 5231.0 5283.2 5311.4 5339.5 4601.1 4629.6 4634.0 4634.7 4650.6 4495.3 4613.8 4615.7 4632.6 4636.2 4577.7 4603.8 4616.7 4625.0 4631.9 4593.6 4596.5 4605.8 4612.5 4630.5 3886.8 4054.7 4471.2 4478.1 4481.8 5137.3 5148.9 5160.6 5174.5 5179.5 5095.9 5102.6 5106.6 5121.9 5122.5 5410.7 5570.3 5587.5 5605.4 5615.9 4477.8 4495.0 4498.3 4504.9 4507.2 5632.3 5733.9 5788.8 5859.4 5950.8 4620.7 4634.2 4635.6 4635.6 4641.9 4686.8 4702.3 4704.4 4713.0 4720.1 4858.6 5046.7 5053.4 5088.6 5105.7 5531.2 5534.0 5539.7 5541.8 5580.2 1635.4 1638.5 1657.7 1665.8 1666.5 1225.6 1228.6 1240.2 1247.8 1259.3 4889.5 4905.3 4907.6 4929.0 4930.3 5761.8 5780.7 5802.9 5825.2 5828.2 4753.5 4849.0 4922.7 4937.8 4944.2 3056.2 3083.5 3084.4 3089.9 3092.0 5295.0 5383.6 5397.6 5408.3 5412.5 5823.2 5858.9 5873.9 5886.4 5905.8 5346.7 5359.4 5389.2 5389.3 5389.5 5571.9 5739.0 5766.0 5816.5 5818.0 5355.2 5671.3 5695.5 5705.5 5709.3 5239.6 5264.5 5335.5 5364.0 5371.7 4626.5 4636.7 4646.1 4656.8 4662.8 5701.2 5730.8 5757.7 5826.7 5837.8 5565.7 5579.8 5587.7 5599.9 5607.6 5574.3 5593.8 5596.4 5597.5 5630.5 5267.7 5519.0 5538.7 5555.5 5560.4 5660.3 5672.5 5681.9 5688.7 5689.6 5243.8 5483.6 5523.2 5528.1 5529.9 15:16:09 INFO - PID 10638 | 15:16:09 INFO - PID 10638 | [#5] yui.html Cycles:180 Average:13811.81 Median:4328.20 stddev:15785.89 (364.7%) stddev-sans-first:15799.35 15:16:09 INFO - PID 10638 | Values: 674.0 686.3 719.1 733.6 772.3 12140.2 12615.9 12971.2 13070.9 13279.6 12846.5 12893.6 12975.9 13134.5 13165.5 845.1 847.0 862.2 863.9 864.0 876.5 883.8 884.2 885.3 885.8 920.5 926.7 927.7 927.9 929.3 905.2 916.9 916.9 919.0 921.6 670.9 674.4 674.6 675.4 675.7 13145.2 13573.1 14880.8 14953.0 14975.2 12934.9 13821.9 14136.2 14459.9 14684.6 9841.7 9883.5 9922.0 9942.9 10063.7 2813.3 2906.8 2944.1 2962.7 3206.0 31188.4 42453.4 52208.2 56351.7 58209.4 11045.5 11269.0 11290.8 11451.8 11859.4 19151.9 19883.4 19894.3 20890.8 21079.0 6410.9 6647.7 6736.5 6779.7 6904.7 3370.7 3449.0 3477.7 3491.2 3511.2 3133.4 3259.3 3259.3 3264.1 3277.2 519.0 522.1 522.1 523.4 534.9 620.7 655.0 662.5 664.1 670.9 8599.2 8972.7 9358.9 9387.9 9775.0 622.8 627.4 641.9 641.9 645.5 4012.6 4306.6 4314.0 4342.4 4353.9 62141.0 62556.7 62833.0 63317.4 64222.4 39805.4 44529.8 46044.3 46492.3 52398.5 45760.8 45839.5 46035.5 46610.1 46856.3 8937.8 9610.0 9647.2 9690.7 9739.8 32041.7 32115.7 32222.7 32994.2 33083.7 38041.4 38261.0 38452.8 39133.6 39586.6 11616.4 11666.9 11764.5 11866.1 12335.2 11337.3 11346.3 11511.7 11636.9 11720.9 12699.6 12743.5 13233.9 13450.9 13476.5 11747.6 11975.7 12269.4 12781.2 12848.4 11783.2 12373.8 12387.8 12522.6 12603.9 9843.6 9844.5 10191.8 10200.2 10478.3 9347.7 9906.4 9944.0 9956.4 10002.3 15:16:09 INFO - PID 10638 | -------- Summary: end -------- 15:16:09 INFO - PID 10638 | 15:16:10 INFO - TEST-INFO | 10638: exit 0 15:16:10 INFO - TEST-OK | dromaeo_css | took 1121258ms 15:16:10 INFO - TEST-START | kraken 15:16:10 INFO - operating with platform_type : linux_ 15:16:10 INFO - Initialising browser for kraken test... 15:16:10 INFO - TEST-INFO | started process 11019 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqBUeUj/profile http://localhost:47080/getInfo.html) 15:16:15 INFO - PID 11019 | __metrics Screen width/height:1600/1200 15:16:15 INFO - PID 11019 | colorDepth:24 15:16:15 INFO - PID 11019 | Browser inner width/height: 1024/697 15:16:15 INFO - PID 11019 | __metrics 15:16:16 ERROR - PID 11019 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 15:16:17 INFO - TEST-INFO | 11019: exit 0 15:16:17 INFO - Browser initialized. 15:16:17 INFO - Running cycle 1/1 for kraken test... 15:16:17 INFO - TEST-INFO | started process 11149 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqBUeUj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:16:30 INFO - PID 11149 | RSS: Main: 155000832 15:16:30 INFO - PID 11149 | 15:16:32 INFO - PID 11149 | Cycle 1(1): loaded http://localhost:47080/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47080/tests/kraken/driver.html?testName=audio-beat-detection) 15:16:33 INFO - PID 11149 | RSS: Main: 161890304 15:16:33 INFO - PID 11149 | 15:16:36 INFO - PID 11149 | Cycle 1(1): loaded http://localhost:47080/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47080/tests/kraken/driver.html?testName=audio-dft) 15:16:37 INFO - PID 11149 | RSS: Main: 161075200 15:16:37 INFO - PID 11149 | 15:16:40 INFO - PID 11149 | Cycle 1(1): loaded http://localhost:47080/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47080/tests/kraken/driver.html?testName=audio-fft) 15:16:40 INFO - PID 11149 | RSS: Main: 157593600 15:16:40 INFO - PID 11149 | 15:16:42 INFO - PID 11149 | Cycle 1(1): loaded http://localhost:47080/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47080/tests/kraken/driver.html?testName=audio-oscillator) 15:16:43 INFO - PID 11149 | RSS: Main: 158208000 15:16:43 INFO - PID 11149 | 15:16:45 INFO - PID 11149 | Cycle 1(1): loaded http://localhost:47080/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47080/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:16:46 INFO - PID 11149 | RSS: Main: 158699520 15:16:46 INFO - PID 11149 | 15:16:49 INFO - PID 11149 | Cycle 1(1): loaded http://localhost:47080/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47080/tests/kraken/driver.html?testName=imaging-darkroom) 15:16:50 INFO - PID 11149 | RSS: Main: 163655680 15:16:50 INFO - PID 11149 | 15:16:53 INFO - PID 11149 | Cycle 1(1): loaded http://localhost:47080/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47080/tests/kraken/driver.html?testName=imaging-desaturate) 15:16:54 INFO - PID 11149 | RSS: Main: 161136640 15:16:54 INFO - PID 11149 | 15:16:57 INFO - PID 11149 | Cycle 1(1): loaded http://localhost:47080/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47080/tests/kraken/driver.html?testName=json-parse-financial) 15:16:57 INFO - PID 11149 | RSS: Main: 162164736 15:16:57 INFO - PID 11149 | 15:16:59 INFO - PID 11149 | Cycle 1(1): loaded http://localhost:47080/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47080/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:17:00 INFO - PID 11149 | RSS: Main: 162611200 15:17:00 INFO - PID 11149 | 15:17:02 INFO - PID 11149 | Cycle 1(1): loaded http://localhost:47080/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47080/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:17:02 INFO - PID 11149 | RSS: Main: 162684928 15:17:02 INFO - PID 11149 | 15:17:05 INFO - PID 11149 | Cycle 1(1): loaded http://localhost:47080/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47080/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:17:05 INFO - PID 11149 | RSS: Main: 163274752 15:17:05 INFO - PID 11149 | 15:17:08 INFO - PID 11149 | Cycle 1(1): loaded http://localhost:47080/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47080/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:17:09 INFO - PID 11149 | RSS: Main: 163844096 15:17:09 INFO - PID 11149 | 15:17:12 INFO - PID 11149 | Cycle 1(1): loaded http://localhost:47080/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47080/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:17:13 INFO - PID 11149 | RSS: Main: 163733504 15:17:13 INFO - PID 11149 | 15:17:15 INFO - PID 11149 | Cycle 1(1): loaded http://localhost:47080/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47080/tests/kraken/driver.html?testName=ai-astar) 15:17:15 INFO - PID 11149 | RSS: Main: 164810752 15:17:15 INFO - PID 11149 | 15:17:15 INFO - PID 11149 | __start_tp_report 15:17:15 INFO - PID 11149 | _x_x_mozilla_page_load 15:17:15 INFO - PID 11149 | _x_x_mozilla_page_load_details 15:17:15 INFO - PID 11149 | |i|pagename|runs| 15:17:15 INFO - PID 11149 | |0;ai-astar;111;119;118;119;119;118;119;120;119;119 15:17:15 INFO - PID 11149 | |1;audio-beat-detection;153;125;125;186;135;128;125;127;150;126 15:17:15 INFO - PID 11149 | |2;audio-dft;165;173;168;170;176;165;165;166;163;164 15:17:15 INFO - PID 11149 | |3;audio-fft;79;77;78;108;77;76;78;81;99;76 15:17:15 INFO - PID 11149 | |4;audio-oscillator;86;91;115;88;84;85;105;86;86;114 15:17:15 INFO - PID 11149 | |5;imaging-gaussian-blur;114;114;114;115;114;118;114;113;115;114 15:17:15 INFO - PID 11149 | |6;imaging-darkroom;151;151;151;150;150;151;151;151;149;151 15:17:15 INFO - PID 11149 | |7;imaging-desaturate;94;96;95;94;94;96;94;95;94;95 15:17:15 INFO - PID 11149 | |8;json-parse-financial;69;67;69;70;70;69;69;69;70;71 15:17:15 INFO - PID 11149 | |9;json-stringify-tinderbox;58;57;57;57;57;57;57;57;58;59 15:17:15 INFO - PID 11149 | |10;stanford-crypto-aes;86;84;86;85;85;84;85;84;84;84 15:17:15 INFO - PID 11149 | |11;stanford-crypto-ccm;147;140;144;147;152;134;139;141;202;137 15:17:15 INFO - PID 11149 | |12;stanford-crypto-pbkdf2;185;196;185;196;200;197;186;192;195;187 15:17:15 INFO - PID 11149 | |13;stanford-crypto-sha256-iterative;75;73;78;74;74;78;80;71;71;74 15:17:15 INFO - PID 11149 | __end_tp_report 15:17:15 INFO - PID 11149 | __start_cc_report 15:17:15 INFO - PID 11149 | _x_x_mozilla_cycle_collect,872 15:17:15 INFO - PID 11149 | __end_cc_report 15:17:15 INFO - PID 11149 | __startTimestamp1489616235300__endTimestamp 15:17:15 INFO - PID 11149 | 15:17:15 INFO - PID 11149 | ------- Summary: start ------- 15:17:15 INFO - PID 11149 | Number of tests: 14 15:17:15 INFO - PID 11149 | 15:17:15 INFO - PID 11149 | [#0] ai-astar Cycles:10 Average:118.10 Median:119.00 stddev:2.56 (2.1%) stddev-sans-first:0.60 15:17:15 INFO - PID 11149 | Values: 111.0 119.0 118.0 119.0 119.0 118.0 119.0 120.0 119.0 119.0 15:17:15 INFO - PID 11149 | 15:17:15 INFO - PID 11149 | [#1] audio-beat-detection Cycles:10 Average:138.00 Median:131.50 stddev:19.87 (15.1%) stddev-sans-first:20.32 15:17:15 INFO - PID 11149 | Values: 153.0 125.0 125.0 186.0 135.0 128.0 125.0 127.0 150.0 126.0 15:17:15 INFO - PID 11149 | 15:17:15 INFO - PID 11149 | [#2] audio-dft Cycles:10 Average:167.50 Median:167.00 stddev:4.25 (2.5%) stddev-sans-first:4.41 15:17:15 INFO - PID 11149 | Values: 165.0 173.0 168.0 170.0 176.0 165.0 165.0 166.0 163.0 164.0 15:17:15 INFO - PID 11149 | 15:17:15 INFO - PID 11149 | [#3] audio-fft Cycles:10 Average:82.90 Median:78.00 stddev:11.16 (14.3%) stddev-sans-first:11.75 15:17:15 INFO - PID 11149 | Values: 79.0 77.0 78.0 108.0 77.0 76.0 78.0 81.0 99.0 76.0 15:17:15 INFO - PID 11149 | 15:17:15 INFO - PID 11149 | [#4] audio-oscillator Cycles:10 Average:94.00 Median:86.00 stddev:12.38 (14.4%) stddev-sans-first:12.79 15:17:15 INFO - PID 11149 | Values: 86.0 91.0 115.0 88.0 84.0 85.0 105.0 86.0 86.0 114.0 15:17:15 INFO - PID 11149 | 15:17:15 INFO - PID 11149 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:114.00 stddev:1.35 (1.2%) stddev-sans-first:1.42 15:17:15 INFO - PID 11149 | Values: 114.0 114.0 114.0 115.0 114.0 118.0 114.0 113.0 115.0 114.0 15:17:15 INFO - PID 11149 | 15:17:15 INFO - PID 11149 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:151.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 15:17:15 INFO - PID 11149 | Values: 151.0 151.0 151.0 150.0 150.0 151.0 151.0 151.0 149.0 151.0 15:17:15 INFO - PID 11149 | 15:17:15 INFO - PID 11149 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.83 15:17:15 INFO - PID 11149 | Values: 94.0 96.0 95.0 94.0 94.0 96.0 94.0 95.0 94.0 95.0 15:17:15 INFO - PID 11149 | 15:17:15 INFO - PID 11149 | [#8] json-parse-financial Cycles:10 Average:69.30 Median:69.50 stddev:1.06 (1.5%) stddev-sans-first:1.12 15:17:15 INFO - PID 11149 | Values: 69.0 67.0 69.0 70.0 70.0 69.0 69.0 69.0 70.0 71.0 15:17:15 INFO - PID 11149 | 15:17:15 INFO - PID 11149 | [#9] json-stringify-tinderbox Cycles:10 Average:57.40 Median:57.00 stddev:0.70 (1.2%) stddev-sans-first:0.71 15:17:15 INFO - PID 11149 | Values: 58.0 57.0 57.0 57.0 57.0 57.0 57.0 57.0 58.0 59.0 15:17:15 INFO - PID 11149 | 15:17:15 INFO - PID 11149 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:85.00 stddev:0.82 (1.0%) stddev-sans-first:0.73 15:17:15 INFO - PID 11149 | Values: 86.0 84.0 86.0 85.0 85.0 84.0 85.0 84.0 84.0 84.0 15:17:15 INFO - PID 11149 | 15:17:15 INFO - PID 11149 | [#11] stanford-crypto-ccm Cycles:10 Average:148.30 Median:145.50 stddev:19.61 (13.5%) stddev-sans-first:20.79 15:17:15 INFO - PID 11149 | Values: 147.0 140.0 144.0 147.0 152.0 134.0 139.0 141.0 202.0 137.0 15:17:15 INFO - PID 11149 | 15:17:15 INFO - PID 11149 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.90 Median:195.50 stddev:5.67 (2.9%) stddev-sans-first:5.43 15:17:15 INFO - PID 11149 | Values: 185.0 196.0 185.0 196.0 200.0 197.0 186.0 192.0 195.0 187.0 15:17:15 INFO - PID 11149 | 15:17:15 INFO - PID 11149 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.80 Median:74.50 stddev:3.01 (4.0%) stddev-sans-first:3.19 15:17:15 INFO - PID 11149 | Values: 75.0 73.0 78.0 74.0 74.0 78.0 80.0 71.0 71.0 74.0 15:17:15 INFO - PID 11149 | -------- Summary: end -------- 15:17:15 INFO - PID 11149 | 15:17:16 INFO - TEST-INFO | 11149: exit 0 15:17:16 INFO - TEST-OK | kraken | took 65675ms 15:17:16 INFO - SUITE-END | took 1186s 15:17:16 INFO - Completed test suite (00:19:47) 15:17:16 INFO - javascript benchmark 15:17:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6711.1258950941465, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2674.6477116847486, 2685.7985651076174, 2694.1782756259345, 2718.660167479065, 2728.31792051987, 4888.706677599346, 4949.084419382412, 5028.446870844209, 5043.621728370378, 5074.2895994560795, 5001.874953126174, 5027.899442011167, 5035.647504674675, 5038.118329292368, 5087.364079490064, 4616.2613981762925, 4664.97667511662, 4666.650001249903, 4669.6731228814, 4694.342792009122, 4648.325992731052, 4676.929846052312, 4677.415323084614, 4688.367070445497, 4733.124371991193, 4528.773561321921, 4556.179887620227, 4577.29051996941, 4630.236011058171, 4649.325847752057, 4635.0729854029, 4637.698549594265, 4644.0, 4668.486466488684, 4683.765811709435, 4554.954450455486, 4607.723536587782, 4615.976920115378, 4620.630349572026, 4659.883502912454, 4909.337239472661, 4927.581155601778, 4946.530079642464, 4988.326575912241, 5008.449070602267, 5322.65402748824, 5334.413214546396, 5360.973195133999, 5375.865603359908, 5436.891262174734, 5412.9458705412835, 5415.972920135414, 5422.40353561108, 5433.8369848904595, 5487.259220005328, 4894.437139728977, 4930.11257973561, 4948.975255123773, 5050.74746262689, 5073.847784566469, 5400.21696853954, 5430.266913966564, 5439.238506609078, 5442.537384322298, 5444.91832622511, 5160.716160611202, 5308.23030660552, 5329.733513324319, 5342.439043900335, 5363.356397232357, 5263.0000299942885, 5381.515663590296, 5392.191171324333, 5394.163904594794, 5395.05586522357, 5273.841784746463, 5300.814471493479, 5315.867103322448, 5331.893362132736, 5391.7304134793885, 5201.713905735145, 5228.686278823283, 5316.680999140064, 5324.946750532445, 5351.036813373552, 4508.413906192174, 4540.046590216026, 4548.772561371984, 4548.818047278071, 4574.428196475441, 3897.1231472918935, 3952.110775075585, 3956.643902048829, 3980.283548961157, 3983.0, 4598.0, 4641.327007583882, 4676.0647870426055, 4691.108689349013, 4697.95302046982, 5455.454454554513, 5465.863353416196, 5471.452854714496, 5474.124140137559, 5495.0383682855345, 4687.484376718558, 4693.131770622445, 4704.95295047052, 4722.811087556528, 4763.666543342002, 4723.126221649006, 4727.881802954954, 4753.786079626425, 4857.441394239637, 4902.0, 4990.700557966534, 5005.0, 5006.173981293192, 5006.173981293192, 5031.245313203049, 5293.364796224478, 5355.598330125178, 5356.785728570813, 5363.356397232357, 5443.7278136092245, 5063.696178229318, 5078.7206703631655, 5087.64386492942, 5125.1799712045895, 5136.280920671184, 5284.180951952453, 5339.866503337447, 5349.224362467498, 5358.98179345923, 5401.729913504388, 5304.893902122013, 5334.839954801362, 5439.102548079522, 5441.700706461183, 5448.7548060336585, 5221.190715439113, 5230.424653288059, 5267.552258058108, 5284.709340986129, 5305.1776974569, 5244.842654720364, 5274.077036518671, 5290.735463226746, 5295.099833028471, 5303.708296043755, 5053.191489361684, 5174.379074511083, 5215.530602245816, 5228.398734145622, 5231.215317702375, 5190.6107041971245, 5294.0, 5296.523312901857, 5335.67985920846, 5339.492748188916, 5139.665921715076, 5141.871453213699, 5144.897102058013, 5149.407818100966, 5149.56228720548], "value": 4930.36923961672, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [675.8141511084451, 703.750168690115, 728.1589763822785, 779.9922000779994, 788.503242956937, 31014.689853101492, 32138.0, 32142.03573892781, 32172.195695107606, 32212.67787322129, 32850.8357458213, 33185.0, 33202.019697045456, 33390.66609333906, 33391.16522086949, 7124.85750284994, 7244.71021159153, 7280.6723697433745, 8774.561271936409, 8983.416077954944, 8921.687740929035, 9044.3668943174, 9046.050164732707, 9048.230900373475, 9056.139666731682, 9001.324900632446, 9057.637694492212, 9081.046490118508, 9081.59132839024, 9238.86141707875, 9169.449833010041, 9217.0, 9236.21492173166, 9265.305102117369, 9282.76793080175, 9060.456372617664, 9103.726888193365, 9107.954460227722, 9111.179993800524, 9121.361504694674, 33794.49308260378, 33957.6604233957, 33961.49057764136, 33981.0, 34003.82998085018, 3415.0949998250485, 3440.896773096786, 3441.177496772661, 3516.4373700207843, 3530.117470632342, 23729.28812135639, 23962.0, 24050.759492405028, 24103.638445423334, 24214.39464013396, 2803.6635603727477, 2806.3405099801735, 2903.6805951345336, 2983.8806447742063, 2985.6118704568266, 150890.24554877155, 151188.0, 151667.0, 152133.0, 152589.0, 42280.788596056824, 42341.36487952621, 42417.0, 42435.0, 42495.36256956148, 43340.133197335876, 43841.78079109648, 43881.78059109748, 43935.56064439379, 43967.12065758667, 12667.809982850265, 12879.162854414433, 13023.869761302456, 13054.216746995211, 13138.014648901179, 10183.287169898036, 10221.897781022244, 10243.282970192015, 10288.0, 10338.793224135625, 12653.0, 13296.800547991788, 13325.600231993056, 13325.73348533024, 13629.18224906489, 5370.516653501126, 5462.657187535919, 5463.426340234298, 5466.234727138124, 5651.660900345993, 851.3614788908319, 888.7111688701198, 900.4417261298037, 900.7522931193975, 922.7739203894954, 24191.637125443132, 25221.747782522307, 25336.873315633304, 25369.492610147692, 25467.745322546536, 939.6147579492512, 958.0563145301873, 968.5157421289356, 969.6945462179391, 970.0784254957678, 13101.541446049343, 13397.53108641193, 13631.931840340734, 13688.384022719001, 13702.0, 215260.0, 215656.0, 216679.0, 216946.0, 217440.0, 42947.35578966318, 43325.0, 43332.56667433348, 43382.349264761055, 43386.566134338886, 1210.86680465147, 1238.5169783784331, 1239.78303796837, 1244.122893360197, 1245.3461932485336, 21987.34037978863, 23033.539329213658, 23147.65278520857, 23396.6490502646, 23399.298021059396, 29067.0, 29131.417371652024, 29161.0, 29204.26989325284, 29220.26949326284, 149669.0, 178230.0, 178510.0, 178653.0, 178757.0, 26093.608595871458, 26771.33071673224, 26800.463990719687, 26913.865430673504, 26975.730242698108, 31848.36303273875, 32487.18782030468, 32594.185145371557, 32601.510977335834, 32825.34349312953, 27284.454310913272, 27430.0, 27449.725502744717, 27729.861350693925, 28526.85736571304, 27306.590401144396, 27440.725592743816, 27777.44445111127, 28382.0, 28655.42689146247, 28137.155885323475, 28380.574291385234, 28965.56551651769, 28995.85502072476, 29032.274193145342, 24098.67457289796, 24496.755032449448, 25170.37074073163, 25895.352616184748, 26350.077747278752, 20010.29963951255, 20263.898680506503, 20358.59282814365, 20411.0609492098, 20610.175592976713], "value": 15214.322431074574, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.7722075637643, 407.6107317511773, 412.7090401267106, 423.28676180635625, 425.03517016372837, 13306.467741290337, 17530.29878804848, 18073.909630451828, 18139.546511337223, 18244.270229190817, 17331.133443327846, 17538.29846806126, 18003.549911252194, 18851.717224241613, 19124.33064842731, 5625.831225063234, 5650.943490565103, 5810.883782324372, 5838.474537291643, 5882.617629854067, 5190.870228244286, 5220.686758794465, 5223.268742376071, 5225.660332078422, 5232.084385232588, 5201.40183878855, 5208.76560554774, 5326.0, 5726.656400615955, 5766.82699519013, 5749.913751293734, 5784.56615753818, 5813.418658134195, 5820.941790582104, 5837.299524057098, 5510.724463776795, 5566.276384070045, 5676.687782171979, 5691.0, 5692.686902220376, 21873.234436794635, 21897.890510547346, 22191.0, 22195.11219551216, 22343.0, 2203.10774136475, 2203.9449013774624, 2230.620794464945, 2240.6078936186104, 2257.074599414232, 13755.518556850562, 14028.71942561143, 14110.365033573515, 14941.0, 14997.925010374987, 1700.319872051177, 1732.4802559232305, 1774.3612299572144, 1781.8752687311894, 1792.686279901012, 91365.0, 92143.0, 93567.53216233943, 93990.53004734933, 94844.52577737137, 15776.526704198892, 16487.91756041236, 16695.998240105633, 16755.2460139294, 17351.392701255394, 26010.34974125662, 28694.856525717238, 29066.854665726536, 29094.0, 29251.414971700447, 8350.0, 8435.662573497115, 8537.359698022674, 8671.566421679017, 8765.167309105625, 6900.723971041102, 6991.440684745208, 7000.439964802804, 7157.105361829771, 7164.605946672878, 8359.623816928253, 9147.758799094265, 9215.354925155174, 9307.627694892264, 9377.202937750231, 3666.138457462494, 3746.662800347982, 3759.0978165240695, 3763.454299126611, 3775.320442320409, 835.4277320035795, 856.6958729650884, 866.9306455483546, 880.8284980975416, 886.7472770260574, 18456.0, 19134.52163695891, 20167.394978150678, 20177.39467815968, 20401.48996275105, 897.2507955856802, 897.3539051882634, 897.9326550508738, 903.810199858024, 911.9407238529475, 10677.0, 10766.407847568302, 10830.317711916092, 10870.347779133277, 10880.78238435227, 464976.0, 475616.32877534325, 481201.0, 489034.0, 490298.0, 93236.0, 94110.0, 95059.0, 95405.0, 95849.12452626432, 1157.976840463186, 1228.502456505117, 1233.216907263894, 1247.1207798501853, 1254.0531898416637, 16280.511584652479, 16319.918400407922, 16432.917835410746, 16800.57998550046, 16898.577535561708, 33626.32747345088, 37369.03376018631, 37969.24061518809, 42528.5747142537, 44043.779781100886, 51569.0, 51821.0, 52135.0, 53767.46232537625, 54466.18300725413, 10503.212259080752, 10531.315464494783, 10828.404437755999, 11042.668719938414, 11305.547778089114, 12699.746005079662, 12879.291638959947, 12982.091253612156, 13333.933330333286, 13382.397792099573, 10499.842502362624, 10548.578056877946, 10831.891681083403, 10912.563497460013, 11143.777124457627, 9994.250431217833, 10703.678889633324, 10770.838437423288, 11032.613858514913, 11275.605353812578, 11197.328160310408, 11271.380074096003, 11292.096632269562, 11330.886691132982, 11751.76496470083, 10890.945545272223, 10903.781924361627, 11032.172587056164, 11273.267237629529, 11279.32324060559, 10329.276950613385, 10427.895721042692, 10451.268411211142, 10835.566577336818, 10878.184136189659], "value": 9827.101620773163, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1449.8332691740452, 1458.9854101458975, 1470.698506806105, 1472.1461552299668, 1533.2257210108894, 7997.240262175084, 8083.70660694289, 8936.329775266857, 9219.308551858612, 9309.34834561581, 9146.679866204684, 9465.053494650532, 9469.715908522738, 9470.905290947088, 9486.193673537757, 2043.8160565549097, 2063.762667293258, 2074.844386671006, 2077.553326034902, 2085.833133349336, 1956.520652440147, 1998.5003749062735, 2000.239908834648, 2003.048551937825, 2005.0175414047085, 1982.3656429942423, 1995.750531183602, 1997.8901160436171, 2004.2383894120214, 2006.8494862885268, 1959.9706004409945, 1968.714536392215, 1969.4091772468203, 1973.6644770388996, 1980.5939782344728, 1830.7528483654803, 1840.5306646805113, 1892.4228110426313, 1999.5800881814691, 2022.9885057471265, 9645.08371704687, 9670.0, 9700.660476883275, 9730.41617502952, 9733.124018838338, 4582.747948862811, 4714.222153344694, 4741.454732705714, 4760.309755085494, 4760.833370832004, 2633.3153380121116, 2802.523570992936, 2853.8145020573597, 2854.9714502854913, 2859.1422573227946, 952.7189479103681, 1010.368519675203, 1036.6371769880482, 1036.7978244242377, 1047.4186826311395, 12637.74724505514, 12721.236725796389, 12722.173058751245, 12726.87273127266, 12780.169288996185, 3647.1611529348397, 3932.9016774580864, 3990.06233535119, 4025.215083058834, 4029.49631296088, 11146.609868654557, 11165.665030049111, 11278.266912650652, 11296.322220666787, 11313.71715707114, 4571.977140114344, 4585.358049873021, 4585.358049873021, 4595.379623750818, 4597.126545956257, 3584.946225806615, 3703.166787472797, 4045.959540404558, 4130.752154870717, 4218.303979843292, 3497.982510087433, 3600.4419315006216, 3600.98199509006, 3640.7633503822167, 3747.0445036515516, 1011.2516737614112, 1040.661784919904, 1049.4490392543976, 1054.3779170289565, 1057.7778666479971, 823.3372135430916, 831.3556993330218, 835.5362773660677, 851.9574021298911, 857.5883575883486, 5279.0, 5289.312389389432, 5387.973060134675, 5533.446655334515, 5539.639923404966, 856.9442986205877, 865.9307255419551, 867.8307729992717, 875.3391189651772, 900.7297810656777, 3230.6607806180014, 3256.3812875553567, 3268.967310326914, 3325.600927888669, 3352.513885486591, 11145.219834611662, 11505.367204803817, 11580.942095289469, 11615.709607259887, 11624.186306958602, 11443.713907152222, 11483.712907177387, 11502.309861408343, 11569.595064172714, 11578.594749183738, 8126.146754590801, 8178.386621003448, 8448.112948140357, 8451.53516556583, 8591.613377398033, 5436.374816896107, 5608.495235428831, 5689.573282003949, 5728.828135155952, 5766.308043034863, 10077.244206684381, 10139.239557033105, 10160.339577927707, 10286.691399258034, 10436.321639093434, 10196.592136314464, 10284.177265818866, 10359.63741269052, 10447.94776026115, 10547.525361358605, 7882.605869706606, 8107.635156418093, 8124.471909326111, 8202.26179643835, 8255.339572834278, 9070.0, 9098.181163695299, 9135.954320228357, 9169.77075573116, 9175.495347755937, 7852.646630901738, 7908.4464087513325, 7926.920730792618, 7927.603619819101, 7946.364290856834, 7698.461107722405, 7728.304452599293, 7942.682292708227, 8000.319972802145, 8001.3598912088055, 6862.348076932683, 6940.375366217065, 7020.7542736004, 7102.857942841218, 7181.35367816899, 5065.189569668835, 5150.793968241378, 5203.11547036997, 5203.401608814884, 5240.423553409199, 5119.360079990001, 5216.921746173886, 5224.52979231871, 5258.106121959353, 5270.077736396192], "value": 4396.41760002271, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.7162270183854, 359.72301327977476, 362.64641974075266, 370.02867472883673, 379.5843551311313, 5082.364704411949, 5268.789248430067, 5382.461753824616, 5418.187271909215, 5454.345478542576, 5133.563647090002, 5230.9738451307785, 5283.154695248761, 5311.362636483627, 5339.5461385782155, 4601.102784956943, 4629.629629629639, 4634.0, 4634.6987445816085, 4650.627949764011, 4495.258282383403, 4613.838515651953, 4615.746133962631, 4632.58706094641, 4636.211843986531, 4577.679562430631, 4603.838865639704, 4616.722996620197, 4624.953750462486, 4631.861044168681, 4593.56361145689, 4596.517365676606, 4605.769711514411, 4612.46956599992, 4630.513796051399, 3886.844526218948, 4054.736442131252, 4471.2398892188085, 4478.1043791241555, 4481.7983190756495, 5137.33214682089, 5148.897022059537, 5160.612954028463, 5174.456682048369, 5179.456157103487, 5095.898082038376, 5102.591792656579, 5106.5659418949435, 5121.871953201163, 5122.462141475166, 5410.6510995983945, 5570.3315602128005, 5587.525060369833, 5605.355384130796, 5615.887682246373, 4477.77611119446, 4495.0, 4498.347739577775, 4504.864854054351, 4507.16617425774, 5632.295963004624, 5733.88532229353, 5788.797392091299, 5859.355470898197, 5950.791722289742, 4620.72929944268, 4634.165850147006, 4635.629149668019, 4635.629149668019, 4641.860744177612, 4686.835960741358, 4702.3416721659, 4704.435467743824, 4713.0, 4720.103180395714, 4858.562729354305, 5046.6719663221775, 5053.418856831511, 5088.643794934393, 5105.719185444762, 5531.197976293495, 5533.972330138324, 5539.698170929828, 5541.806036788774, 5580.218769372291, 1635.4357746577411, 1638.5248277999485, 1657.7430498272788, 1665.76679264903, 1666.5000499849996, 1225.5526732742485, 1228.5515786737776, 1240.2434514945876, 1247.7504499100216, 1259.307380940479, 4889.462159162489, 4905.288733133676, 4907.607391408679, 4929.0, 4930.309756634074, 5761.798337058183, 5780.739866706008, 5802.912956305659, 5825.242718446575, 5828.154917536934, 4753.548412900769, 4848.95151048485, 4922.680025798311, 4937.827176048893, 4944.157109661959, 3056.2359410147465, 3083.522054081621, 3084.3677046205476, 3089.891853785107, 3092.0105566219045, 5294.973525132426, 5383.623146379716, 5397.622166448311, 5408.269883565747, 5412.458754124556, 5823.213866128019, 5858.912116318259, 5873.911891321633, 5886.35182148999, 5905.822825315247, 5346.679199248058, 5359.410464848864, 5389.164679474688, 5389.272448219519, 5389.541888939484, 5571.860703482445, 5739.0, 5765.971170144123, 5816.534677225727, 5817.95276850171, 5355.22349259363, 5671.291088613923, 5695.487406133468, 5705.486506214461, 5709.25779648643, 5239.633225674166, 5264.473552644705, 5335.505244065143, 5363.973180134074, 5371.677699338053, 4626.467956184947, 4636.698614590041, 4646.071880169692, 4656.790444430077, 4662.810983199262, 5701.173329867229, 5730.828075157752, 5757.6545407274025, 5826.650400975955, 5837.795677151279, 5565.693886836263, 5579.804706835242, 5587.664740115606, 5599.8880022400135, 5607.5513958884, 5574.303212098488, 5593.776248950159, 5596.41237670055, 5597.481133489864, 5630.5214056805635, 5267.7366131694025, 5519.0, 5538.667679939055, 5555.527780138734, 5560.36055853582, 5660.32076150848, 5672.517835983987, 5681.9147712783515, 5688.715564221855, 5689.573282003784, 5243.790248390022, 5483.629092726818, 5523.226748255167, 5528.143137813645, 5529.944700552943], "value": 4417.386164758805, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [673.952823302369, 686.2999740264927, 719.0508528742063, 733.5635296998286, 772.2933515833012, 12140.210886292396, 12615.873841261597, 12971.221726696393, 13070.869291307084, 13279.601611951633, 12846.48614055439, 12893.613191604243, 12975.870241297584, 13134.474621015172, 13165.539206127787, 845.1295165979052, 847.0343808058802, 862.241227719609, 863.9265662418702, 863.9870401943975, 876.4609764994515, 883.770219742865, 884.164464580968, 885.3094586222725, 885.8272636835819, 920.5443305563755, 926.7127190570944, 927.717046300878, 927.9211267042309, 929.326238477102, 905.2215095018279, 916.9174774270315, 916.9220616247594, 919.0396036142214, 921.6221349246844, 670.8825955457825, 674.4132604633951, 674.578388507183, 675.4393853101963, 675.7398401615364, 13145.211287322696, 13573.11774734649, 14880.776788348183, 14953.0, 14975.176365300013, 12934.935325323408, 13821.861781382258, 14136.22250776207, 14459.927700361432, 14684.609083098623, 9841.704748857546, 9883.505824708807, 9922.0, 9942.90057099427, 10063.69808905734, 2813.3388653666575, 2906.781991350636, 2944.131481213047, 2962.718541738553, 3206.0, 31188.37623247545, 42453.36319955203, 52208.2168767465, 56351.71824140894, 58209.417905820825, 11045.477261369315, 11269.0, 11290.774184516264, 11451.770964580663, 11859.407029648482, 19151.904240478707, 19883.403497895088, 19894.303699370743, 20890.791092089188, 21079.0, 6410.935890641033, 6647.66761661915, 6736.5284430090405, 6779.72881084751, 6904.654767261617, 3370.7134893534326, 3448.965310406868, 3477.739169562293, 3491.2493813830147, 3511.227529943408, 3133.3576616793503, 3259.282957749291, 3259.331836973462, 3264.069740124053, 3277.2462333663393, 518.9636725429184, 522.0524747583124, 522.1488972974028, 523.3641126031889, 534.9491798279157, 620.6803496199461, 655.0, 662.5428454366568, 664.1200409457488, 670.8591195848829, 8599.226069653761, 8972.730818075468, 9358.859617105749, 9387.859182112274, 9775.026333048507, 622.791364892757, 627.4290395739855, 641.8652083062516, 641.8748344072861, 645.4513663386084, 4012.578679238696, 4306.590873866978, 4313.977786754809, 4342.413774140514, 4353.869383918487, 62141.0, 62556.68721656362, 62833.0, 63317.366826332065, 64222.35777642257, 39805.402918956235, 44529.777351113684, 46044.30933536, 46492.302615460794, 52398.47601524012, 45760.7711961438, 45839.54160458419, 46035.53964460312, 46610.06779864384, 46856.297155543376, 8937.821243574963, 9609.951950240204, 9647.228221742384, 9690.709278721368, 9739.805203896025, 32041.67958320387, 32115.678843212205, 32222.677773222906, 32994.17514562155, 33083.66916330902, 38041.4293785599, 38261.0, 38452.80773596114, 39133.60866391299, 39586.604133959445, 11616.361100139573, 11666.88333116658, 11764.529418823151, 11866.110041746731, 12335.198212116184, 11337.26307789991, 11346.262492937933, 11511.712207194887, 11636.88363116358, 11720.88279117198, 12699.55551555691, 12743.490260389852, 13233.933830330787, 13450.86549134496, 13476.460941562227, 11747.588834390755, 11975.700607484534, 12269.447874845475, 12781.16922400041, 12848.421821018264, 11783.175177737476, 12373.814392784296, 12387.75224495523, 12522.623588363092, 12603.873961260637, 9843.60625574969, 9844.458554779556, 10191.796164076824, 10200.2349823765, 10478.318909270873, 9347.719568412958, 9906.356086854332, 9944.0, 9956.402615843073, 10002.349847259904], "value": 6381.353594880579, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1586.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 119.0, 118.0, 119.0, 119.0, 118.0, 119.0, 120.0, 119.0, 119.0], "value": 118.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 125.0, 125.0, 186.0, 135.0, 128.0, 125.0, 127.0, 150.0, 126.0], "value": 138.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 173.0, 168.0, 170.0, 176.0, 165.0, 165.0, 166.0, 163.0, 164.0], "value": 167.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 78.0, 108.0, 77.0, 76.0, 78.0, 81.0, 99.0, 76.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 91.0, 115.0, 88.0, 84.0, 85.0, 105.0, 86.0, 86.0, 114.0], "value": 94.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 115.0, 114.0, 118.0, 114.0, 113.0, 115.0, 114.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 151.0, 150.0, 150.0, 151.0, 151.0, 151.0, 149.0, 151.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 95.0, 94.0, 94.0, 96.0, 94.0, 95.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 69.0, 70.0, 70.0, 69.0, 69.0, 69.0, 70.0, 71.0], "value": 69.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 57.0, 57.0, 57.0, 57.0, 57.0, 57.0, 58.0, 59.0], "value": 57.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 86.0, 85.0, 85.0, 84.0, 85.0, 84.0, 84.0, 84.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 140.0, 144.0, 147.0, 152.0, 134.0, 139.0, 141.0, 202.0, 137.0], "value": 148.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 196.0, 185.0, 196.0, 200.0, 197.0, 186.0, 192.0, 195.0, 187.0], "value": 191.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 78.0, 74.0, 74.0, 78.0, 80.0, 71.0, 71.0, 74.0], "value": 74.8, "unit": "score"}]}]} 15:17:17 INFO - Return code: 0 15:17:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:17:17 ERROR - # TBPL SUCCESS # 15:17:17 INFO - Running post-action listener: _resource_record_post_action 15:17:17 INFO - [mozharness: 2017-03-15 22:17:17.106595Z] Finished run-tests step (success) 15:17:17 INFO - Running post-run listener: _resource_record_post_run 15:17:17 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 12288; Write bytes: 360595456; Read time: 420; Write time: 335328 15:17:17 INFO - TinderboxPrint: CPU usage
13.4% 15:17:17 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 420 15:17:17 INFO - TinderboxPrint: I/O write bytes / time
360,595,456 / 335,328 15:17:17 INFO - TinderboxPrint: CPU idle
8,318.4 (86.6%) 15:17:17 INFO - TinderboxPrint: CPU user
1,221.6 (12.7%) 15:17:17 INFO - TinderboxPrint: Swap in / out
0 / 0 15:17:17 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107728896; Read time: 0; Write time: 138436 15:17:17 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 12288; Write bytes: 252866560; Read time: 420; Write time: 196892 15:17:17 INFO - Running post-run listener: _upload_blobber_files 15:17:17 INFO - Blob upload gear active. 15:17:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:17:17 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 15:17:17 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'] 15:17:17 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 15:17:18 INFO - (blobuploader) - INFO - Open directory for files ... 15:17:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:17:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:17:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:17:19 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:17:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:17:19 INFO - (blobuploader) - INFO - Done attempting. 15:17:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:17:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:17:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:17:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:17:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:17:23 INFO - (blobuploader) - INFO - Done attempting. 15:17:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:17:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:17:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:17:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:17:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:17:24 INFO - (blobuploader) - INFO - Done attempting. 15:17:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:17:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:17:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:17:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:17:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:17:24 INFO - (blobuploader) - INFO - Done attempting. 15:17:24 INFO - (blobuploader) - INFO - Iteration through files over. 15:17:24 INFO - Return code: 0 15:17:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:17:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:17:24 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8934ab3c24ecddaddf7df6ef51afabe5f638fe443183ce723d0720c18f8953f0939178efb5d90fdb5b9398680b6f52133786373dee2450fbfe57b9ad2e6838b5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/36d7f0f66b3a598d5bf95c4f6cb8d9f4d80aec25949c04c3adf4b2e027a42e866394c83d0d63bf365b9f35c7d7a23171c74c4d11e1fd273f86d16ed53e9ae0c0", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/909aea72a6c9d7774259f4e669d5df05e48f733644c65e50a4a5f34bd226ce2934835f56058bc8c6bb05041639e1b5adfb170f8a41112e2e446fe7b6fcb84716", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/acf8d8391a92df4bbcc06fe2836e0e5f1eb3a6600cc8e606a61c2b01892d2ddb89a5263c6cdcbeaab27c4c834dd6546992054b00c947edf50984a40f4a363e5f"} 15:17:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:17:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:17:24 INFO - Contents: 15:17:24 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8934ab3c24ecddaddf7df6ef51afabe5f638fe443183ce723d0720c18f8953f0939178efb5d90fdb5b9398680b6f52133786373dee2450fbfe57b9ad2e6838b5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/36d7f0f66b3a598d5bf95c4f6cb8d9f4d80aec25949c04c3adf4b2e027a42e866394c83d0d63bf365b9f35c7d7a23171c74c4d11e1fd273f86d16ed53e9ae0c0", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/909aea72a6c9d7774259f4e669d5df05e48f733644c65e50a4a5f34bd226ce2934835f56058bc8c6bb05041639e1b5adfb170f8a41112e2e446fe7b6fcb84716", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/acf8d8391a92df4bbcc06fe2836e0e5f1eb3a6600cc8e606a61c2b01892d2ddb89a5263c6cdcbeaab27c4c834dd6546992054b00c947edf50984a40f4a363e5f"} 15:17:24 INFO - Running post-run listener: copy_logs_to_upload_dir 15:17:24 INFO - Copying logs to upload dir... 15:17:24 INFO - mkdir: /builds/slave/test/build/upload/logs 15:17:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.678701 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-15 15:17:24.566898) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-15 15:17:24.570525) ========= 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=df17445c3590ff7897617a0e00000225-1489614980.556820-239714012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8934ab3c24ecddaddf7df6ef51afabe5f638fe443183ce723d0720c18f8953f0939178efb5d90fdb5b9398680b6f52133786373dee2450fbfe57b9ad2e6838b5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/36d7f0f66b3a598d5bf95c4f6cb8d9f4d80aec25949c04c3adf4b2e027a42e866394c83d0d63bf365b9f35c7d7a23171c74c4d11e1fd273f86d16ed53e9ae0c0", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/909aea72a6c9d7774259f4e669d5df05e48f733644c65e50a4a5f34bd226ce2934835f56058bc8c6bb05041639e1b5adfb170f8a41112e2e446fe7b6fcb84716", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/acf8d8391a92df4bbcc06fe2836e0e5f1eb3a6600cc8e606a61c2b01892d2ddb89a5263c6cdcbeaab27c4c834dd6546992054b00c947edf50984a40f4a363e5f"} build_url:https://queue.taskcluster.net/v1/task/MaOVz0A5TrG585fazLri1A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011285 build_url: 'https://queue.taskcluster.net/v1/task/MaOVz0A5TrG585fazLri1A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8934ab3c24ecddaddf7df6ef51afabe5f638fe443183ce723d0720c18f8953f0939178efb5d90fdb5b9398680b6f52133786373dee2450fbfe57b9ad2e6838b5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/36d7f0f66b3a598d5bf95c4f6cb8d9f4d80aec25949c04c3adf4b2e027a42e866394c83d0d63bf365b9f35c7d7a23171c74c4d11e1fd273f86d16ed53e9ae0c0", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/909aea72a6c9d7774259f4e669d5df05e48f733644c65e50a4a5f34bd226ce2934835f56058bc8c6bb05041639e1b5adfb170f8a41112e2e446fe7b6fcb84716", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/acf8d8391a92df4bbcc06fe2836e0e5f1eb3a6600cc8e606a61c2b01892d2ddb89a5263c6cdcbeaab27c4c834dd6546992054b00c947edf50984a40f4a363e5f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-15 15:17:24.595634) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 15:17:24.595960) ========= 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=df17445c3590ff7897617a0e00000225-1489614980.556820-239714012 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 15:17:24.677969) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-15 15:17:24.678338) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-15 15:17:24.678627) ========= ========= Total master_lag: 0.17 =========