builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-004 starttime: 1490111821.15 results: success (0) revision: 31172c0751dd45780a57e92a688c1f54cc01fe63 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 08:57:01.146619) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 08:57:01.147120) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 08:57:01.147431) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 08:57:01.162044) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 08:57:01.162336) ========= 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=c6927cf182745ad25b1d38b9000001fe-1490111820.436670-1291451011 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-21 08:57:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2017-03-21 08:57:01 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124148 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 08:57:01.300556) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 08:57:01.301004) ========= 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=c6927cf182745ad25b1d38b9000001fe-1490111820.436670-1291451011 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014166 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 08:57:01.351107) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 08:57:01.351474) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 31172c0751dd45780a57e92a688c1f54cc01fe63 --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 31172c0751dd45780a57e92a688c1f54cc01fe63 --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=c6927cf182745ad25b1d38b9000001fe-1490111820.436670-1291451011 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-21 08:57:01,671 truncating revision to first 12 chars 2017-03-21 08:57:01,672 Setting DEBUG logging. 2017-03-21 08:57:01,672 attempt 1/10 2017-03-21 08:57:01,672 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/31172c0751dd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-21 08:57:02,010 unpacking tar archive at: mozilla-central-31172c0751dd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.632582 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 08:57:02.001356) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 08:57:02.002150) ========= script_repo_revision: 31172c0751dd45780a57e92a688c1f54cc01fe63 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 08:57:02.003174) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 08:57:02.003865) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 08:57:02.016134) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-03-21 08:57:02.016556) ========= /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=c6927cf182745ad25b1d38b9000001fe-1490111820.436670-1291451011 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:57:02 INFO - MultiFileLogger online at 20170321 08:57:02 in /builds/slave/test 08:57:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:57:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:57:02 INFO - {'append_to_log': False, 08:57:02 INFO - 'base_work_dir': '/builds/slave/test', 08:57:02 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:57:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:57:02 INFO - 'branch': 'Firefox-Non-PGO', 08:57:02 INFO - 'buildbot_json_path': 'buildprops.json', 08:57:02 INFO - 'config_files': ('talos/linux_config.py',), 08:57:02 INFO - 'default_actions': ('clobber', 08:57:02 INFO - 'read-buildbot-config', 08:57:02 INFO - 'download-and-extract', 08:57:02 INFO - 'populate-webroot', 08:57:02 INFO - 'create-virtualenv', 08:57:02 INFO - 'install', 08:57:02 INFO - 'run-tests'), 08:57:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:57:02 INFO - 'download_minidump_stackwalk': True, 08:57:02 INFO - 'download_symbols': 'ondemand', 08:57:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:57:02 INFO - 'tooltool.py': '/tools/tooltool.py', 08:57:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:57:02 INFO - '/tools/misc-python/virtualenv.py')}, 08:57:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:57:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:57:02 INFO - 'gecko_profile': False, 08:57:02 INFO - 'gecko_profile_interval': 0, 08:57:02 INFO - 'installer_path': 'installer.exe', 08:57:02 INFO - 'log_level': 'info', 08:57:02 INFO - 'log_name': 'talos', 08:57:02 INFO - 'log_to_console': True, 08:57:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:57:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:57:02 INFO - 'opt_config_files': (), 08:57:02 INFO - 'pip_index': False, 08:57:02 INFO - 'suite': 'dromaeojs-e10s', 08:57:02 INFO - 'system_bits': '32', 08:57:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:57:02 INFO - 'title': 'talos-linux64-ix-004', 08:57:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:57:02 INFO - 'use_talos_json': True, 08:57:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:57:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:57:02 INFO - 'work_dir': 'build'} 08:57:02 INFO - [mozharness: 2017-03-21 15:57:02.441695Z] Running clobber step. 08:57:02 INFO - Running pre-action listener: _resource_record_pre_action 08:57:02 INFO - Running main action method: clobber 08:57:02 INFO - rmtree: /builds/slave/test/build 08:57:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:57:04 INFO - Running post-action listener: _resource_record_post_action 08:57:04 INFO - [mozharness: 2017-03-21 15:57:04.035101Z] Finished clobber step (success) 08:57:04 INFO - [mozharness: 2017-03-21 15:57:04.035200Z] Running read-buildbot-config step. 08:57:04 INFO - Running pre-action listener: _resource_record_pre_action 08:57:04 INFO - Running main action method: read_buildbot_config 08:57:04 INFO - Using buildbot properties: 08:57:04 INFO - { 08:57:04 INFO - "project": "", 08:57:04 INFO - "product": "firefox", 08:57:04 INFO - "who": "ffxbld@noreply.mozilla.org", 08:57:04 INFO - "installer_path": "public/build/target.tar.bz2", 08:57:04 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:57:04 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:57:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:57:04 INFO - "stage_platform": "linux64", 08:57:04 INFO - "basedir": "/builds/slave/test", 08:57:04 INFO - "buildnumber": 763, 08:57:04 INFO - "platform": "ubuntu64_hw", 08:57:04 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:57:04 INFO - "slavebuilddir": "test", 08:57:04 INFO - "taskId": "PXY7FlCITJyWCHN00W3Bew", 08:57:04 INFO - "branch": "mozilla-central", 08:57:04 INFO - "script_repo_revision": "production", 08:57:04 INFO - "revision": "31172c0751dd45780a57e92a688c1f54cc01fe63", 08:57:04 INFO - "slavename": "talos-linux64-ix-004", 08:57:04 INFO - "repo_path": "mozilla-central" 08:57:04 INFO - } 08:57:04 INFO - Finding installer, test and symbols from parent task. 08:57:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PXY7FlCITJyWCHN00W3Bew'}, attempt #1 08:57:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PXY7FlCITJyWCHN00W3Bew'}, attempt #1 08:57:04 INFO - Task dependencies: T-7Yh0DbT_Supooniosh_w 08:57:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T-7Yh0DbT_Supooniosh_w'}, attempt #1 08:57:05 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/T-7Yh0DbT_Supooniosh_w/artifacts/public/build/target.tar.bz2 08:57:05 INFO - Set test_url: https://queue.taskcluster.net/v1/task/T-7Yh0DbT_Supooniosh_w/artifacts/public/build/test_packages.json 08:57:05 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/T-7Yh0DbT_Supooniosh_w/artifacts/public/build/target.crashreporter-symbols.zip 08:57:05 INFO - Running post-action listener: _resource_record_post_action 08:57:05 INFO - [mozharness: 2017-03-21 15:57:05.420455Z] Finished read-buildbot-config step (success) 08:57:05 INFO - [mozharness: 2017-03-21 15:57:05.420672Z] Running download-and-extract step. 08:57:05 INFO - Running pre-action listener: _resource_record_pre_action 08:57:05 INFO - Running main action method: download_and_extract 08:57:05 INFO - mkdir: /builds/slave/test/build/tests 08: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')]} 08:57:05 INFO - trying https://queue.taskcluster.net/v1/task/T-7Yh0DbT_Supooniosh_w/artifacts/public/build/target.test_packages.json 08:57:05 INFO - Downloading https://queue.taskcluster.net/v1/task/T-7Yh0DbT_Supooniosh_w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:57:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T-7Yh0DbT_Supooniosh_w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:57:05 INFO - Downloaded 986 bytes. 08:57:05 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:57:05 INFO - Using the following test package requirements: 08:57:05 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:57:05 INFO - u'common': [u'target.common.tests.zip'], 08:57:05 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:57:05 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:57:05 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:57:05 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:57:05 INFO - u'mozbase': [u'target.common.tests.zip'], 08:57:05 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:57:05 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:57:05 INFO - u'web-platform': [u'target.common.tests.zip', 08:57:05 INFO - u'target.web-platform.tests.zip'], 08:57:05 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:57:05 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:57:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T-7Yh0DbT_Supooniosh_w/artifacts/public/build/target.common.tests.zip 08:57:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T-7Yh0DbT_Supooniosh_w/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:57:05 INFO - Fetch https://queue.taskcluster.net/v1/task/T-7Yh0DbT_Supooniosh_w/artifacts/public/build/target.common.tests.zip into memory 08:57:07 INFO - Expected file size: 58196672 08:57:07 INFO - Obtained file size: 58196672 08:57:16 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:57:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T-7Yh0DbT_Supooniosh_w/artifacts/public/build/target.common.tests.zip 08:57:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T-7Yh0DbT_Supooniosh_w/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:57:16 INFO - Fetch https://queue.taskcluster.net/v1/task/T-7Yh0DbT_Supooniosh_w/artifacts/public/build/target.common.tests.zip into memory 08:57:18 INFO - Expected file size: 58196672 08:57:18 INFO - Obtained file size: 58196672 08:57:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T-7Yh0DbT_Supooniosh_w/artifacts/public/build/target.talos.tests.zip 08:57:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T-7Yh0DbT_Supooniosh_w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:57:28 INFO - Fetch https://queue.taskcluster.net/v1/task/T-7Yh0DbT_Supooniosh_w/artifacts/public/build/target.talos.tests.zip into memory 08:57:29 INFO - Expected file size: 14404171 08:57:29 INFO - Obtained file size: 14404171 08: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')]} 08:57:29 INFO - trying https://queue.taskcluster.net/v1/task/T-7Yh0DbT_Supooniosh_w/artifacts/public/build/target.tar.bz2 08:57:29 INFO - Downloading https://queue.taskcluster.net/v1/task/T-7Yh0DbT_Supooniosh_w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:57:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T-7Yh0DbT_Supooniosh_w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:57:31 INFO - Downloaded 61792164 bytes. 08:57:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T-7Yh0DbT_Supooniosh_w/artifacts/public/build/target.tar.bz2 08:57:31 INFO - mkdir: /builds/slave/test/properties 08:57:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:57:31 INFO - Writing to file /builds/slave/test/properties/build_url 08:57:31 INFO - Contents: 08:57:31 INFO - build_url:https://queue.taskcluster.net/v1/task/T-7Yh0DbT_Supooniosh_w/artifacts/public/build/target.tar.bz2 08:57:31 INFO - Running post-action listener: _resource_record_post_action 08:57:31 INFO - Running post-action listener: set_extra_try_arguments 08:57:31 INFO - [mozharness: 2017-03-21 15:57:31.003492Z] Finished download-and-extract step (success) 08:57:31 INFO - [mozharness: 2017-03-21 15:57:31.003603Z] Running populate-webroot step. 08:57:31 INFO - Running pre-action listener: _resource_record_pre_action 08:57:31 INFO - Running main action method: populate_webroot 08:57:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:57:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:57:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:57:31 INFO - '--tppagecycles', 08:57:31 INFO - '7'], 08:57:31 INFO - 'tests': ['tsvgm']}}, 08:57:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:57:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:57:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:57:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:57:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:57:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:57:31 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:57:31 INFO - 'talos_options': ['--disable-e10s'], 08:57:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:57:31 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:57:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:57:31 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:57:31 INFO - 'talos_options': ['--disable-e10s'], 08:57:31 INFO - 'tests': ['damp', 'tps']}, 08:57:31 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:57:31 INFO - 'tests': ['damp', 'tps']}, 08:57:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:57:31 INFO - 'tests': ['dromaeo_dom']}, 08:57:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:57:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:57:31 INFO - 'tests': ['basic_compositor_video']}, 08:57:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:57:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:57:31 INFO - 'tests': ['a11yr', 08:57:31 INFO - 'ts_paint', 08:57:31 INFO - 'tpaint', 08:57:31 INFO - 'sessionrestore', 08:57:31 INFO - 'sessionrestore_no_auto_restore', 08:57:31 INFO - 'tabpaint']}, 08:57:31 INFO - 'other-e10s': {'tests': ['a11yr', 08:57:31 INFO - 'ts_paint', 08:57:31 INFO - 'tpaint', 08:57:31 INFO - 'sessionrestore', 08:57:31 INFO - 'sessionrestore_no_auto_restore', 08:57:31 INFO - 'tabpaint']}, 08:57:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:57:31 INFO - 'ts_paint', 08:57:31 INFO - 'tpaint', 08:57:31 INFO - 'sessionrestore', 08:57:31 INFO - 'sessionrestore_no_auto_restore', 08:57:31 INFO - 'tabpaint']}, 08:57:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:57:31 INFO - 'ts_paint', 08:57:31 INFO - 'tpaint', 08:57:31 INFO - 'sessionrestore', 08:57:31 INFO - 'sessionrestore_no_auto_restore', 08:57:31 INFO - 'tabpaint']}, 08:57:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:57:31 INFO - 'tests': ['a11yr', 08:57:31 INFO - 'ts_paint', 08:57:31 INFO - 'tpaint', 08:57:31 INFO - 'sessionrestore', 08:57:31 INFO - 'sessionrestore_no_auto_restore', 08:57:31 INFO - 'tabpaint']}, 08:57:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:57:31 INFO - 'tests': ['a11yr', 08:57:31 INFO - 'ts_paint', 08:57:31 INFO - 'tpaint', 08:57:31 INFO - 'sessionrestore', 08:57:31 INFO - 'sessionrestore_no_auto_restore', 08:57:31 INFO - 'tabpaint']}, 08:57:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:57:31 INFO - 'tests': ['tsvgx', 08:57:31 INFO - 'tsvgr_opacity', 08:57:31 INFO - 'tart', 08:57:31 INFO - 'tscrollx', 08:57:31 INFO - 'cart', 08:57:31 INFO - 'tsvg_static']}, 08:57:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:57:31 INFO - 'tsvgr_opacity', 08:57:31 INFO - 'tart', 08:57:31 INFO - 'tscrollx', 08:57:31 INFO - 'cart', 08:57:31 INFO - 'tsvg_static']}, 08:57:31 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:57:31 INFO - 'talos_options': ['--disable-e10s'], 08:57:31 INFO - 'tests': ['tp5o']}, 08:57:31 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:57:31 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:57:31 INFO - 'talos_options': ['--disable-e10s', 08:57:31 INFO - '--xperf_path', 08:57:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:57:31 INFO - 'tests': ['tp5n']}, 08:57:31 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:57:31 INFO - 'talos_options': ['--xperf_path', 08:57:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:57:31 INFO - 'tests': ['tp5n']}}, 08:57:31 INFO - 'talos.zip': {'path': '', 08:57:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:57:31 INFO - Running post-action listener: _resource_record_post_action 08:57:31 INFO - [mozharness: 2017-03-21 15:57:31.018313Z] Finished populate-webroot step (success) 08:57:31 INFO - [mozharness: 2017-03-21 15:57:31.018402Z] Running create-virtualenv step. 08:57:31 INFO - Running pre-action listener: _resource_record_pre_action 08:57:31 INFO - Running main action method: create_virtualenv 08:57:31 INFO - Creating virtualenv /builds/slave/test/build/venv 08:57:31 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:57:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:57:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:57:31 INFO - Using real prefix '/usr' 08:57:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:57:31 INFO - Installing distribute.............................................................................................................................................................................................done. 08:57:33 INFO - Installing pip.................done. 08:57:33 INFO - Return code: 0 08:57:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:57:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:57:33 INFO - Reading from file tmpfile_stdout 08:57:33 INFO - Output received: 08:57:33 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:57:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:57:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:33 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 0x27fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a98290>, '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 0x2a98b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a99040>, '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': 'c6927cf182745ad25b1d38b9000001fe-1490111820.436670-1291451011', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:57:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:57:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:57:33 INFO - Using env: {'DISPLAY': ':0', 08:57:33 INFO - 'HOME': '/home/cltbld', 08:57:33 INFO - 'LANG': 'en_US.UTF-8', 08:57:33 INFO - 'LANGUAGE': 'en_US:en', 08:57:33 INFO - 'LOGNAME': 'cltbld', 08:57:33 INFO - 'MAIL': '/var/mail/cltbld', 08:57:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:33 INFO - 'MOZ_NO_REMOTE': '1', 08:57:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:33 INFO - 'NO_EM_RESTART': '1', 08:57:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:33 INFO - 'PWD': '/builds/slave/test', 08:57:33 INFO - 'SHELL': '/bin/bash', 08:57:33 INFO - 'SHLVL': '1', 08:57:33 INFO - 'TERM': 'linux', 08:57:33 INFO - 'TMOUT': '86400', 08:57:33 INFO - 'USER': 'cltbld', 08:57:33 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1490111820.436670-1291451011', 08:57:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:33 INFO - '_': '/tools/buildbot/bin/python'} 08:57:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:34 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:57:34 INFO - Cleaning up... 08:57:34 INFO - Return code: 0 08:57:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:57:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x27fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a98290>, '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 0x2a98b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a99040>, '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': 'c6927cf182745ad25b1d38b9000001fe-1490111820.436670-1291451011', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:57:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:57:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:57:34 INFO - Using env: {'DISPLAY': ':0', 08:57:34 INFO - 'HOME': '/home/cltbld', 08:57:34 INFO - 'LANG': 'en_US.UTF-8', 08:57:34 INFO - 'LANGUAGE': 'en_US:en', 08:57:34 INFO - 'LOGNAME': 'cltbld', 08:57:34 INFO - 'MAIL': '/var/mail/cltbld', 08:57:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:34 INFO - 'MOZ_NO_REMOTE': '1', 08:57:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:34 INFO - 'NO_EM_RESTART': '1', 08:57:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:34 INFO - 'PWD': '/builds/slave/test', 08:57:34 INFO - 'SHELL': '/bin/bash', 08:57:34 INFO - 'SHLVL': '1', 08:57:34 INFO - 'TERM': 'linux', 08:57:34 INFO - 'TMOUT': '86400', 08:57:34 INFO - 'USER': 'cltbld', 08:57:34 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1490111820.436670-1291451011', 08:57:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:34 INFO - '_': '/tools/buildbot/bin/python'} 08:57:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:34 INFO - Downloading/unpacking psutil>=3.1.1 08:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:57:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:57:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:57:36 INFO - Installing collected packages: psutil 08:57:36 INFO - Running setup.py install for psutil 08:57:36 INFO - building 'psutil._psutil_linux' extension 08:57:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:57:36 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:57:36 INFO - building 'psutil._psutil_posix' extension 08:57:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:57:36 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:57:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:57:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:57:36 INFO - Successfully installed psutil 08:57:36 INFO - Cleaning up... 08:57:36 INFO - Return code: 0 08:57:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:57:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:36 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 0x27fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a98290>, '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 0x2a98b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a99040>, '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': 'c6927cf182745ad25b1d38b9000001fe-1490111820.436670-1291451011', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:57:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:57:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:57:36 INFO - Using env: {'DISPLAY': ':0', 08:57:36 INFO - 'HOME': '/home/cltbld', 08:57:36 INFO - 'LANG': 'en_US.UTF-8', 08:57:36 INFO - 'LANGUAGE': 'en_US:en', 08:57:36 INFO - 'LOGNAME': 'cltbld', 08:57:36 INFO - 'MAIL': '/var/mail/cltbld', 08:57:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:36 INFO - 'MOZ_NO_REMOTE': '1', 08:57:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:36 INFO - 'NO_EM_RESTART': '1', 08:57:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:36 INFO - 'PWD': '/builds/slave/test', 08:57:36 INFO - 'SHELL': '/bin/bash', 08:57:36 INFO - 'SHLVL': '1', 08:57:36 INFO - 'TERM': 'linux', 08:57:36 INFO - 'TMOUT': '86400', 08:57:36 INFO - 'USER': 'cltbld', 08:57:36 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1490111820.436670-1291451011', 08:57:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:36 INFO - '_': '/tools/buildbot/bin/python'} 08:57:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:57:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:57:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:57:39 INFO - Installing collected packages: mozsystemmonitor 08:57:39 INFO - Running setup.py install for mozsystemmonitor 08:57:39 INFO - Successfully installed mozsystemmonitor 08:57:39 INFO - Cleaning up... 08:57:39 INFO - Return code: 0 08:57:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:39 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 0x27fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a98290>, '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 0x2a98b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a99040>, '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': 'c6927cf182745ad25b1d38b9000001fe-1490111820.436670-1291451011', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:57:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:57:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:57:39 INFO - Using env: {'DISPLAY': ':0', 08:57:39 INFO - 'HOME': '/home/cltbld', 08:57:39 INFO - 'LANG': 'en_US.UTF-8', 08:57:39 INFO - 'LANGUAGE': 'en_US:en', 08:57:39 INFO - 'LOGNAME': 'cltbld', 08:57:39 INFO - 'MAIL': '/var/mail/cltbld', 08:57:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:39 INFO - 'MOZ_NO_REMOTE': '1', 08:57:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:39 INFO - 'NO_EM_RESTART': '1', 08:57:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:39 INFO - 'PWD': '/builds/slave/test', 08:57:39 INFO - 'SHELL': '/bin/bash', 08:57:39 INFO - 'SHLVL': '1', 08:57:39 INFO - 'TERM': 'linux', 08:57:39 INFO - 'TMOUT': '86400', 08:57:39 INFO - 'USER': 'cltbld', 08:57:39 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1490111820.436670-1291451011', 08:57:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:39 INFO - '_': '/tools/buildbot/bin/python'} 08:57:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:39 INFO - Downloading/unpacking jsonschema==2.5.1 08:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:57:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:41 INFO - Downloading functools32-3.2.3-2.tar.gz 08:57:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:57:41 INFO - warning: no files found matching '*.txt' 08:57:41 INFO - no previously-included directories found matching 'build' 08:57:41 INFO - no previously-included directories found matching 'dist' 08:57:41 INFO - no previously-included directories found matching '.git*' 08:57:41 INFO - Installing collected packages: jsonschema, functools32 08:57:41 INFO - Running setup.py install for functools32 08:57:42 INFO - warning: no files found matching '*.txt' 08:57:42 INFO - no previously-included directories found matching 'build' 08:57:42 INFO - no previously-included directories found matching 'dist' 08:57:42 INFO - no previously-included directories found matching '.git*' 08:57:42 INFO - Successfully installed jsonschema functools32 08:57:42 INFO - Cleaning up... 08:57:42 INFO - Return code: 0 08:57:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:57:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:42 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 0x27fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a98290>, '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 0x2a98b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a99040>, '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': 'c6927cf182745ad25b1d38b9000001fe-1490111820.436670-1291451011', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:57:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:57:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:57:42 INFO - Using env: {'DISPLAY': ':0', 08:57:42 INFO - 'HOME': '/home/cltbld', 08:57:42 INFO - 'LANG': 'en_US.UTF-8', 08:57:42 INFO - 'LANGUAGE': 'en_US:en', 08:57:42 INFO - 'LOGNAME': 'cltbld', 08:57:42 INFO - 'MAIL': '/var/mail/cltbld', 08:57:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:42 INFO - 'MOZ_NO_REMOTE': '1', 08:57:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:42 INFO - 'NO_EM_RESTART': '1', 08:57:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:42 INFO - 'PWD': '/builds/slave/test', 08:57:42 INFO - 'SHELL': '/bin/bash', 08:57:42 INFO - 'SHLVL': '1', 08:57:42 INFO - 'TERM': 'linux', 08:57:42 INFO - 'TMOUT': '86400', 08:57:42 INFO - 'USER': 'cltbld', 08:57:42 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1490111820.436670-1291451011', 08:57:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:42 INFO - '_': '/tools/buildbot/bin/python'} 08:57:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:57:42 INFO - Cleaning up... 08:57:42 INFO - Return code: 0 08:57:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:57:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:42 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 0x27fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a98290>, '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 0x2a98b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a99040>, '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': 'c6927cf182745ad25b1d38b9000001fe-1490111820.436670-1291451011', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:57:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:57:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:57:42 INFO - Using env: {'DISPLAY': ':0', 08:57:42 INFO - 'HOME': '/home/cltbld', 08:57:42 INFO - 'LANG': 'en_US.UTF-8', 08:57:42 INFO - 'LANGUAGE': 'en_US:en', 08:57:42 INFO - 'LOGNAME': 'cltbld', 08:57:42 INFO - 'MAIL': '/var/mail/cltbld', 08:57:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:42 INFO - 'MOZ_NO_REMOTE': '1', 08:57:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:42 INFO - 'NO_EM_RESTART': '1', 08:57:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:42 INFO - 'PWD': '/builds/slave/test', 08:57:42 INFO - 'SHELL': '/bin/bash', 08:57:42 INFO - 'SHLVL': '1', 08:57:42 INFO - 'TERM': 'linux', 08:57:42 INFO - 'TMOUT': '86400', 08:57:42 INFO - 'USER': 'cltbld', 08:57:42 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1490111820.436670-1291451011', 08:57:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:42 INFO - '_': '/tools/buildbot/bin/python'} 08:57:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:42 INFO - Downloading/unpacking blobuploader==1.2.4 08:57:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:44 INFO - Downloading blobuploader-1.2.4.tar.gz 08:57:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:57:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:57:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:45 INFO - Downloading docopt-0.6.1.tar.gz 08:57:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:57:45 INFO - Installing collected packages: blobuploader, requests, docopt 08:57:45 INFO - Running setup.py install for blobuploader 08:57:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:57:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:57:45 INFO - Running setup.py install for requests 08:57:45 INFO - Running setup.py install for docopt 08:57:45 INFO - Successfully installed blobuploader requests docopt 08:57:45 INFO - Cleaning up... 08:57:45 INFO - Return code: 0 08:57:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:45 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 0x27fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a98290>, '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 0x2a98b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a99040>, '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': 'c6927cf182745ad25b1d38b9000001fe-1490111820.436670-1291451011', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:57:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:57:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:57:46 INFO - Using env: {'DISPLAY': ':0', 08:57:46 INFO - 'HOME': '/home/cltbld', 08:57:46 INFO - 'LANG': 'en_US.UTF-8', 08:57:46 INFO - 'LANGUAGE': 'en_US:en', 08:57:46 INFO - 'LOGNAME': 'cltbld', 08:57:46 INFO - 'MAIL': '/var/mail/cltbld', 08:57:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:46 INFO - 'MOZ_NO_REMOTE': '1', 08:57:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:46 INFO - 'NO_EM_RESTART': '1', 08:57:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:46 INFO - 'PWD': '/builds/slave/test', 08:57:46 INFO - 'SHELL': '/bin/bash', 08:57:46 INFO - 'SHLVL': '1', 08:57:46 INFO - 'TERM': 'linux', 08:57:46 INFO - 'TMOUT': '86400', 08:57:46 INFO - 'USER': 'cltbld', 08:57:46 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1490111820.436670-1291451011', 08:57:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:46 INFO - '_': '/tools/buildbot/bin/python'} 08:57:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:57:46 INFO - Running setup.py (path:/tmp/pip-rJxj32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:57:46 INFO - Running setup.py (path:/tmp/pip-ImMZfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:57:46 INFO - Running setup.py (path:/tmp/pip-pKabhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:57:46 INFO - Running setup.py (path:/tmp/pip-kxSw7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:57:46 INFO - Running setup.py (path:/tmp/pip-r6q_jn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:57:46 INFO - Running setup.py (path:/tmp/pip-52sGn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:57:46 INFO - Running setup.py (path:/tmp/pip-EwJjHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:57:46 INFO - Running setup.py (path:/tmp/pip-4UFYmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:57:46 INFO - Running setup.py (path:/tmp/pip-DdzpWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:57:46 INFO - Running setup.py (path:/tmp/pip-kpLlby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:57:46 INFO - Running setup.py (path:/tmp/pip-M7ttdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:57:47 INFO - Running setup.py (path:/tmp/pip-Npvbcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:57:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:57:47 INFO - Running setup.py (path:/tmp/pip-hPU7wQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:57:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:57:47 INFO - Running setup.py (path:/tmp/pip-JW5UY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:57:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:57:47 INFO - Running setup.py (path:/tmp/pip-OjlHmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:57:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:57:47 INFO - Running setup.py (path:/tmp/pip-VFK_yN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:57:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:57:47 INFO - Running setup.py (path:/tmp/pip-Y_TxzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:57:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:57:47 INFO - Running setup.py install for manifestparser 08:57:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:57:47 INFO - Running setup.py install for mozcrash 08:57:47 INFO - Running setup.py install for mozdebug 08:57:47 INFO - Running setup.py install for mozdevice 08:57:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:57:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:57:47 INFO - Running setup.py install for mozfile 08:57:47 INFO - Running setup.py install for mozhttpd 08:57:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:57:48 INFO - Running setup.py install for mozinfo 08:57:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:57:48 INFO - Running setup.py install for mozInstall 08:57:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:57:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:57:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:57:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:57:48 INFO - Running setup.py install for mozleak 08:57:48 INFO - Running setup.py install for mozlog 08:57:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:57:48 INFO - Running setup.py install for moznetwork 08:57:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:57:48 INFO - Running setup.py install for mozprocess 08:57:48 INFO - Running setup.py install for mozprofile 08:57:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:57:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:57:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:57:48 INFO - Running setup.py install for mozrunner 08:57:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:57:48 INFO - Running setup.py install for mozscreenshot 08:57:49 INFO - Running setup.py install for moztest 08:57:49 INFO - Running setup.py install for mozversion 08:57:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:57:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:57:49 INFO - Cleaning up... 08:57:49 INFO - Return code: 0 08:57:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:57: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')]} 08:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57: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')]} 08:57:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:49 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 0x27fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a98290>, '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 0x2a98b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a99040>, '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': 'c6927cf182745ad25b1d38b9000001fe-1490111820.436670-1291451011', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:57:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:57:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:57:49 INFO - Using env: {'DISPLAY': ':0', 08:57:49 INFO - 'HOME': '/home/cltbld', 08:57:49 INFO - 'LANG': 'en_US.UTF-8', 08:57:49 INFO - 'LANGUAGE': 'en_US:en', 08:57:49 INFO - 'LOGNAME': 'cltbld', 08:57:49 INFO - 'MAIL': '/var/mail/cltbld', 08:57:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:49 INFO - 'MOZ_NO_REMOTE': '1', 08:57:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:49 INFO - 'NO_EM_RESTART': '1', 08:57:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:49 INFO - 'PWD': '/builds/slave/test', 08:57:49 INFO - 'SHELL': '/bin/bash', 08:57:49 INFO - 'SHLVL': '1', 08:57:49 INFO - 'TERM': 'linux', 08:57:49 INFO - 'TMOUT': '86400', 08:57:49 INFO - 'USER': 'cltbld', 08:57:49 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1490111820.436670-1291451011', 08:57:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:49 INFO - '_': '/tools/buildbot/bin/python'} 08:57:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:57:49 INFO - Running setup.py (path:/tmp/pip-ClAzUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:57:49 INFO - Running setup.py (path:/tmp/pip-E90dUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:57:49 INFO - Running setup.py (path:/tmp/pip-g3upfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:57:49 INFO - Running setup.py (path:/tmp/pip-LLvxpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:57:49 INFO - Running setup.py (path:/tmp/pip-0GXdN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:57:49 INFO - Running setup.py (path:/tmp/pip-4BHT2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:57:49 INFO - Running setup.py (path:/tmp/pip-tiw_9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:57:49 INFO - Running setup.py (path:/tmp/pip-Esqkax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:57:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:57:50 INFO - Running setup.py (path:/tmp/pip-EbZ4_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:57:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:57:50 INFO - Running setup.py (path:/tmp/pip-Gusnxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:57:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:57:50 INFO - Running setup.py (path:/tmp/pip-6boJZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:57:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:57:50 INFO - Running setup.py (path:/tmp/pip-9viIi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:57:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:57:50 INFO - Running setup.py (path:/tmp/pip-tR4k5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:57:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:57:50 INFO - Running setup.py (path:/tmp/pip-gHyHZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:57:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:57:50 INFO - Running setup.py (path:/tmp/pip-bZKdCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:57:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:57:50 INFO - Running setup.py (path:/tmp/pip-oM9u8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:57:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:57:50 INFO - Running setup.py (path:/tmp/pip-fdLyDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:57:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:57:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:57:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:57:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:57:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:57:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:57:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:52 INFO - Downloading blessings-1.6.tar.gz 08:57:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:57:52 INFO - Installing collected packages: blessings 08:57:52 INFO - Running setup.py install for blessings 08:57:52 INFO - Successfully installed blessings 08:57:52 INFO - Cleaning up... 08:57:52 INFO - Return code: 0 08:57:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:57:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:57:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:57:53 INFO - Reading from file tmpfile_stdout 08:57:53 INFO - Current package versions: 08:57:53 INFO - argparse == 1.2.1 08:57:53 INFO - blessings == 1.6 08:57:53 INFO - blobuploader == 1.2.4 08:57:53 INFO - docopt == 0.6.1 08:57:53 INFO - functools32 == 3.2.3-2 08:57:53 INFO - jsonschema == 2.5.1 08:57:53 INFO - manifestparser == 1.1 08:57:53 INFO - mozInstall == 1.12 08:57:53 INFO - mozcrash == 1.0 08:57:53 INFO - mozdebug == 0.1 08:57:53 INFO - mozdevice == 0.49 08:57:53 INFO - mozfile == 1.2 08:57:53 INFO - mozhttpd == 0.7 08:57:53 INFO - mozinfo == 0.9 08:57:53 INFO - mozleak == 0.1 08:57:53 INFO - mozlog == 3.4 08:57:53 INFO - moznetwork == 0.27 08:57:53 INFO - mozprocess == 0.25 08:57:53 INFO - mozprofile == 0.28 08:57:53 INFO - mozrunner == 6.13 08:57:53 INFO - mozscreenshot == 0.1 08:57:53 INFO - mozsystemmonitor == 0.3 08:57:53 INFO - moztest == 0.8 08:57:53 INFO - mozversion == 1.4 08:57:53 INFO - psutil == 3.1.1 08:57:53 INFO - requests == 1.2.3 08:57:53 INFO - wsgiref == 0.1.2 08:57:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:57: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')]} 08:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57: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')]} 08:57:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:53 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 0x27fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a98290>, '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 0x2a98b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a99040>, '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': 'c6927cf182745ad25b1d38b9000001fe-1490111820.436670-1291451011', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:57:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:57:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:57:53 INFO - Using env: {'DISPLAY': ':0', 08:57:53 INFO - 'HOME': '/home/cltbld', 08:57:53 INFO - 'LANG': 'en_US.UTF-8', 08:57:53 INFO - 'LANGUAGE': 'en_US:en', 08:57:53 INFO - 'LOGNAME': 'cltbld', 08:57:53 INFO - 'MAIL': '/var/mail/cltbld', 08:57:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:53 INFO - 'MOZ_NO_REMOTE': '1', 08:57:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:53 INFO - 'NO_EM_RESTART': '1', 08:57:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:53 INFO - 'PWD': '/builds/slave/test', 08:57:53 INFO - 'SHELL': '/bin/bash', 08:57:53 INFO - 'SHLVL': '1', 08:57:53 INFO - 'TERM': 'linux', 08:57:53 INFO - 'TMOUT': '86400', 08:57:53 INFO - 'USER': 'cltbld', 08:57:53 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1490111820.436670-1291451011', 08:57:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:53 INFO - '_': '/tools/buildbot/bin/python'} 08:57:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:57:53 INFO - Cleaning up... 08:57:53 INFO - Return code: 0 08:57:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:57: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')]} 08:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57: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')]} 08:57:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a98290>, '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 0x2a98b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a99040>, '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': 'c6927cf182745ad25b1d38b9000001fe-1490111820.436670-1291451011', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:57: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', 'jsonschema'] in /builds/slave/test/build 08:57: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 jsonschema 08:57:53 INFO - Using env: {'DISPLAY': ':0', 08:57:53 INFO - 'HOME': '/home/cltbld', 08:57:53 INFO - 'LANG': 'en_US.UTF-8', 08:57:53 INFO - 'LANGUAGE': 'en_US:en', 08:57:53 INFO - 'LOGNAME': 'cltbld', 08:57:53 INFO - 'MAIL': '/var/mail/cltbld', 08:57:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:53 INFO - 'MOZ_NO_REMOTE': '1', 08:57:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:53 INFO - 'NO_EM_RESTART': '1', 08:57:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:53 INFO - 'PWD': '/builds/slave/test', 08:57:53 INFO - 'SHELL': '/bin/bash', 08:57:53 INFO - 'SHLVL': '1', 08:57:53 INFO - 'TERM': 'linux', 08:57:53 INFO - 'TMOUT': '86400', 08:57:53 INFO - 'USER': 'cltbld', 08:57:53 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1490111820.436670-1291451011', 08:57:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:53 INFO - '_': '/tools/buildbot/bin/python'} 08:57:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:57:53 INFO - Cleaning up... 08:57:53 INFO - Return code: 0 08:57:53 INFO - Running post-action listener: _resource_record_post_action 08:57:53 INFO - Running post-action listener: _start_resource_monitoring 08:57:53 INFO - Starting resource monitoring. 08:57:53 INFO - [mozharness: 2017-03-21 15:57:53.671414Z] Finished create-virtualenv step (success) 08:57:53 INFO - [mozharness: 2017-03-21 15:57:53.671930Z] Running install step. 08:57:53 INFO - Running pre-action listener: _resource_record_pre_action 08:57:53 INFO - Running main action method: install 08:57:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:57:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:57:53 INFO - Reading from file tmpfile_stdout 08:57:53 INFO - Detecting whether we're running mozinstall >=1.0... 08:57:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:57:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:57:53 INFO - Reading from file tmpfile_stdout 08:57:53 INFO - Output received: 08:57:53 INFO - Usage: mozinstall [options] installer 08:57:53 INFO - Options: 08:57:53 INFO - -h, --help show this help message and exit 08:57:53 INFO - -d DEST, --destination=DEST 08:57:53 INFO - Directory to install application into. [default: 08:57:53 INFO - "/builds/slave/test"] 08:57:53 INFO - --app=APP Application being installed. [default: firefox] 08:57:53 INFO - mkdir: /builds/slave/test/build/application 08:57:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:57:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:58:09 INFO - Reading from file tmpfile_stdout 08:58:09 INFO - Output received: 08:58:09 INFO - /builds/slave/test/build/application/firefox/firefox 08:58:09 INFO - Running post-action listener: _resource_record_post_action 08:58:09 INFO - [mozharness: 2017-03-21 15:58:09.445759Z] Finished install step (success) 08:58:09 INFO - [mozharness: 2017-03-21 15:58:09.446032Z] Running run-tests step. 08:58:09 INFO - Running pre-action listener: _resource_record_pre_action 08:58:09 INFO - Running main action method: run_tests 08:58:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:58:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:58:09 INFO - Python 2.7.3 08:58:09 INFO - Return code: 0 08:58:09 INFO - grabbing minidump binary from tooltool 08:58: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')]} 08:58:09 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 0x2a98290>, '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 0x2a98b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a99040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:58:09 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:58:09 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:58:09 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:58:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:58:09 INFO - Return code: 0 08:58:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:58:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:58:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:58:09 INFO - ENV: RUST_BACKTRACE is now 1 08:58:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:58:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:58:09 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/T-7Yh0DbT_Supooniosh_w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:58:09 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/T-7Yh0DbT_Supooniosh_w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-004 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:58:09 INFO - Using env: {'DISPLAY': ':0', 08:58:09 INFO - 'HOME': '/home/cltbld', 08:58:09 INFO - 'LANG': 'en_US.UTF-8', 08:58:09 INFO - 'LANGUAGE': 'en_US:en', 08:58:09 INFO - 'LOGNAME': 'cltbld', 08:58:09 INFO - 'MAIL': '/var/mail/cltbld', 08:58:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:58:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:58:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:09 INFO - 'MOZ_NO_REMOTE': '1', 08:58:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:58:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:58:09 INFO - 'NO_EM_RESTART': '1', 08:58:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:58:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:58:09 INFO - 'PWD': '/builds/slave/test', 08:58:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:58:09 INFO - 'RUST_BACKTRACE': '1', 08:58:09 INFO - 'SHELL': '/bin/bash', 08:58:09 INFO - 'SHLVL': '1', 08:58:09 INFO - 'TERM': 'linux', 08:58:09 INFO - 'TMOUT': '86400', 08:58:09 INFO - 'USER': 'cltbld', 08:58:09 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1490111820.436670-1291451011', 08:58:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:09 INFO - '_': '/tools/buildbot/bin/python'} 08:58:09 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/T-7Yh0DbT_Supooniosh_w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:58:09 INFO - mozversion application_buildid: 20170321152219 08:58:09 INFO - mozversion application_changeset: 31172c0751dd45780a57e92a688c1f54cc01fe63 08:58:09 INFO - mozversion application_display_name: Nightly 08:58:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:58:09 INFO - mozversion application_name: Firefox 08:58:09 INFO - mozversion application_remotingname: firefox 08:58:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:58:09 INFO - mozversion application_vendor: Mozilla 08:58:09 INFO - mozversion application_version: 55.0a1 08:58:09 INFO - mozversion platform_buildid: 20170321152219 08:58:09 INFO - mozversion platform_changeset: 31172c0751dd45780a57e92a688c1f54cc01fe63 08:58:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:58:09 INFO - mozversion platform_version: 55.0a1 08:58:09 INFO - using testdate: 1490111889 08:58:09 INFO - actual date: 1490111889 08:58:09 INFO - starting webserver on 'localhost:48332' 08:58:09 INFO - SUITE-START | Running 2 tests 08:58:09 INFO - TEST-START | dromaeo_css 08:58:09 INFO - operating with platform_type : linux_ 08:58:09 INFO - Initialising browser for dromaeo_css test... 08:58:09 INFO - TEST-INFO | started process 12823 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpymY4c8/profile http://localhost:48332/getInfo.html) 08:58:14 INFO - PID 12823 | __metrics Screen width/height:1600/1200 08:58:14 INFO - PID 12823 | colorDepth:24 08:58:14 INFO - PID 12823 | Browser inner width/height: 1024/697 08:58:14 INFO - PID 12823 | __metrics 08:58:15 ERROR - PID 12823 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 08:58:16 INFO - TEST-INFO | 12823: exit 0 08:58:16 INFO - Browser initialized. 08:58:16 INFO - Running cycle 1/1 for dromaeo_css test... 08:58:16 INFO - TEST-INFO | started process 12955 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpymY4c8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:58:28 INFO - PID 12955 | RSS: Main: 155189248 08:58:28 INFO - PID 12955 | 09:01:32 INFO - PID 12955 | Cycle 1(1): loaded http://localhost:48332/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48332/tests/dromaeo/cssquery-ext.html) 09:01:35 INFO - PID 12955 | RSS: Main: 167350272 09:01:35 INFO - PID 12955 | 09:03:16 INFO - PID 12955 | ************************* 09:03:16 INFO - PID 12955 | A coding exception was thrown and uncaught in a Task. 09:03:16 INFO - PID 12955 | 09:03:16 ERROR - PID 12955 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:03:16 INFO - PID 12955 | Full stack: 09:03:16 INFO - PID 12955 | ************************* 09:04:38 INFO - PID 12955 | Cycle 1(1): loaded http://localhost:48332/tests/dromaeo/cssquery-ext.html (next: http://localhost:48332/tests/dromaeo/cssquery-jquery.html) 09:04:38 INFO - PID 12955 | RSS: Main: 160583680 09:04:38 INFO - PID 12955 | 09:07:40 INFO - PID 12955 | Cycle 1(1): loaded http://localhost:48332/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48332/tests/dromaeo/cssquery-mootools.html) 09:07:41 INFO - PID 12955 | RSS: Main: 168435712 09:07:41 INFO - PID 12955 | 09:10:43 INFO - PID 12955 | Cycle 1(1): loaded http://localhost:48332/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48332/tests/dromaeo/cssquery-prototype.html) 09:10:44 INFO - PID 12955 | RSS: Main: 160284672 09:10:44 INFO - PID 12955 | 09:13:47 INFO - PID 12955 | Cycle 1(1): loaded http://localhost:48332/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48332/tests/dromaeo/cssquery-yui.html) 09:13:47 INFO - PID 12955 | RSS: Main: 167473152 09:13:47 INFO - PID 12955 | 09:16:50 INFO - PID 12955 | Cycle 1(1): loaded http://localhost:48332/tests/dromaeo/cssquery-yui.html (next: http://localhost:48332/tests/dromaeo/cssquery-dojo.html) 09:16:51 INFO - PID 12955 | RSS: Main: 161394688 09:16:51 INFO - PID 12955 | 09:16:51 INFO - PID 12955 | __start_tp_report 09:16:51 INFO - PID 12955 | _x_x_mozilla_page_load 09:16:51 INFO - PID 12955 | _x_x_mozilla_page_load_details 09:16:51 INFO - PID 12955 | |i|pagename|runs| 09:16:51 INFO - PID 12955 | |0;dojo.html;2683.5382356759783;2701.3786829029336;2709.8238614490056;2719.2522056434477;2733.3986522964947;5003.474635163301;5028.597712183026;5031.899362012758;5090.31280777095;5115.360579927509;5068.1890897456415;5080.136376815941;5100.387953445583;5133.230015497677;5146.305248791412;4604.125216208918;4626.560476754703;4638.0491999140095;4653.441587009564;4676.649251306166;4659.510751371108;4662.930056049162;4673.345731597562;4701.341812146302;4740.217864052427;4628.4445866496235;4631.258998560214;4648.651351148677;4688.976555117237;4691.038337140878;4668.883277918079;4674.205385084544;4684.906301873943;4697.741624210667;4742.786574604151;4628.8148474061;4633.235516139833;4645.070985802853;4671.906561868777;4699.929501057487;4978.9751051244875;5026.271190677331;5096.566791822699;5110.926705391872;5140.74296285188;5473.507384335429;5481.342238931354;5484.396716361197;5490.972545137289;5539.307586551681;5507.642003269814;5529.336479622471;5546.833594992157;5551.833444996657;5557.694326812024;5036.219385995177;5047.369078865142;5113.207452844815;5144.459831717616;5179.974100129551;5643.1535269709875;5690.800821971211;5694.686792226385;5734.856628584319;5754.712264386764;5301.575873930076;5353.250544923714;5379;5421.945780542223;5427.3758517770175;5454.10007348791;5517.862053448615;5546.833594992157;5555.611107222537;5586.888262234733;5274.947250527445;5364.436734142937;5484.862878428071;5490.423505531861;5522.144067669517;5510.476504732044;5522.171674248895;5523.917141242885;5542.528885044736;5545.72271386429;4695.812167513262;4705.153072446924;4705.905881882343;4710.29345598163;4734.95265047352;3960.782156981336;3995.2808494471274;4022.1754540319166;4036.979815100906;4067.247559201557;4622.4684161321875;4694.389729335165;4709.788059537329;4741.2176990796825;4747.264174053027;5449.782008719686;5467.371252305956;5485.780568777284;5506.229127922094;5530.198121272393;4646.09401166776;4704.811807527729;4716.198246298138;4719.551642593948;4774.832880849153;4870.634702397334;4876.414830220397;4878.804847806048;4879.585235255043;4882.707037577686;5006.299118123393;5036.6726162799305;5036.924446133237;5037.445880953165;5049.2426136079885;5391.406945235943;5431.266778984945;5437.918431223456;5438.728063596725;5532.419095994863;5172.327597412313;5177.378714554127;5178.689278643294;5212.139996900621;5233.842984710464;5430.429804870431;5485.966710111407;5489.423610520837;5493.038718224375;5507.173923911445;5382.4886635769535;5451.863703407446;5452;5580.804671836466;5608.579356548194;5244.7902083916215;5246.055709972242;5250.868728281824;5254.474552544715;5256.9737151314;5246.632735708464;5250.684958902325;5254.710990895537;5260.158374660036;5263.710495922761;5145.61407894402;5154.252633368215;5185.714785686823;5193.532582067632;5194.610404219623;5348.839534813962;5398.811041613525;5478.945210547843;5496;5500.119980803052;5257.342832145981;5261.921071184011;5272.209168624737;5300.469953004668;5310.389305229948 09:16:51 INFO - PID 12955 | |1;ext.html;710.545251039335;726.4624178108198;733.6111860713822;756.71623141322;762.0740799928088;33611.83194084029;34723;34816.30367392651;34843;34870.30259394811;31114.844425777897;31464;31518.52722209169;31544.526832097537;31560.526592101138;2227.376334626307;2357.6817129687443;2362.456634973957;2377.0491803278655;2432.781049705526;2437.4393889405446;2457.6190690442922;2483.192962287255;2491.302435318105;2495.8502489850575;2445.40087678519;2473.6536884836137;2476.5294594027077;2478.628205769131;2479.119912431088;2448.2410452759614;2481.0323973650293;2481.4292712676097;2489.639002344668;2493.3268017635137;2462.482878595479;2484.068474322129;2484.3168128764555;2484.8260621756485;2490.489449662833;33839.15402114942;33922.83038584791;34318.31363372743;34337.48493772595;34423.139421514665;2641.603759436081;2650.9602355964676;2657.2028391482477;2663.42736311692;2675.933101672454;23278.883605582032;23692.881535592212;23864;24219.757802421926;24644.13745518916;2927.7657787376957;2957.8521073946217;2986.074316961749;3010.638723353212;3011.629708482635;146547.267263663;147124.2643786785;147694.26152869273;147750.26124869307;147855;31692.683073169435;31886.362272754413;35417.8229108858;40621.593784061784;40739;37445;37543.81228093897;37713.43429848555;37838.81080594634;37881.24237515289;10797.380392941122;10906.34561926287;10924.016838484575;10935.671929842118;10947.34315941046;8517.787055323666;8536.317094632415;8579.699710510102;8583.05586385497;8594.054653988056;12086.637400877988;12141.575044873387;12144.69638259033;12263.570775022832;12291.877081229251;5113.386393632788;5127.948720512822;5137.6660517066275;5149.562287205555;5151.330327057459;871.5859966515854;900.4237288135598;905.7735566108473;906.954652267384;934.8130373925106;19931.302404415776;20973.685394718785;21002.579948400948;21045.15819367239;21330.680039799416;937.8358787212211;952.6046690623452;962.821877952567;973.600823662295;1009.4548943570536;10603;10652.840207396895;10859.565617375374;11032.386646736422;11073.390963496924;212017;215735;215861;216162;217146;42527;42958.78520607377;43039.56960430418;43081;43117.78441107837;1188.6612315490045;1256.497401039573;1256.9622911312674;1258.641287233134;1268.422867595242;19087.236510539977;19174.520636984187;19330.323438679578;20556.486087847326;20924.372268831958;29963.55054674225;30110.09669709912;30139.246518837204;30236;30236.546451802802;195356;195488.45115488337;195923;196011;196081;27365;27703;28027.579586305816;28033.579496307164;28067.859660701564;33396.49905251375;34429.655703442644;35045.47431788576;35208.295834083685;35254;29195;29453.705462945098;29506.409871802873;29612.259693507836;29867.253318667208;29113;29202.269943251587;30155.175171973257;30471.542926855673;30472.542911856784;29047.12858614245;29071;29097.27256818512;29162.416751664423;29736;25946;27119.45761084728;27295;27511.449771004067;28083.578746319232;21066.978579145798;21310.147594096063;21504.354869353945;21514;22376.88811555997 09:16:51 INFO - PID 12955 | |2;jquery.html;411.93820926860985;416.5771741682193;416.8291000689718;436.9650427965762;440.34828453888247;14854.777178342307;17075.914620426895;17623.383181588648;17776.55558611034;18273.81726182738;17522.561935951606;17590.64818703625;17639.470815875546;17739.20173592188;17762.111894405294;3706.5366829146355;3726.4782930389765;3871.502880641984;3917.902052448683;3940.3104456720102;3847.865324713636;3895.844166233347;3917.2557214129224;3921.1961547882756;3924.8822535323843;3867.5552311484257;3876.573576906538;3878.030492376906;3885.57258701544;3895.7467764595353;3737.7196710246703;3798.734088613798;3821.5032045833864;3893.6885049196;3897.649211570958;3500.859965601373;3518.5074089627474;3520.5951315598522;3536.752427330088;3559.626239244894;21484.140634374606;21984.120635174575;22026.669599956014;22084.33746987593;22238.221662241907;1595.920203989796;1613.9596510087224;1619.3684463059417;1664.0514906503297;1664.2760399226254;13571.864281357159;13627;13696.726065478635;13867.4453021879;14454.927725361411;1715.8970461772333;1725.1546742096407;1732.575518997841;1739.4520725971406;1765.2321240260528;76169;76846.61576692137;77628.22371776267;77996.22003779946;78589.60705196437;10208.693739187836;10424.322419042737;10525.36847789135;10654.414007229521;10696.839547406795;13147.934260328637;15549.922250388676;15559.533214003599;15579;15612.3755049799;6364.6316042051185;7178.641067946582;7438.962805185939;7514.248575142442;7534.0582427196605;6485.643289619022;6560.409563139245;6801.21785994607;6806.115205023414;6812.284710105467;6576.76981305652;6719.865602687919;6751.932480675228;6771.966140169267;6816.897746533806;2047.7235573197725;2102.295730930125;2106.6313395155785;2117.163720330461;2118.6927895455074;855.6320782063773;870.760540851271;885.7201344057903;888;910.2308549275983;15977;16339.754903676454;16344.427945021867;16534.338626455046;17171.484855454357;870.8171284030298;874.5364956573027;880.3133555826465;881.3698205782896;893.071205945822;8713;9101.135392137736;9234.399764015317;9314.115159059878;9434.669786557575;398219;403020;417201;419908;426096;61734.38265617376;79876;80437;82748.17251827405;86506.75412196374;1050.7845891592358;1068.834330678746;1092.2736380307165;1101.4492753623188;1104.1608377632897;15801.525954221392;16203.75694364562;16398.754018689968;16455.9177204118;16475.34098636041;41715.16569668529;41903.58096418997;42058.78970605128;42893;42978;50550.494495054576;51862;51997;52577;53012.73493632507;7501.849963000818;7637.198094200029;7709.383249339927;7800.648970796215;8261.463004904663;11870.643880683594;12022.879771202526;12154.878451215729;12387.442565084413;12455.688607784878;10365.481725913825;10507.684769456928;10968.122550196125;11127.276727012719;11587.710307242387;10468.68593942183;10666.679999600025;10678.466076695979;10714.946425267824;10857.40284284372;9846.901530984598;10402;11283.774324513299;11367.431628418712;11682.532698691957;7747;8211.794705132419;8533.061363249913;8577.95711021441;8787.077356877691;9920.107190352903;10269.332493387907;10297.897021029694;10567.78864422692;10614.8407773885 09:16:51 INFO - PID 12955 | |3;mootools.html;1251.749650069986;1273.9171953823002;1288.4974859804684;1288.6391810293114;1292.0374321130753;9192.126747958942;9570.995045520225;9590.85613715794;9706.272029597772;9960.302778805486;9684.37051591646;9795.95102024489;9800.215982721384;9819.705408837728;9846.458444785534;2179.891005449725;2223.110755697726;2233.218373569246;2235.0612742648045;2243.270936945491;2073.5749171419825;2125.521757604542;2127.223563399356;2131.0836340373635;2142.4858034071867;2099.6325643012487;2140.7752186020475;2143.8177754890853;2146.474113842103;2163.935081947536;2084.739407574053;2086.426232785981;2087.728595282611;2089.571637814252;2089.9895500522553;1748.3356324596573;1813.8548916086681;2060.721802556666;2065.060397519125;2112.4718820294925;9381.5309234538;9628.71113866585;9651.903480965171;9689.806203875884;9699.272554558436;5105.591552675777;5343.358796944352;5345.33183352081;5351.357837059578;5359.758810853521;3176.12656519459;3201.935961280761;3225.8064516129107;3261.5596894419186;3269.9182520436943;1037.9584816607326;1041.9479026048743;1049.380865289483;1064.2337516987757;1071.8606581144402;14167.149971001772;14437.927810360987;14501.057431266934;14543.127412355187;14545.636359091002;4694.910684865809;4836.540528649773;4847.466778654345;4925.310456536088;4941.975290123526;11866.525338986516;11923.70190745221;11985.820212696817;12033.699157521132;12079.033677305795;5378.058839703036;5476.644018138808;5479.315085614298;5509.944900550943;5523.502884740393;4693.647976401715;4758.500357462417;4837.443693975168;4873.488283730228;5025.14572522672;3926.54844692864;4003.5195776507007;4053.3717273822604;4077.7145599808323;4104.589541045932;1263.185245516655;1264.4942023190797;1278.4949944771763;1282.9037822163375;1289.4326496341766;614.370270472769;638.457311285413;650.768977013163;656.5535435903631;657.2868437745004;4872.342233798463;4900.656954013256;4918.508149185053;5006.4492905780335;5135.589152867761;511.60861940614717;513.0841448015275;520.7110053920035;521.9947800522023;532.7682458130726;2935.9559606605917;2978.74680652147;3095.1488340706037;3818.0645741792882;3916.4321173429694;10539.947300263602;11058.944705276423;11903.642890713292;12329.50681972729;12464.875351246554;11802.11484138693;12113.454894529767;12235;12305;12406.255624662368;8687.782805429915;8770.868436973451;8895.555222238861;8898.243649289754;8904.287656987426;5511.283533140666;5654.15187721845;5716;5773.797917072882;5917.6745279010065;10656.8934310659;11199;11278.887211127783;11402.714932126763;11523.250988686044;11046.392448415414;11060.778784424105;11126.276792008493;11188;11201.943990279997;8013.078495972804;8168.509889406655;8173.427860049739;8280.420370574002;8282.4202305838;9056.909430905607;9057.637694492147;9182.311326650395;9199.172074513326;9214.585343659686;7662.923370766221;7740.380769538311;7750.612469376396;7794.727184548514;7867.409944254318;7920.762377128695;8025.317847982987;8089.2315230053055;8108.918910810817;8135.30849877767;6948.687309071205;7005.684744186422;7072;7090.361867431956;7100;5080.212567052113;5163.509466600667;5207.791688332424;5254.080535906125;5266.07843627356;5003.299538064746;5107.6169287302855;5171.612129090258;5175.870603234798;5293.153095504701 09:16:51 INFO - PID 12955 | |4;prototype.html;378.22463948904755;382.8640832504461;397.28885295321373;408.9631933126018;411.75089071111955;5370.409254981949;5444.646098003627;5460.999999999995;5515.972420137899;5546.611737178399;5274.498922602346;5360.812371566996;5377.677339359641;5377.946220537793;5396.325459317585;4187.832486700544;4198;4203.579642035795;4209.894752631178;4212.389203565481;3995.8201880915285;4160.39674247234;4207.347861081537;4221.7255878367805;4223.788810559475;4144.357624568197;4153.813078411479;4159.126583417486;4163.937540936889;4170.645495132917;4163.8959026024595;4168.458100446953;4175.8956026099595;4178.310578754517;4188.28799104153;3671.4492826076303;3695;3710.5732840723394;3719.0702324418894;3722.8510859565586;5099.36257967754;5234.7120908350025;5260.579153667697;5275.103232450492;5277.815276465343;4805.1590971579835;4807.879803004917;4811;4824.445188803297;4829.1307564638355;5487.5609951203805;5633.126865335879;5648.293963254593;5665.575081868877;5679.630823996427;4026.094128821021;4034.7780872052026;4035.233305671913;4039.7576145431367;4047.2107938951917;5696.800611978602;5735.799247026376;5837.211976383176;5917.378675239081;6007.36922623127;4098.672106231495;4100.774457404871;4132.669386449077;4138.937915931264;4147.460830092069;4192.266353388145;4212.578742125763;4215.936760948588;4216.135692183095;4218.557051509547;4681.695689780221;4745.369222069025;4755.619550435957;4800.207965685623;4801.591864691541;5700.458456446631;5710.885782284414;5717;5721.799737009268;5747.252857128547;1434.9139051656934;1457.3733294683389;1458.3145921416917;1459.1755658053166;1464.4874293997016;945.8267512495615;972.7743043764907;980.352967041749;981.7594689301167;1000.0749306891242;4926.211806111077;4933.975330123399;4934.629902757308;4940.1601727706375;4941.950580494149;5881.2942446906645;5886.615196262166;5894.528437724972;5928.970355148283;5933.851653708692;4787.996543611934;4902.4362198346935;4943.505649435027;4961.404631444249;4966.15575352191;3100.3489267253676;3112.673169317234;3123.7813353065067;3130.248740302311;3142.6385965614245;5445.292112025411;5454.91817622736;5458.263134476795;5462.317210348707;5471.808486703026;5737.971310143506;6013.9699301503215;6015.187949626745;6025.9096113558335;6051.213342265565;5375.92481503693;5433.809816656477;5436.21174929633;5458.754356053908;5474.178873168898;5666.858328541819;5859.589828711949;5879.147523608967;5906.7341969612335;5917.733701983335;5772.913406298825;5776.480116789509;5810.140754958373;5810.941890581209;5819.730305181068;5197.7141257231215;5284.735763211901;5335.279737235423;5423.5932305076485;5428.782848686008;4089.3661482470266;4123.9793801032;4129.69027322958;4130.524989626111;4134.855280065183;5514.420985796594;5865.472107510344;5872.794452194153;5885.94114058871;5899.705014749331;5618.747156378055;5696.572757043321;5712.685802280748;5713.285839270091;5724.57065720081;5655.604107712421;5689.943100569107;5739.62692424991;5749.281339832521;5751.712414379348;5400.324959380077;5622.156676498558;5650.717464126859;5660.54715622741;5662.546996240373;5774.82675519735;5777.9133313001175;5780.479756821906;5798.507126894261;5809.796657116981;5503;5619.662820230799;5641.605087643826;5652.590979036194;5653.745581448927 09:16:51 INFO - PID 12955 | |5;yui.html;684.8869936460484;687.4019602945436;704.5561296383278;717.1394326807829;734.922833102524;11917.106217033725;12052.638420847388;12235.38823058848;12370.443330050146;13486.865131348684;13135.540256091039;13369.264690442022;13384.93307533461;13405.731885362311;13409.664758381045;638.2723694987718;655.885220086483;839.689314953468;849.2399302624148;852.4672079950032;827.6523859978823;853.9487630742144;863.7840539865034;866.8656358264479;869.6651789061225;908.604756930734;909.1363204955319;911.1890417528405;911.5487833522383;914.2183433164648;899.8200359927976;901.5492253873064;908.2869947091567;909.3679892474732;910.1762904571374;649.0945131541473;655.1057806094694;656.0651072222112;661.5997321620398;662.5329142954206;13319;13321.333933303393;13369;13384.397702103428;13665.18008919468;13287.667808304774;13916.234607096605;14090.365933533016;14196.290185490685;14243.643908902257;10375.16998640107;10390.84413733787;10482.161427085892;10527.578896844117;10667.466626668713;2613.529564678357;2633.170551276361;2654.9070782522713;2693.6902256240587;2709.607106969498;58173.709131454496;58793.41206587922;58938;59033.40966590322;59682.40317596812;9080.455172689659;9129.863052054225;9232.27683962549;9246.583903724348;9545.093216144454;14446.133232006114;14790.334434950453;14860.851391486163;15014.174220417983;15018.849811501963;6490.545661803723;6509.837254068591;6517.380848819449;6538.215414150332;6770;3247.1719711473897;3352.430086885235;3363.4618461046116;3439.7764145330975;3446.0351101691567;3486.4073107571776;3516.701080408143;3517.43721004638;3531.964680353215;3552.6980206682206;658.58180055665;658.8188248231775;659.1233659233209;666.3835951744617;681.437813803614;531.5322516185809;557.3924422379625;561.6040691312696;563.1524555543962;573.6386076771607;9018.639254429749;9234.261259099256;9277.16505514507;9294.953525232466;9339.766505837408;541.6777017674477;542.9185622156708;545.353755799379;545.3837164004649;550.5347980956086;3827.8468861245797;3885.184111336651;3897.941530877039;4001.199760048002;4073.8745210727757;59448;61139;61873;63102.368976310565;63532.68233658802;39060;44279;52828.20757688638;53033.575299458105;53751.73124134433;43974;44891.775541122086;44965.32552011722;45642.77178614152;46083.30875036877;9027.32295077885;9485.430874147572;9589.875135993118;9603.135717785433;9611.711648650551;23378.090036428297;23381.181658641864;23860;23922.162724304566;24552.263432097065;29445;29828.254293642833;29844.10467685973;29993;30158.69841301559;11636.301821890374;11678;11787.882121178678;12040.337781422106;12374.010079193464;12153.392330383269;12514.687132821753;12518.186317889307;12615;12680.492780288685;11612.361320127475;11747.823782643096;11748;11798.41007949582;12133.635990920286;11565.537378505102;12114.273143611412;12170.269783812999;12480.563180288646;12532.310722910328;11845.881541184823;11992.700182495508;11994.400279985792;12040.819387709016;12133.453994570089;9344.579493922925;9956.900430995887;10320.845187322346;10434.68695939123;10512.106470950055;9131.634734610541;9139.58871850755;9245.630174792934;9935.105840474103;9971 09:16:51 INFO - PID 12955 | __end_tp_report 09:16:51 INFO - PID 12955 | __start_cc_report 09:16:51 INFO - PID 12955 | _x_x_mozilla_cycle_collect,395 09:16:51 INFO - PID 12955 | __end_cc_report 09:16:51 INFO - PID 12955 | __startTimestamp1490113011038__endTimestamp 09:16:51 INFO - PID 12955 | 09:16:51 INFO - PID 12955 | ------- Summary: start ------- 09:16:51 INFO - PID 12955 | Number of tests: 6 09:16:51 INFO - PID 12955 | 09:16:51 INFO - PID 12955 | [#0] dojo.html Cycles:165 Average:5046.79 Median:5177.38 stddev:561.82 (10.9%) stddev-sans-first:532.07 09:16:51 INFO - PID 12955 | Values: 2683.5 2701.4 2709.8 2719.3 2733.4 5003.5 5028.6 5031.9 5090.3 5115.4 5068.2 5080.1 5100.4 5133.2 5146.3 4604.1 4626.6 4638.0 4653.4 4676.6 4659.5 4662.9 4673.3 4701.3 4740.2 4628.4 4631.3 4648.7 4689.0 4691.0 4668.9 4674.2 4684.9 4697.7 4742.8 4628.8 4633.2 4645.1 4671.9 4699.9 4979.0 5026.3 5096.6 5110.9 5140.7 5473.5 5481.3 5484.4 5491.0 5539.3 5507.6 5529.3 5546.8 5551.8 5557.7 5036.2 5047.4 5113.2 5144.5 5180.0 5643.2 5690.8 5694.7 5734.9 5754.7 5301.6 5353.3 5379.0 5421.9 5427.4 5454.1 5517.9 5546.8 5555.6 5586.9 5274.9 5364.4 5484.9 5490.4 5522.1 5510.5 5522.2 5523.9 5542.5 5545.7 4695.8 4705.2 4705.9 4710.3 4735.0 3960.8 3995.3 4022.2 4037.0 4067.2 4622.5 4694.4 4709.8 4741.2 4747.3 5449.8 5467.4 5485.8 5506.2 5530.2 4646.1 4704.8 4716.2 4719.6 4774.8 4870.6 4876.4 4878.8 4879.6 4882.7 5006.3 5036.7 5036.9 5037.4 5049.2 5391.4 5431.3 5437.9 5438.7 5532.4 5172.3 5177.4 5178.7 5212.1 5233.8 5430.4 5486.0 5489.4 5493.0 5507.2 5382.5 5451.9 5452.0 5580.8 5608.6 5244.8 5246.1 5250.9 5254.5 5257.0 5246.6 5250.7 5254.7 5260.2 5263.7 5145.6 5154.3 5185.7 5193.5 5194.6 5348.8 5398.8 5478.9 5496.0 5500.1 5257.3 5261.9 5272.2 5300.5 5310.4 09:16:51 INFO - PID 12955 | 09:16:51 INFO - PID 12955 | [#1] ext.html Cycles:180 Average:31651.17 Median:27607.22 stddev:49285.32 (178.5%) stddev-sans-first:49368.82 09:16:51 INFO - PID 12955 | Values: 710.5 726.5 733.6 756.7 762.1 33611.8 34723.0 34816.3 34843.0 34870.3 31114.8 31464.0 31518.5 31544.5 31560.5 2227.4 2357.7 2362.5 2377.0 2432.8 2437.4 2457.6 2483.2 2491.3 2495.9 2445.4 2473.7 2476.5 2478.6 2479.1 2448.2 2481.0 2481.4 2489.6 2493.3 2462.5 2484.1 2484.3 2484.8 2490.5 33839.2 33922.8 34318.3 34337.5 34423.1 2641.6 2651.0 2657.2 2663.4 2675.9 23278.9 23692.9 23864.0 24219.8 24644.1 2927.8 2957.9 2986.1 3010.6 3011.6 146547.3 147124.3 147694.3 147750.3 147855.0 31692.7 31886.4 35417.8 40621.6 40739.0 37445.0 37543.8 37713.4 37838.8 37881.2 10797.4 10906.3 10924.0 10935.7 10947.3 8517.8 8536.3 8579.7 8583.1 8594.1 12086.6 12141.6 12144.7 12263.6 12291.9 5113.4 5127.9 5137.7 5149.6 5151.3 871.6 900.4 905.8 907.0 934.8 19931.3 20973.7 21002.6 21045.2 21330.7 937.8 952.6 962.8 973.6 1009.5 10603.0 10652.8 10859.6 11032.4 11073.4 212017.0 215735.0 215861.0 216162.0 217146.0 42527.0 42958.8 43039.6 43081.0 43117.8 1188.7 1256.5 1257.0 1258.6 1268.4 19087.2 19174.5 19330.3 20556.5 20924.4 29963.6 30110.1 30139.2 30236.0 30236.5 195356.0 195488.5 195923.0 196011.0 196081.0 27365.0 27703.0 28027.6 28033.6 28067.9 33396.5 34429.7 35045.5 35208.3 35254.0 29195.0 29453.7 29506.4 29612.3 29867.3 29113.0 29202.3 30155.2 30471.5 30472.5 29047.1 29071.0 29097.3 29162.4 29736.0 25946.0 27119.5 27295.0 27511.4 28083.6 21067.0 21310.1 21504.4 21514.0 22376.9 09:16:51 INFO - PID 12955 | 09:16:51 INFO - PID 12955 | [#2] jquery.html Cycles:180 Average:25568.90 Median:3768.23 stddev:68289.20 (1812.2%) stddev-sans-first:68454.65 09:16:51 INFO - PID 12955 | Values: 411.9 416.6 416.8 437.0 440.3 14854.8 17075.9 17623.4 17776.6 18273.8 17522.6 17590.6 17639.5 17739.2 17762.1 3706.5 3726.5 3871.5 3917.9 3940.3 3847.9 3895.8 3917.3 3921.2 3924.9 3867.6 3876.6 3878.0 3885.6 3895.7 3737.7 3798.7 3821.5 3893.7 3897.6 3500.9 3518.5 3520.6 3536.8 3559.6 21484.1 21984.1 22026.7 22084.3 22238.2 1595.9 1614.0 1619.4 1664.1 1664.3 13571.9 13627.0 13696.7 13867.4 14454.9 1715.9 1725.2 1732.6 1739.5 1765.2 76169.0 76846.6 77628.2 77996.2 78589.6 10208.7 10424.3 10525.4 10654.4 10696.8 13147.9 15549.9 15559.5 15579.0 15612.4 6364.6 7178.6 7439.0 7514.2 7534.1 6485.6 6560.4 6801.2 6806.1 6812.3 6576.8 6719.9 6751.9 6772.0 6816.9 2047.7 2102.3 2106.6 2117.2 2118.7 855.6 870.8 885.7 888.0 910.2 15977.0 16339.8 16344.4 16534.3 17171.5 870.8 874.5 880.3 881.4 893.1 8713.0 9101.1 9234.4 9314.1 9434.7 398219.0 403020.0 417201.0 419908.0 426096.0 61734.4 79876.0 80437.0 82748.2 86506.8 1050.8 1068.8 1092.3 1101.4 1104.2 15801.5 16203.8 16398.8 16455.9 16475.3 41715.2 41903.6 42058.8 42893.0 42978.0 50550.5 51862.0 51997.0 52577.0 53012.7 7501.8 7637.2 7709.4 7800.6 8261.5 11870.6 12022.9 12154.9 12387.4 12455.7 10365.5 10507.7 10968.1 11127.3 11587.7 10468.7 10666.7 10678.5 10714.9 10857.4 9846.9 10402.0 11283.8 11367.4 11682.5 7747.0 8211.8 8533.1 8578.0 8787.1 9920.1 10269.3 10297.9 10567.8 10614.8 09:16:51 INFO - PID 12955 | 09:16:51 INFO - PID 12955 | [#3] mootools.html Cycles:180 Average:6055.72 Median:4859.90 stddev:3851.94 (79.3%) stddev-sans-first:3845.83 09:16:51 INFO - PID 12955 | Values: 1251.7 1273.9 1288.5 1288.6 1292.0 9192.1 9571.0 9590.9 9706.3 9960.3 9684.4 9796.0 9800.2 9819.7 9846.5 2179.9 2223.1 2233.2 2235.1 2243.3 2073.6 2125.5 2127.2 2131.1 2142.5 2099.6 2140.8 2143.8 2146.5 2163.9 2084.7 2086.4 2087.7 2089.6 2090.0 1748.3 1813.9 2060.7 2065.1 2112.5 9381.5 9628.7 9651.9 9689.8 9699.3 5105.6 5343.4 5345.3 5351.4 5359.8 3176.1 3201.9 3225.8 3261.6 3269.9 1038.0 1041.9 1049.4 1064.2 1071.9 14167.1 14437.9 14501.1 14543.1 14545.6 4694.9 4836.5 4847.5 4925.3 4942.0 11866.5 11923.7 11985.8 12033.7 12079.0 5378.1 5476.6 5479.3 5509.9 5523.5 4693.6 4758.5 4837.4 4873.5 5025.1 3926.5 4003.5 4053.4 4077.7 4104.6 1263.2 1264.5 1278.5 1282.9 1289.4 614.4 638.5 650.8 656.6 657.3 4872.3 4900.7 4918.5 5006.4 5135.6 511.6 513.1 520.7 522.0 532.8 2936.0 2978.7 3095.1 3818.1 3916.4 10539.9 11058.9 11903.6 12329.5 12464.9 11802.1 12113.5 12235.0 12305.0 12406.3 8687.8 8770.9 8895.6 8898.2 8904.3 5511.3 5654.2 5716.0 5773.8 5917.7 10656.9 11199.0 11278.9 11402.7 11523.3 11046.4 11060.8 11126.3 11188.0 11201.9 8013.1 8168.5 8173.4 8280.4 8282.4 9056.9 9057.6 9182.3 9199.2 9214.6 7662.9 7740.4 7750.6 7794.7 7867.4 7920.8 8025.3 8089.2 8108.9 8135.3 6948.7 7005.7 7072.0 7090.4 7100.0 5080.2 5163.5 5207.8 5254.1 5266.1 5003.3 5107.6 5171.6 5175.9 5293.2 09:16:51 INFO - PID 12955 | 09:16:51 INFO - PID 12955 | [#4] prototype.html Cycles:180 Average:4707.37 Median:5365.61 stddev:1365.52 (25.4%) stddev-sans-first:1330.13 09:16:51 INFO - PID 12955 | Values: 378.2 382.9 397.3 409.0 411.8 5370.4 5444.6 5461.0 5516.0 5546.6 5274.5 5360.8 5377.7 5377.9 5396.3 4187.8 4198.0 4203.6 4209.9 4212.4 3995.8 4160.4 4207.3 4221.7 4223.8 4144.4 4153.8 4159.1 4163.9 4170.6 4163.9 4168.5 4175.9 4178.3 4188.3 3671.4 3695.0 3710.6 3719.1 3722.9 5099.4 5234.7 5260.6 5275.1 5277.8 4805.2 4807.9 4811.0 4824.4 4829.1 5487.6 5633.1 5648.3 5665.6 5679.6 4026.1 4034.8 4035.2 4039.8 4047.2 5696.8 5735.8 5837.2 5917.4 6007.4 4098.7 4100.8 4132.7 4138.9 4147.5 4192.3 4212.6 4215.9 4216.1 4218.6 4681.7 4745.4 4755.6 4800.2 4801.6 5700.5 5710.9 5717.0 5721.8 5747.3 1434.9 1457.4 1458.3 1459.2 1464.5 945.8 972.8 980.4 981.8 1000.1 4926.2 4934.0 4934.6 4940.2 4942.0 5881.3 5886.6 5894.5 5929.0 5933.9 4788.0 4902.4 4943.5 4961.4 4966.2 3100.3 3112.7 3123.8 3130.2 3142.6 5445.3 5454.9 5458.3 5462.3 5471.8 5738.0 6014.0 6015.2 6025.9 6051.2 5375.9 5433.8 5436.2 5458.8 5474.2 5666.9 5859.6 5879.1 5906.7 5917.7 5772.9 5776.5 5810.1 5810.9 5819.7 5197.7 5284.7 5335.3 5423.6 5428.8 4089.4 4124.0 4129.7 4130.5 4134.9 5514.4 5865.5 5872.8 5885.9 5899.7 5618.7 5696.6 5712.7 5713.3 5724.6 5655.6 5689.9 5739.6 5749.3 5751.7 5400.3 5622.2 5650.7 5660.5 5662.5 5774.8 5777.9 5780.5 5798.5 5809.8 5503.0 5619.7 5641.6 5652.6 5653.7 09:16:51 INFO - PID 12955 | 09:16:51 INFO - PID 12955 | [#5] yui.html Cycles:180 Average:13363.68 Median:44585.39 stddev:15917.87 (35.7%) stddev-sans-first:15934.05 09:16:51 INFO - PID 12955 | Values: 684.9 687.4 704.6 717.1 734.9 11917.1 12052.6 12235.4 12370.4 13486.9 13135.5 13369.3 13384.9 13405.7 13409.7 638.3 655.9 839.7 849.2 852.5 827.7 853.9 863.8 866.9 869.7 908.6 909.1 911.2 911.5 914.2 899.8 901.5 908.3 909.4 910.2 649.1 655.1 656.1 661.6 662.5 13319.0 13321.3 13369.0 13384.4 13665.2 13287.7 13916.2 14090.4 14196.3 14243.6 10375.2 10390.8 10482.2 10527.6 10667.5 2613.5 2633.2 2654.9 2693.7 2709.6 58173.7 58793.4 58938.0 59033.4 59682.4 9080.5 9129.9 9232.3 9246.6 9545.1 14446.1 14790.3 14860.9 15014.2 15018.8 6490.5 6509.8 6517.4 6538.2 6770.0 3247.2 3352.4 3363.5 3439.8 3446.0 3486.4 3516.7 3517.4 3532.0 3552.7 658.6 658.8 659.1 666.4 681.4 531.5 557.4 561.6 563.2 573.6 9018.6 9234.3 9277.2 9295.0 9339.8 541.7 542.9 545.4 545.4 550.5 3827.8 3885.2 3897.9 4001.2 4073.9 59448.0 61139.0 61873.0 63102.4 63532.7 39060.0 44279.0 52828.2 53033.6 53751.7 43974.0 44891.8 44965.3 45642.8 46083.3 9027.3 9485.4 9589.9 9603.1 9611.7 23378.1 23381.2 23860.0 23922.2 24552.3 29445.0 29828.3 29844.1 29993.0 30158.7 11636.3 11678.0 11787.9 12040.3 12374.0 12153.4 12514.7 12518.2 12615.0 12680.5 11612.4 11747.8 11748.0 11798.4 12133.6 11565.5 12114.3 12170.3 12480.6 12532.3 11845.9 11992.7 11994.4 12040.8 12133.5 9344.6 9956.9 10320.8 10434.7 10512.1 9131.6 9139.6 9245.6 9935.1 9971.0 09:16:51 INFO - PID 12955 | -------- Summary: end -------- 09:16:51 INFO - PID 12955 | 09:16:51 INFO - TEST-INFO | 12955: exit 0 09:16:51 INFO - TEST-OK | dromaeo_css | took 1122148ms 09:16:51 INFO - TEST-START | kraken 09:16:51 INFO - operating with platform_type : linux_ 09:16:51 INFO - Initialising browser for kraken test... 09:16:51 INFO - TEST-INFO | started process 13334 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGfviOk/profile http://localhost:48332/getInfo.html) 09:16:56 INFO - PID 13334 | __metrics Screen width/height:1600/1200 09:16:56 INFO - PID 13334 | colorDepth:24 09:16:56 INFO - PID 13334 | Browser inner width/height: 1024/697 09:16:56 INFO - PID 13334 | __metrics 09:16:57 ERROR - PID 13334 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 09:16:58 INFO - TEST-INFO | 13334: exit 0 09:16:58 INFO - Browser initialized. 09:16:58 INFO - Running cycle 1/1 for kraken test... 09:16:58 INFO - TEST-INFO | started process 13465 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGfviOk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:17:10 INFO - PID 13465 | RSS: Main: 155148288 09:17:10 INFO - PID 13465 | 09:17:13 INFO - PID 13465 | Cycle 1(1): loaded http://localhost:48332/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48332/tests/kraken/driver.html?testName=audio-beat-detection) 09:17:14 INFO - PID 13465 | RSS: Main: 161079296 09:17:14 INFO - PID 13465 | 09:17:16 INFO - PID 13465 | Cycle 1(1): loaded http://localhost:48332/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48332/tests/kraken/driver.html?testName=audio-dft) 09:17:17 INFO - PID 13465 | RSS: Main: 161513472 09:17:17 INFO - PID 13465 | 09:17:20 INFO - PID 13465 | Cycle 1(1): loaded http://localhost:48332/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48332/tests/kraken/driver.html?testName=audio-fft) 09:17:21 INFO - PID 13465 | RSS: Main: 157577216 09:17:21 INFO - PID 13465 | 09:17:23 INFO - PID 13465 | Cycle 1(1): loaded http://localhost:48332/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48332/tests/kraken/driver.html?testName=audio-oscillator) 09:17:23 INFO - PID 13465 | RSS: Main: 158126080 09:17:23 INFO - PID 13465 | 09:17:26 INFO - PID 13465 | Cycle 1(1): loaded http://localhost:48332/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48332/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:17:26 INFO - PID 13465 | RSS: Main: 159232000 09:17:26 INFO - PID 13465 | 09:17:29 INFO - PID 13465 | Cycle 1(1): loaded http://localhost:48332/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48332/tests/kraken/driver.html?testName=imaging-darkroom) 09:17:30 INFO - PID 13465 | RSS: Main: 163196928 09:17:30 INFO - PID 13465 | 09:17:34 INFO - PID 13465 | Cycle 1(1): loaded http://localhost:48332/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48332/tests/kraken/driver.html?testName=imaging-desaturate) 09:17:34 INFO - PID 13465 | RSS: Main: 160829440 09:17:34 INFO - PID 13465 | 09:17:37 INFO - PID 13465 | Cycle 1(1): loaded http://localhost:48332/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48332/tests/kraken/driver.html?testName=json-parse-financial) 09:17:38 INFO - PID 13465 | RSS: Main: 162058240 09:17:38 INFO - PID 13465 | 09:17:40 INFO - PID 13465 | Cycle 1(1): loaded http://localhost:48332/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48332/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:17:40 INFO - PID 13465 | RSS: Main: 161873920 09:17:40 INFO - PID 13465 | 09:17:42 INFO - PID 13465 | Cycle 1(1): loaded http://localhost:48332/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48332/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:17:43 INFO - PID 13465 | RSS: Main: 161566720 09:17:43 INFO - PID 13465 | 09:17:45 INFO - PID 13465 | Cycle 1(1): loaded http://localhost:48332/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48332/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:17:46 INFO - PID 13465 | RSS: Main: 162537472 09:17:46 INFO - PID 13465 | 09:17:49 INFO - PID 13465 | Cycle 1(1): loaded http://localhost:48332/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48332/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:17:49 INFO - PID 13465 | RSS: Main: 164061184 09:17:49 INFO - PID 13465 | 09:17:53 INFO - PID 13465 | Cycle 1(1): loaded http://localhost:48332/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48332/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:17:53 INFO - PID 13465 | RSS: Main: 162926592 09:17:53 INFO - PID 13465 | 09:17:55 INFO - PID 13465 | Cycle 1(1): loaded http://localhost:48332/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48332/tests/kraken/driver.html?testName=ai-astar) 09:17:55 INFO - PID 13465 | RSS: Main: 164892672 09:17:55 INFO - PID 13465 | 09:17:55 INFO - PID 13465 | __start_tp_report 09:17:55 INFO - PID 13465 | _x_x_mozilla_page_load 09:17:55 INFO - PID 13465 | _x_x_mozilla_page_load_details 09:17:55 INFO - PID 13465 | |i|pagename|runs| 09:17:55 INFO - PID 13465 | |0;ai-astar;104;111;111;114;112;112;112;111;112;112 09:17:55 INFO - PID 13465 | |1;audio-beat-detection;156;126;124;184;126;126;128;127;148;126 09:17:55 INFO - PID 13465 | |2;audio-dft;165;166;166;170;169;167;165;165;163;166 09:17:55 INFO - PID 13465 | |3;audio-fft;75;75;78;124;76;76;76;77;96;79 09:17:55 INFO - PID 13465 | |4;audio-oscillator;85;84;122;85;86;84;98;86;85;105 09:17:55 INFO - PID 13465 | |5;imaging-gaussian-blur;114;115;114;114;124;119;115;114;114;114 09:17:55 INFO - PID 13465 | |6;imaging-darkroom;151;150;151;150;151;151;150;150;151;151 09:17:55 INFO - PID 13465 | |7;imaging-desaturate;96;94;95;94;95;95;94;97;99;94 09:17:55 INFO - PID 13465 | |8;json-parse-financial;68;71;68;75;75;70;70;70;71;71 09:17:55 INFO - PID 13465 | |9;json-stringify-tinderbox;56;56;55;55;55;56;56;56;56;55 09:17:55 INFO - PID 13465 | |10;stanford-crypto-aes;87;84;83;83;83;82;85;90;82;83 09:17:55 INFO - PID 13465 | |11;stanford-crypto-ccm;141;141;139;136;135;134;138;139;185;134 09:17:55 INFO - PID 13465 | |12;stanford-crypto-pbkdf2;186;199;196;202;206;194;200;201;200;192 09:17:55 INFO - PID 13465 | |13;stanford-crypto-sha256-iterative;72;74;71;73;71;74;73;73;71;71 09:17:55 INFO - PID 13465 | __end_tp_report 09:17:55 INFO - PID 13465 | __start_cc_report 09:17:55 INFO - PID 13465 | _x_x_mozilla_cycle_collect,896 09:17:55 INFO - PID 13465 | __end_cc_report 09:17:55 INFO - PID 13465 | __startTimestamp1490113075772__endTimestamp 09:17:55 INFO - PID 13465 | 09:17:55 INFO - PID 13465 | ------- Summary: start ------- 09:17:55 INFO - PID 13465 | Number of tests: 14 09:17:55 INFO - PID 13465 | 09:17:55 INFO - PID 13465 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:2.64 (2.4%) stddev-sans-first:0.93 09:17:55 INFO - PID 13465 | Values: 104.0 111.0 111.0 114.0 112.0 112.0 112.0 111.0 112.0 112.0 09:17:55 INFO - PID 13465 | 09:17:55 INFO - PID 13465 | [#1] audio-beat-detection Cycles:10 Average:137.10 Median:127.50 stddev:19.79 (15.5%) stddev-sans-first:19.77 09:17:55 INFO - PID 13465 | Values: 156.0 126.0 124.0 184.0 126.0 126.0 128.0 127.0 148.0 126.0 09:17:55 INFO - PID 13465 | 09:17:55 INFO - PID 13465 | [#2] audio-dft Cycles:10 Average:166.20 Median:166.00 stddev:2.04 (1.2%) stddev-sans-first:2.12 09:17:55 INFO - PID 13465 | Values: 165.0 166.0 166.0 170.0 169.0 167.0 165.0 165.0 163.0 166.0 09:17:55 INFO - PID 13465 | 09:17:55 INFO - PID 13465 | [#3] audio-fft Cycles:10 Average:83.20 Median:76.50 stddev:15.64 (20.4%) stddev-sans-first:16.31 09:17:55 INFO - PID 13465 | Values: 75.0 75.0 78.0 124.0 76.0 76.0 76.0 77.0 96.0 79.0 09:17:55 INFO - PID 13465 | 09:17:55 INFO - PID 13465 | [#4] audio-oscillator Cycles:10 Average:92.00 Median:85.00 stddev:12.70 (14.9%) stddev-sans-first:13.22 09:17:55 INFO - PID 13465 | Values: 85.0 84.0 122.0 85.0 86.0 84.0 98.0 86.0 85.0 105.0 09:17:55 INFO - PID 13465 | 09:17:55 INFO - PID 13465 | [#5] imaging-gaussian-blur Cycles:10 Average:115.70 Median:114.50 stddev:3.30 (2.9%) stddev-sans-first:3.44 09:17:55 INFO - PID 13465 | Values: 114.0 115.0 114.0 114.0 124.0 119.0 115.0 114.0 114.0 114.0 09:17:55 INFO - PID 13465 | 09:17:55 INFO - PID 13465 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:151.00 stddev:0.52 (0.3%) stddev-sans-first:0.53 09:17:55 INFO - PID 13465 | Values: 151.0 150.0 151.0 150.0 151.0 151.0 150.0 150.0 151.0 151.0 09:17:55 INFO - PID 13465 | 09:17:55 INFO - PID 13465 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:1.64 (1.7%) stddev-sans-first:1.72 09:17:55 INFO - PID 13465 | Values: 96.0 94.0 95.0 94.0 95.0 95.0 94.0 97.0 99.0 94.0 09:17:55 INFO - PID 13465 | 09:17:55 INFO - PID 13465 | [#8] json-parse-financial Cycles:10 Average:70.90 Median:71.00 stddev:2.42 (3.4%) stddev-sans-first:2.33 09:17:55 INFO - PID 13465 | Values: 68.0 71.0 68.0 75.0 75.0 70.0 70.0 70.0 71.0 71.0 09:17:55 INFO - PID 13465 | 09:17:55 INFO - PID 13465 | [#9] json-stringify-tinderbox Cycles:10 Average:55.60 Median:56.00 stddev:0.52 (0.9%) stddev-sans-first:0.53 09:17:55 INFO - PID 13465 | Values: 56.0 56.0 55.0 55.0 55.0 56.0 56.0 56.0 56.0 55.0 09:17:55 INFO - PID 13465 | 09:17:55 INFO - PID 13465 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:83.50 stddev:2.53 (3.0%) stddev-sans-first:2.47 09:17:55 INFO - PID 13465 | Values: 87.0 84.0 83.0 83.0 83.0 82.0 85.0 90.0 82.0 83.0 09:17:55 INFO - PID 13465 | 09:17:55 INFO - PID 13465 | [#11] stanford-crypto-ccm Cycles:10 Average:142.20 Median:139.00 stddev:15.27 (11.0%) stddev-sans-first:16.19 09:17:55 INFO - PID 13465 | Values: 141.0 141.0 139.0 136.0 135.0 134.0 138.0 139.0 185.0 134.0 09:17:55 INFO - PID 13465 | 09:17:55 INFO - PID 13465 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.60 Median:200.00 stddev:5.74 (2.9%) stddev-sans-first:4.28 09:17:55 INFO - PID 13465 | Values: 186.0 199.0 196.0 202.0 206.0 194.0 200.0 201.0 200.0 192.0 09:17:55 INFO - PID 13465 | 09:17:55 INFO - PID 13465 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:73.00 stddev:1.25 (1.7%) stddev-sans-first:1.32 09:17:55 INFO - PID 13465 | Values: 72.0 74.0 71.0 73.0 71.0 74.0 73.0 73.0 71.0 71.0 09:17:55 INFO - PID 13465 | -------- Summary: end -------- 09:17:55 INFO - PID 13465 | 09:17:56 INFO - TEST-INFO | 13465: exit 0 09:17:56 INFO - TEST-OK | kraken | took 65104ms 09:17:56 INFO - SUITE-END | took 1187s 09:17:57 INFO - Completed test suite (00:19:47) 09:17:57 INFO - javascript benchmark 09:17:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6277.625064122838, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2683.5382356759783, 2701.3786829029336, 2709.8238614490056, 2719.2522056434477, 2733.3986522964947, 5003.474635163301, 5028.597712183026, 5031.899362012758, 5090.31280777095, 5115.360579927509, 5068.1890897456415, 5080.136376815941, 5100.387953445583, 5133.230015497677, 5146.305248791412, 4604.125216208918, 4626.560476754703, 4638.0491999140095, 4653.441587009564, 4676.649251306166, 4659.510751371108, 4662.930056049162, 4673.345731597562, 4701.341812146302, 4740.217864052427, 4628.4445866496235, 4631.258998560214, 4648.651351148677, 4688.976555117237, 4691.038337140878, 4668.883277918079, 4674.205385084544, 4684.906301873943, 4697.741624210667, 4742.786574604151, 4628.8148474061, 4633.235516139833, 4645.070985802853, 4671.906561868777, 4699.929501057487, 4978.9751051244875, 5026.271190677331, 5096.566791822699, 5110.926705391872, 5140.74296285188, 5473.507384335429, 5481.342238931354, 5484.396716361197, 5490.972545137289, 5539.307586551681, 5507.642003269814, 5529.336479622471, 5546.833594992157, 5551.833444996657, 5557.694326812024, 5036.219385995177, 5047.369078865142, 5113.207452844815, 5144.459831717616, 5179.974100129551, 5643.1535269709875, 5690.800821971211, 5694.686792226385, 5734.856628584319, 5754.712264386764, 5301.575873930076, 5353.250544923714, 5379.0, 5421.945780542223, 5427.3758517770175, 5454.10007348791, 5517.862053448615, 5546.833594992157, 5555.611107222537, 5586.888262234733, 5274.947250527445, 5364.436734142937, 5484.862878428071, 5490.423505531861, 5522.144067669517, 5510.476504732044, 5522.171674248895, 5523.917141242885, 5542.528885044736, 5545.72271386429, 4695.812167513262, 4705.153072446924, 4705.905881882343, 4710.29345598163, 4734.95265047352, 3960.782156981336, 3995.2808494471274, 4022.1754540319166, 4036.979815100906, 4067.247559201557, 4622.4684161321875, 4694.389729335165, 4709.788059537329, 4741.2176990796825, 4747.264174053027, 5449.782008719686, 5467.371252305956, 5485.780568777284, 5506.229127922094, 5530.198121272393, 4646.09401166776, 4704.811807527729, 4716.198246298138, 4719.551642593948, 4774.832880849153, 4870.634702397334, 4876.414830220397, 4878.804847806048, 4879.585235255043, 4882.707037577686, 5006.299118123393, 5036.6726162799305, 5036.924446133237, 5037.445880953165, 5049.2426136079885, 5391.406945235943, 5431.266778984945, 5437.918431223456, 5438.728063596725, 5532.419095994863, 5172.327597412313, 5177.378714554127, 5178.689278643294, 5212.139996900621, 5233.842984710464, 5430.429804870431, 5485.966710111407, 5489.423610520837, 5493.038718224375, 5507.173923911445, 5382.4886635769535, 5451.863703407446, 5452.0, 5580.804671836466, 5608.579356548194, 5244.7902083916215, 5246.055709972242, 5250.868728281824, 5254.474552544715, 5256.9737151314, 5246.632735708464, 5250.684958902325, 5254.710990895537, 5260.158374660036, 5263.710495922761, 5145.61407894402, 5154.252633368215, 5185.714785686823, 5193.532582067632, 5194.610404219623, 5348.839534813962, 5398.811041613525, 5478.945210547843, 5496.0, 5500.119980803052, 5257.342832145981, 5261.921071184011, 5272.209168624737, 5300.469953004668, 5310.389305229948], "value": 5007.898795196976, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.545251039335, 726.4624178108198, 733.6111860713822, 756.71623141322, 762.0740799928088, 33611.83194084029, 34723.0, 34816.30367392651, 34843.0, 34870.30259394811, 31114.844425777897, 31464.0, 31518.52722209169, 31544.526832097537, 31560.526592101138, 2227.376334626307, 2357.6817129687443, 2362.456634973957, 2377.0491803278655, 2432.781049705526, 2437.4393889405446, 2457.6190690442922, 2483.192962287255, 2491.302435318105, 2495.8502489850575, 2445.40087678519, 2473.6536884836137, 2476.5294594027077, 2478.628205769131, 2479.119912431088, 2448.2410452759614, 2481.0323973650293, 2481.4292712676097, 2489.639002344668, 2493.3268017635137, 2462.482878595479, 2484.068474322129, 2484.3168128764555, 2484.8260621756485, 2490.489449662833, 33839.15402114942, 33922.83038584791, 34318.31363372743, 34337.48493772595, 34423.139421514665, 2641.603759436081, 2650.9602355964676, 2657.2028391482477, 2663.42736311692, 2675.933101672454, 23278.883605582032, 23692.881535592212, 23864.0, 24219.757802421926, 24644.13745518916, 2927.7657787376957, 2957.8521073946217, 2986.074316961749, 3010.638723353212, 3011.629708482635, 146547.267263663, 147124.2643786785, 147694.26152869273, 147750.26124869307, 147855.0, 31692.683073169435, 31886.362272754413, 35417.8229108858, 40621.593784061784, 40739.0, 37445.0, 37543.81228093897, 37713.43429848555, 37838.81080594634, 37881.24237515289, 10797.380392941122, 10906.34561926287, 10924.016838484575, 10935.671929842118, 10947.34315941046, 8517.787055323666, 8536.317094632415, 8579.699710510102, 8583.05586385497, 8594.054653988056, 12086.637400877988, 12141.575044873387, 12144.69638259033, 12263.570775022832, 12291.877081229251, 5113.386393632788, 5127.948720512822, 5137.6660517066275, 5149.562287205555, 5151.330327057459, 871.5859966515854, 900.4237288135598, 905.7735566108473, 906.954652267384, 934.8130373925106, 19931.302404415776, 20973.685394718785, 21002.579948400948, 21045.15819367239, 21330.680039799416, 937.8358787212211, 952.6046690623452, 962.821877952567, 973.600823662295, 1009.4548943570536, 10603.0, 10652.840207396895, 10859.565617375374, 11032.386646736422, 11073.390963496924, 212017.0, 215735.0, 215861.0, 216162.0, 217146.0, 42527.0, 42958.78520607377, 43039.56960430418, 43081.0, 43117.78441107837, 1188.6612315490045, 1256.497401039573, 1256.9622911312674, 1258.641287233134, 1268.422867595242, 19087.236510539977, 19174.520636984187, 19330.323438679578, 20556.486087847326, 20924.372268831958, 29963.55054674225, 30110.09669709912, 30139.246518837204, 30236.0, 30236.546451802802, 195356.0, 195488.45115488337, 195923.0, 196011.0, 196081.0, 27365.0, 27703.0, 28027.579586305816, 28033.579496307164, 28067.859660701564, 33396.49905251375, 34429.655703442644, 35045.47431788576, 35208.295834083685, 35254.0, 29195.0, 29453.705462945098, 29506.409871802873, 29612.259693507836, 29867.253318667208, 29113.0, 29202.269943251587, 30155.175171973257, 30471.542926855673, 30472.542911856784, 29047.12858614245, 29071.0, 29097.27256818512, 29162.416751664423, 29736.0, 25946.0, 27119.45761084728, 27295.0, 27511.449771004067, 28083.578746319232, 21066.978579145798, 21310.147594096063, 21504.354869353945, 21514.0, 22376.88811555997], "value": 12367.33239336982, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.93820926860985, 416.5771741682193, 416.8291000689718, 436.9650427965762, 440.34828453888247, 14854.777178342307, 17075.914620426895, 17623.383181588648, 17776.55558611034, 18273.81726182738, 17522.561935951606, 17590.64818703625, 17639.470815875546, 17739.20173592188, 17762.111894405294, 3706.5366829146355, 3726.4782930389765, 3871.502880641984, 3917.902052448683, 3940.3104456720102, 3847.865324713636, 3895.844166233347, 3917.2557214129224, 3921.1961547882756, 3924.8822535323843, 3867.5552311484257, 3876.573576906538, 3878.030492376906, 3885.57258701544, 3895.7467764595353, 3737.7196710246703, 3798.734088613798, 3821.5032045833864, 3893.6885049196, 3897.649211570958, 3500.859965601373, 3518.5074089627474, 3520.5951315598522, 3536.752427330088, 3559.626239244894, 21484.140634374606, 21984.120635174575, 22026.669599956014, 22084.33746987593, 22238.221662241907, 1595.920203989796, 1613.9596510087224, 1619.3684463059417, 1664.0514906503297, 1664.2760399226254, 13571.864281357159, 13627.0, 13696.726065478635, 13867.4453021879, 14454.927725361411, 1715.8970461772333, 1725.1546742096407, 1732.575518997841, 1739.4520725971406, 1765.2321240260528, 76169.0, 76846.61576692137, 77628.22371776267, 77996.22003779946, 78589.60705196437, 10208.693739187836, 10424.322419042737, 10525.36847789135, 10654.414007229521, 10696.839547406795, 13147.934260328637, 15549.922250388676, 15559.533214003599, 15579.0, 15612.3755049799, 6364.6316042051185, 7178.641067946582, 7438.962805185939, 7514.248575142442, 7534.0582427196605, 6485.643289619022, 6560.409563139245, 6801.21785994607, 6806.115205023414, 6812.284710105467, 6576.76981305652, 6719.865602687919, 6751.932480675228, 6771.966140169267, 6816.897746533806, 2047.7235573197725, 2102.295730930125, 2106.6313395155785, 2117.163720330461, 2118.6927895455074, 855.6320782063773, 870.760540851271, 885.7201344057903, 888.0, 910.2308549275983, 15977.0, 16339.754903676454, 16344.427945021867, 16534.338626455046, 17171.484855454357, 870.8171284030298, 874.5364956573027, 880.3133555826465, 881.3698205782896, 893.071205945822, 8713.0, 9101.135392137736, 9234.399764015317, 9314.115159059878, 9434.669786557575, 398219.0, 403020.0, 417201.0, 419908.0, 426096.0, 61734.38265617376, 79876.0, 80437.0, 82748.17251827405, 86506.75412196374, 1050.7845891592358, 1068.834330678746, 1092.2736380307165, 1101.4492753623188, 1104.1608377632897, 15801.525954221392, 16203.75694364562, 16398.754018689968, 16455.9177204118, 16475.34098636041, 41715.16569668529, 41903.58096418997, 42058.78970605128, 42893.0, 42978.0, 50550.494495054576, 51862.0, 51997.0, 52577.0, 53012.73493632507, 7501.849963000818, 7637.198094200029, 7709.383249339927, 7800.648970796215, 8261.463004904663, 11870.643880683594, 12022.879771202526, 12154.878451215729, 12387.442565084413, 12455.688607784878, 10365.481725913825, 10507.684769456928, 10968.122550196125, 11127.276727012719, 11587.710307242387, 10468.68593942183, 10666.679999600025, 10678.466076695979, 10714.946425267824, 10857.40284284372, 9846.901530984598, 10402.0, 11283.774324513299, 11367.431628418712, 11682.532698691957, 7747.0, 8211.794705132419, 8533.061363249913, 8577.95711021441, 8787.077356877691, 9920.107190352903, 10269.332493387907, 10297.897021029694, 10567.78864422692, 10614.8407773885], "value": 8278.825832324319, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1251.749650069986, 1273.9171953823002, 1288.4974859804684, 1288.6391810293114, 1292.0374321130753, 9192.126747958942, 9570.995045520225, 9590.85613715794, 9706.272029597772, 9960.302778805486, 9684.37051591646, 9795.95102024489, 9800.215982721384, 9819.705408837728, 9846.458444785534, 2179.891005449725, 2223.110755697726, 2233.218373569246, 2235.0612742648045, 2243.270936945491, 2073.5749171419825, 2125.521757604542, 2127.223563399356, 2131.0836340373635, 2142.4858034071867, 2099.6325643012487, 2140.7752186020475, 2143.8177754890853, 2146.474113842103, 2163.935081947536, 2084.739407574053, 2086.426232785981, 2087.728595282611, 2089.571637814252, 2089.9895500522553, 1748.3356324596573, 1813.8548916086681, 2060.721802556666, 2065.060397519125, 2112.4718820294925, 9381.5309234538, 9628.71113866585, 9651.903480965171, 9689.806203875884, 9699.272554558436, 5105.591552675777, 5343.358796944352, 5345.33183352081, 5351.357837059578, 5359.758810853521, 3176.12656519459, 3201.935961280761, 3225.8064516129107, 3261.5596894419186, 3269.9182520436943, 1037.9584816607326, 1041.9479026048743, 1049.380865289483, 1064.2337516987757, 1071.8606581144402, 14167.149971001772, 14437.927810360987, 14501.057431266934, 14543.127412355187, 14545.636359091002, 4694.910684865809, 4836.540528649773, 4847.466778654345, 4925.310456536088, 4941.975290123526, 11866.525338986516, 11923.70190745221, 11985.820212696817, 12033.699157521132, 12079.033677305795, 5378.058839703036, 5476.644018138808, 5479.315085614298, 5509.944900550943, 5523.502884740393, 4693.647976401715, 4758.500357462417, 4837.443693975168, 4873.488283730228, 5025.14572522672, 3926.54844692864, 4003.5195776507007, 4053.3717273822604, 4077.7145599808323, 4104.589541045932, 1263.185245516655, 1264.4942023190797, 1278.4949944771763, 1282.9037822163375, 1289.4326496341766, 614.370270472769, 638.457311285413, 650.768977013163, 656.5535435903631, 657.2868437745004, 4872.342233798463, 4900.656954013256, 4918.508149185053, 5006.4492905780335, 5135.589152867761, 511.60861940614717, 513.0841448015275, 520.7110053920035, 521.9947800522023, 532.7682458130726, 2935.9559606605917, 2978.74680652147, 3095.1488340706037, 3818.0645741792882, 3916.4321173429694, 10539.947300263602, 11058.944705276423, 11903.642890713292, 12329.50681972729, 12464.875351246554, 11802.11484138693, 12113.454894529767, 12235.0, 12305.0, 12406.255624662368, 8687.782805429915, 8770.868436973451, 8895.555222238861, 8898.243649289754, 8904.287656987426, 5511.283533140666, 5654.15187721845, 5716.0, 5773.797917072882, 5917.6745279010065, 10656.8934310659, 11199.0, 11278.887211127783, 11402.714932126763, 11523.250988686044, 11046.392448415414, 11060.778784424105, 11126.276792008493, 11188.0, 11201.943990279997, 8013.078495972804, 8168.509889406655, 8173.427860049739, 8280.420370574002, 8282.4202305838, 9056.909430905607, 9057.637694492147, 9182.311326650395, 9199.172074513326, 9214.585343659686, 7662.923370766221, 7740.380769538311, 7750.612469376396, 7794.727184548514, 7867.409944254318, 7920.762377128695, 8025.317847982987, 8089.2315230053055, 8108.918910810817, 8135.30849877767, 6948.687309071205, 7005.684744186422, 7072.0, 7090.361867431956, 7100.0, 5080.212567052113, 5163.509466600667, 5207.791688332424, 5254.080535906125, 5266.07843627356, 5003.299538064746, 5107.6169287302855, 5171.612129090258, 5175.870603234798, 5293.153095504701], "value": 4534.620409900065, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.22463948904755, 382.8640832504461, 397.28885295321373, 408.9631933126018, 411.75089071111955, 5370.409254981949, 5444.646098003627, 5460.999999999995, 5515.972420137899, 5546.611737178399, 5274.498922602346, 5360.812371566996, 5377.677339359641, 5377.946220537793, 5396.325459317585, 4187.832486700544, 4198.0, 4203.579642035795, 4209.894752631178, 4212.389203565481, 3995.8201880915285, 4160.39674247234, 4207.347861081537, 4221.7255878367805, 4223.788810559475, 4144.357624568197, 4153.813078411479, 4159.126583417486, 4163.937540936889, 4170.645495132917, 4163.8959026024595, 4168.458100446953, 4175.8956026099595, 4178.310578754517, 4188.28799104153, 3671.4492826076303, 3695.0, 3710.5732840723394, 3719.0702324418894, 3722.8510859565586, 5099.36257967754, 5234.7120908350025, 5260.579153667697, 5275.103232450492, 5277.815276465343, 4805.1590971579835, 4807.879803004917, 4811.0, 4824.445188803297, 4829.1307564638355, 5487.5609951203805, 5633.126865335879, 5648.293963254593, 5665.575081868877, 5679.630823996427, 4026.094128821021, 4034.7780872052026, 4035.233305671913, 4039.7576145431367, 4047.2107938951917, 5696.800611978602, 5735.799247026376, 5837.211976383176, 5917.378675239081, 6007.36922623127, 4098.672106231495, 4100.774457404871, 4132.669386449077, 4138.937915931264, 4147.460830092069, 4192.266353388145, 4212.578742125763, 4215.936760948588, 4216.135692183095, 4218.557051509547, 4681.695689780221, 4745.369222069025, 4755.619550435957, 4800.207965685623, 4801.591864691541, 5700.458456446631, 5710.885782284414, 5717.0, 5721.799737009268, 5747.252857128547, 1434.9139051656934, 1457.3733294683389, 1458.3145921416917, 1459.1755658053166, 1464.4874293997016, 945.8267512495615, 972.7743043764907, 980.352967041749, 981.7594689301167, 1000.0749306891242, 4926.211806111077, 4933.975330123399, 4934.629902757308, 4940.1601727706375, 4941.950580494149, 5881.2942446906645, 5886.615196262166, 5894.528437724972, 5928.970355148283, 5933.851653708692, 4787.996543611934, 4902.4362198346935, 4943.505649435027, 4961.404631444249, 4966.15575352191, 3100.3489267253676, 3112.673169317234, 3123.7813353065067, 3130.248740302311, 3142.6385965614245, 5445.292112025411, 5454.91817622736, 5458.263134476795, 5462.317210348707, 5471.808486703026, 5737.971310143506, 6013.9699301503215, 6015.187949626745, 6025.9096113558335, 6051.213342265565, 5375.92481503693, 5433.809816656477, 5436.21174929633, 5458.754356053908, 5474.178873168898, 5666.858328541819, 5859.589828711949, 5879.147523608967, 5906.7341969612335, 5917.733701983335, 5772.913406298825, 5776.480116789509, 5810.140754958373, 5810.941890581209, 5819.730305181068, 5197.7141257231215, 5284.735763211901, 5335.279737235423, 5423.5932305076485, 5428.782848686008, 4089.3661482470266, 4123.9793801032, 4129.69027322958, 4130.524989626111, 4134.855280065183, 5514.420985796594, 5865.472107510344, 5872.794452194153, 5885.94114058871, 5899.705014749331, 5618.747156378055, 5696.572757043321, 5712.685802280748, 5713.285839270091, 5724.57065720081, 5655.604107712421, 5689.943100569107, 5739.62692424991, 5749.281339832521, 5751.712414379348, 5400.324959380077, 5622.156676498558, 5650.717464126859, 5660.54715622741, 5662.546996240373, 5774.82675519735, 5777.9133313001175, 5780.479756821906, 5798.507126894261, 5809.796657116981, 5503.0, 5619.662820230799, 5641.605087643826, 5652.590979036194, 5653.745581448927], "value": 4291.448036661699, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [684.8869936460484, 687.4019602945436, 704.5561296383278, 717.1394326807829, 734.922833102524, 11917.106217033725, 12052.638420847388, 12235.38823058848, 12370.443330050146, 13486.865131348684, 13135.540256091039, 13369.264690442022, 13384.93307533461, 13405.731885362311, 13409.664758381045, 638.2723694987718, 655.885220086483, 839.689314953468, 849.2399302624148, 852.4672079950032, 827.6523859978823, 853.9487630742144, 863.7840539865034, 866.8656358264479, 869.6651789061225, 908.604756930734, 909.1363204955319, 911.1890417528405, 911.5487833522383, 914.2183433164648, 899.8200359927976, 901.5492253873064, 908.2869947091567, 909.3679892474732, 910.1762904571374, 649.0945131541473, 655.1057806094694, 656.0651072222112, 661.5997321620398, 662.5329142954206, 13319.0, 13321.333933303393, 13369.0, 13384.397702103428, 13665.18008919468, 13287.667808304774, 13916.234607096605, 14090.365933533016, 14196.290185490685, 14243.643908902257, 10375.16998640107, 10390.84413733787, 10482.161427085892, 10527.578896844117, 10667.466626668713, 2613.529564678357, 2633.170551276361, 2654.9070782522713, 2693.6902256240587, 2709.607106969498, 58173.709131454496, 58793.41206587922, 58938.0, 59033.40966590322, 59682.40317596812, 9080.455172689659, 9129.863052054225, 9232.27683962549, 9246.583903724348, 9545.093216144454, 14446.133232006114, 14790.334434950453, 14860.851391486163, 15014.174220417983, 15018.849811501963, 6490.545661803723, 6509.837254068591, 6517.380848819449, 6538.215414150332, 6770.0, 3247.1719711473897, 3352.430086885235, 3363.4618461046116, 3439.7764145330975, 3446.0351101691567, 3486.4073107571776, 3516.701080408143, 3517.43721004638, 3531.964680353215, 3552.6980206682206, 658.58180055665, 658.8188248231775, 659.1233659233209, 666.3835951744617, 681.437813803614, 531.5322516185809, 557.3924422379625, 561.6040691312696, 563.1524555543962, 573.6386076771607, 9018.639254429749, 9234.261259099256, 9277.16505514507, 9294.953525232466, 9339.766505837408, 541.6777017674477, 542.9185622156708, 545.353755799379, 545.3837164004649, 550.5347980956086, 3827.8468861245797, 3885.184111336651, 3897.941530877039, 4001.199760048002, 4073.8745210727757, 59448.0, 61139.0, 61873.0, 63102.368976310565, 63532.68233658802, 39060.0, 44279.0, 52828.20757688638, 53033.575299458105, 53751.73124134433, 43974.0, 44891.775541122086, 44965.32552011722, 45642.77178614152, 46083.30875036877, 9027.32295077885, 9485.430874147572, 9589.875135993118, 9603.135717785433, 9611.711648650551, 23378.090036428297, 23381.181658641864, 23860.0, 23922.162724304566, 24552.263432097065, 29445.0, 29828.254293642833, 29844.10467685973, 29993.0, 30158.69841301559, 11636.301821890374, 11678.0, 11787.882121178678, 12040.337781422106, 12374.010079193464, 12153.392330383269, 12514.687132821753, 12518.186317889307, 12615.0, 12680.492780288685, 11612.361320127475, 11747.823782643096, 11748.0, 11798.41007949582, 12133.635990920286, 11565.537378505102, 12114.273143611412, 12170.269783812999, 12480.563180288646, 12532.310722910328, 11845.881541184823, 11992.700182495508, 11994.400279985792, 12040.819387709016, 12133.453994570089, 9344.579493922925, 9956.900430995887, 10320.845187322346, 10434.68695939123, 10512.106470950055, 9131.634734610541, 9139.58871850755, 9245.630174792934, 9935.105840474103, 9971.0], "value": 6133.383776204807, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1573.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 111.0, 114.0, 112.0, 112.0, 112.0, 111.0, 112.0, 112.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 126.0, 124.0, 184.0, 126.0, 126.0, 128.0, 127.0, 148.0, 126.0], "value": 137.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 166.0, 170.0, 169.0, 167.0, 165.0, 165.0, 163.0, 166.0], "value": 166.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 78.0, 124.0, 76.0, 76.0, 76.0, 77.0, 96.0, 79.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 122.0, 85.0, 86.0, 84.0, 98.0, 86.0, 85.0, 105.0], "value": 92.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 124.0, 119.0, 115.0, 114.0, 114.0, 114.0], "value": 115.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 151.0, 150.0, 151.0, 151.0, 150.0, 150.0, 151.0, 151.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 97.0, 99.0, 94.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 68.0, 75.0, 75.0, 70.0, 70.0, 70.0, 71.0, 71.0], "value": 70.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 55.0, 55.0, 56.0, 56.0, 56.0, 56.0, 55.0], "value": 55.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 83.0, 83.0, 83.0, 82.0, 85.0, 90.0, 82.0, 83.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 141.0, 139.0, 136.0, 135.0, 134.0, 138.0, 139.0, 185.0, 134.0], "value": 142.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 199.0, 196.0, 202.0, 206.0, 194.0, 200.0, 201.0, 200.0, 192.0], "value": 197.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 71.0, 73.0, 71.0, 74.0, 73.0, 73.0, 71.0, 71.0], "value": 72.3, "unit": "score"}]}]} 09:17:57 INFO - Return code: 0 09:17:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:17:57 ERROR - # TBPL SUCCESS # 09:17:57 INFO - Running post-action listener: _resource_record_post_action 09:17:57 INFO - [mozharness: 2017-03-21 16:17:57.600080Z] Finished run-tests step (success) 09:17:57 INFO - Running post-run listener: _resource_record_post_run 09:17:57 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 8192; Write bytes: 363773952; Read time: 44; Write time: 206376 09:17:57 INFO - TinderboxPrint: CPU usage
13.3% 09:17:57 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 44 09:17:57 INFO - TinderboxPrint: I/O write bytes / time
363,773,952 / 206,376 09:17:57 INFO - TinderboxPrint: CPU idle
8,321.8 (86.7%) 09:17:57 INFO - TinderboxPrint: CPU user
1,220.6 (12.7%) 09:17:57 INFO - TinderboxPrint: Swap in / out
0 / 0 09:17:57 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 105148416; Read time: 0; Write time: 64236 09:17:57 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 8192; Write bytes: 258625536; Read time: 44; Write time: 142140 09:17:58 INFO - Running post-run listener: _upload_blobber_files 09:17:58 INFO - Blob upload gear active. 09:17:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:17:58 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 09:17:58 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'] 09:17:58 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 09:17:58 INFO - (blobuploader) - INFO - Open directory for files ... 09:17:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:17:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:17:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:17:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:17:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:17:59 INFO - (blobuploader) - INFO - Done attempting. 09:17:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:17:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:17:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:18:00 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:18:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:18:00 INFO - (blobuploader) - INFO - Done attempting. 09:18:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:18:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:18:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:18:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:18:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:18:02 INFO - (blobuploader) - INFO - Done attempting. 09:18:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:18:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:18:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:18:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:18:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:18:05 INFO - (blobuploader) - INFO - Done attempting. 09:18:05 INFO - (blobuploader) - INFO - Iteration through files over. 09:18:05 INFO - Return code: 0 09:18:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:18:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:18:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/104b9be3df0a87e0e34212be04c2498f34810f57c6a75e7fb4582eb5d2352a2d1544491abca22cffa5cbfd76e81dfecabb3662dcf7edfb4e045ffd080b747a84", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2036d84ccc724040fbafd0622ed7786e25bd145d77e371af8da510073f2eee0dc10ee956532f570d289d0b5d4dca990b69935c22a3d0b9d8a1a764b8a61e44f0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/612c220eb26e7bb8adb4e6f831057b9025974146905dd6be1775963d94a87eeab573d05211cd7d0d912060bd34e9d50ee83f4589cb1654cf8abef0aef328d9d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d643518c0d364bc9ba881c38c6aaebb55452f01649fbc7acbf0fb648d2fb9df3a6f322104162f8b00df632ab6126f9703fe4013232fe16af41393603a7820a3"} 09:18:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:18:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:18:05 INFO - Contents: 09:18:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/104b9be3df0a87e0e34212be04c2498f34810f57c6a75e7fb4582eb5d2352a2d1544491abca22cffa5cbfd76e81dfecabb3662dcf7edfb4e045ffd080b747a84", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2036d84ccc724040fbafd0622ed7786e25bd145d77e371af8da510073f2eee0dc10ee956532f570d289d0b5d4dca990b69935c22a3d0b9d8a1a764b8a61e44f0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/612c220eb26e7bb8adb4e6f831057b9025974146905dd6be1775963d94a87eeab573d05211cd7d0d912060bd34e9d50ee83f4589cb1654cf8abef0aef328d9d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d643518c0d364bc9ba881c38c6aaebb55452f01649fbc7acbf0fb648d2fb9df3a6f322104162f8b00df632ab6126f9703fe4013232fe16af41393603a7820a3"} 09:18:05 INFO - Running post-run listener: copy_logs_to_upload_dir 09:18:05 INFO - Copying logs to upload dir... 09:18:05 INFO - mkdir: /builds/slave/test/build/upload/logs 09:18:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.521141 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-03-21 09:18:05.554045) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 09:18:05.557406) ========= 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=c6927cf182745ad25b1d38b9000001fe-1490111820.436670-1291451011 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/104b9be3df0a87e0e34212be04c2498f34810f57c6a75e7fb4582eb5d2352a2d1544491abca22cffa5cbfd76e81dfecabb3662dcf7edfb4e045ffd080b747a84", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2036d84ccc724040fbafd0622ed7786e25bd145d77e371af8da510073f2eee0dc10ee956532f570d289d0b5d4dca990b69935c22a3d0b9d8a1a764b8a61e44f0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/612c220eb26e7bb8adb4e6f831057b9025974146905dd6be1775963d94a87eeab573d05211cd7d0d912060bd34e9d50ee83f4589cb1654cf8abef0aef328d9d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d643518c0d364bc9ba881c38c6aaebb55452f01649fbc7acbf0fb648d2fb9df3a6f322104162f8b00df632ab6126f9703fe4013232fe16af41393603a7820a3"} build_url:https://queue.taskcluster.net/v1/task/T-7Yh0DbT_Supooniosh_w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011407 build_url: 'https://queue.taskcluster.net/v1/task/T-7Yh0DbT_Supooniosh_w/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/104b9be3df0a87e0e34212be04c2498f34810f57c6a75e7fb4582eb5d2352a2d1544491abca22cffa5cbfd76e81dfecabb3662dcf7edfb4e045ffd080b747a84", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2036d84ccc724040fbafd0622ed7786e25bd145d77e371af8da510073f2eee0dc10ee956532f570d289d0b5d4dca990b69935c22a3d0b9d8a1a764b8a61e44f0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/612c220eb26e7bb8adb4e6f831057b9025974146905dd6be1775963d94a87eeab573d05211cd7d0d912060bd34e9d50ee83f4589cb1654cf8abef0aef328d9d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d643518c0d364bc9ba881c38c6aaebb55452f01649fbc7acbf0fb648d2fb9df3a6f322104162f8b00df632ab6126f9703fe4013232fe16af41393603a7820a3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 09:18:05.582118) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 09:18:05.582423) ========= 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=c6927cf182745ad25b1d38b9000001fe-1490111820.436670-1291451011 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004499 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 09:18:05.666765) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 09:18:05.667115) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 09:18:05.667422) ========= ========= Total master_lag: 0.18 =========