builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-064 starttime: 1486258862.54 results: success (0) revision: 3e555770a90a41e04bbb4ac41b65fa2f1db6977d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-04 17:41:02.538119) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-04 17:41:02.538559) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-04 17:41:02.538846) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-04 17:41:02.558855) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-04 17:41:02.559214) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1486257084.675137-1044810650 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-04 17:41:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.5M=0s 2017-02-04 17:41:05 (69.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.215067 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-04 17:41:02.788016) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-04 17:41:02.788335) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1486257084.675137-1044810650 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022254 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-04 17:41:02.838013) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-04 17:41:02.838351) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3e555770a90a41e04bbb4ac41b65fa2f1db6977d --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 3e555770a90a41e04bbb4ac41b65fa2f1db6977d --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=a12cd81e0ef515edd9e0d800000001bb-1486257084.675137-1044810650 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-04 17:41:05,665 truncating revision to first 12 chars 2017-02-04 17:41:05,665 Setting DEBUG logging. 2017-02-04 17:41:05,665 attempt 1/10 2017-02-04 17:41:05,665 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3e555770a90a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-04 17:41:06,136 unpacking tar archive at: mozilla-central-3e555770a90a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.781470 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-04 17:41:03.632915) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-04 17:41:03.633250) ========= script_repo_revision: 3e555770a90a41e04bbb4ac41b65fa2f1db6977d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-04 17:41:03.633619) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-04 17:41:03.633882) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-04 17:41:03.642201) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-02-04 17:41:03.642479) ========= /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=a12cd81e0ef515edd9e0d800000001bb-1486257084.675137-1044810650 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:41:06 INFO - MultiFileLogger online at 20170204 17:41:06 in /builds/slave/test 17:41:06 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 17:41:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:41:06 INFO - {'append_to_log': False, 17:41:06 INFO - 'base_work_dir': '/builds/slave/test', 17:41:06 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:41:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:41:06 INFO - 'branch': 'Firefox-Non-PGO', 17:41:06 INFO - 'buildbot_json_path': 'buildprops.json', 17:41:06 INFO - 'config_files': ('talos/linux_config.py',), 17:41:06 INFO - 'default_actions': ('clobber', 17:41:06 INFO - 'read-buildbot-config', 17:41:06 INFO - 'download-and-extract', 17:41:06 INFO - 'populate-webroot', 17:41:06 INFO - 'create-virtualenv', 17:41:06 INFO - 'install', 17:41:06 INFO - 'run-tests'), 17:41:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:41:06 INFO - 'download_minidump_stackwalk': True, 17:41:06 INFO - 'download_symbols': 'ondemand', 17:41:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:41:06 INFO - 'tooltool.py': '/tools/tooltool.py', 17:41:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:41:06 INFO - '/tools/misc-python/virtualenv.py')}, 17:41:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:41:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:41:06 INFO - 'installer_path': 'installer.exe', 17:41:06 INFO - 'log_level': 'info', 17:41:06 INFO - 'log_name': 'talos', 17:41:06 INFO - 'log_to_console': True, 17:41:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:41:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:41:06 INFO - 'opt_config_files': (), 17:41:06 INFO - 'pip_index': False, 17:41:06 INFO - 'sps_profile': False, 17:41:06 INFO - 'sps_profile_interval': 0, 17:41:06 INFO - 'suite': 'dromaeojs-e10s', 17:41:06 INFO - 'system_bits': '32', 17:41:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:41:06 INFO - 'title': 'talos-linux64-ix-064', 17:41:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:41:06 INFO - 'use_talos_json': True, 17:41:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:41:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:41:06 INFO - 'work_dir': 'build'} 17:41:06 INFO - [mozharness: 2017-02-05 01:41:06.560750Z] Running clobber step. 17:41:06 INFO - Running pre-action listener: _resource_record_pre_action 17:41:06 INFO - Running main action method: clobber 17:41:06 INFO - rmtree: /builds/slave/test/build 17:41:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:41:07 INFO - Running post-action listener: _resource_record_post_action 17:41:07 INFO - [mozharness: 2017-02-05 01:41:07.021390Z] Finished clobber step (success) 17:41:07 INFO - [mozharness: 2017-02-05 01:41:07.021491Z] Running read-buildbot-config step. 17:41:07 INFO - Running pre-action listener: _resource_record_pre_action 17:41:07 INFO - Running main action method: read_buildbot_config 17:41:07 INFO - Using buildbot properties: 17:41:07 INFO - { 17:41:07 INFO - "project": "", 17:41:07 INFO - "product": "firefox", 17:41:07 INFO - "who": "philringnalda@gmail.com", 17:41:07 INFO - "installer_path": "public/build/target.tar.bz2", 17:41:07 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 17:41:07 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 17:41:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 17:41:07 INFO - "stage_platform": "linux64", 17:41:07 INFO - "basedir": "/builds/slave/test", 17:41:07 INFO - "buildnumber": 400, 17:41:07 INFO - "platform": "ubuntu64_hw", 17:41:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:41:07 INFO - "slavebuilddir": "test", 17:41:07 INFO - "taskId": "cyVhTo8YQL-wr3Q5Tcv3Vg", 17:41:07 INFO - "branch": "mozilla-central", 17:41:07 INFO - "script_repo_revision": "production", 17:41:07 INFO - "revision": "3e555770a90a41e04bbb4ac41b65fa2f1db6977d", 17:41:07 INFO - "slavename": "talos-linux64-ix-064", 17:41:07 INFO - "repo_path": "mozilla-central" 17:41:07 INFO - } 17:41:07 INFO - Finding installer, test and symbols from parent task. 17:41:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cyVhTo8YQL-wr3Q5Tcv3Vg'}, attempt #1 17:41:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cyVhTo8YQL-wr3Q5Tcv3Vg'}, attempt #1 17:41:07 INFO - Task dependencies: dA3DHMjvS6OSbEEzgaOT1A 17:41:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dA3DHMjvS6OSbEEzgaOT1A'}, attempt #1 17:41:08 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/dA3DHMjvS6OSbEEzgaOT1A/artifacts/public/build/target.tar.bz2 17:41:08 INFO - Set test_url: https://queue.taskcluster.net/v1/task/dA3DHMjvS6OSbEEzgaOT1A/artifacts/public/build/test_packages.json 17:41:08 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/dA3DHMjvS6OSbEEzgaOT1A/artifacts/public/build/target.crashreporter-symbols.zip 17:41:08 INFO - Running post-action listener: _resource_record_post_action 17:41:08 INFO - [mozharness: 2017-02-05 01:41:08.388554Z] Finished read-buildbot-config step (success) 17:41:08 INFO - [mozharness: 2017-02-05 01:41:08.388772Z] Running download-and-extract step. 17:41:08 INFO - Running pre-action listener: _resource_record_pre_action 17:41:08 INFO - Running main action method: download_and_extract 17:41:08 INFO - mkdir: /builds/slave/test/build/tests 17:41:08 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')]} 17:41:08 INFO - trying https://queue.taskcluster.net/v1/task/dA3DHMjvS6OSbEEzgaOT1A/artifacts/public/build/target.test_packages.json 17:41:08 INFO - Downloading https://queue.taskcluster.net/v1/task/dA3DHMjvS6OSbEEzgaOT1A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:41:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dA3DHMjvS6OSbEEzgaOT1A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:41:08 INFO - Downloaded 896 bytes. 17:41:08 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:41:08 INFO - Using the following test package requirements: 17:41:08 INFO - {u'common': [u'target.common.tests.zip'], 17:41:08 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:41:08 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:41:08 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:41:08 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:41:08 INFO - u'mozbase': [u'target.common.tests.zip'], 17:41:08 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:41:08 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:41:08 INFO - u'web-platform': [u'target.common.tests.zip', 17:41:08 INFO - u'target.web-platform.tests.zip'], 17:41:08 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:41:08 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:41:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dA3DHMjvS6OSbEEzgaOT1A/artifacts/public/build/target.common.tests.zip 17:41:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dA3DHMjvS6OSbEEzgaOT1A/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:41:08 INFO - Fetch https://queue.taskcluster.net/v1/task/dA3DHMjvS6OSbEEzgaOT1A/artifacts/public/build/target.common.tests.zip into memory 17:41:09 INFO - Expected file size: 39902328 17:41:09 INFO - Obtained file size: 39902328 17:41:14 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:41:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dA3DHMjvS6OSbEEzgaOT1A/artifacts/public/build/target.common.tests.zip 17:41:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dA3DHMjvS6OSbEEzgaOT1A/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:41:14 INFO - Fetch https://queue.taskcluster.net/v1/task/dA3DHMjvS6OSbEEzgaOT1A/artifacts/public/build/target.common.tests.zip into memory 17:41:15 INFO - Expected file size: 39902328 17:41:15 INFO - Obtained file size: 39902328 17:41:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dA3DHMjvS6OSbEEzgaOT1A/artifacts/public/build/target.talos.tests.zip 17:41:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dA3DHMjvS6OSbEEzgaOT1A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:41:19 INFO - Fetch https://queue.taskcluster.net/v1/task/dA3DHMjvS6OSbEEzgaOT1A/artifacts/public/build/target.talos.tests.zip into memory 17:41:20 INFO - Expected file size: 14403454 17:41:20 INFO - Obtained file size: 14403454 17:41:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:20 INFO - trying https://queue.taskcluster.net/v1/task/dA3DHMjvS6OSbEEzgaOT1A/artifacts/public/build/target.tar.bz2 17:41:20 INFO - Downloading https://queue.taskcluster.net/v1/task/dA3DHMjvS6OSbEEzgaOT1A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:41:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dA3DHMjvS6OSbEEzgaOT1A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:41:21 INFO - Downloaded 56221786 bytes. 17:41:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dA3DHMjvS6OSbEEzgaOT1A/artifacts/public/build/target.tar.bz2 17:41:21 INFO - mkdir: /builds/slave/test/properties 17:41:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:41:21 INFO - Writing to file /builds/slave/test/properties/build_url 17:41:21 INFO - Contents: 17:41:21 INFO - build_url:https://queue.taskcluster.net/v1/task/dA3DHMjvS6OSbEEzgaOT1A/artifacts/public/build/target.tar.bz2 17:41:21 INFO - Running post-action listener: _resource_record_post_action 17:41:21 INFO - Running post-action listener: set_extra_try_arguments 17:41:21 INFO - [mozharness: 2017-02-05 01:41:21.943896Z] Finished download-and-extract step (success) 17:41:21 INFO - [mozharness: 2017-02-05 01:41:21.943993Z] Running populate-webroot step. 17:41:21 INFO - Running pre-action listener: _resource_record_pre_action 17:41:21 INFO - Running main action method: populate_webroot 17:41:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:41:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:41:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:41:21 INFO - '--tppagecycles', 17:41:21 INFO - '7'], 17:41:21 INFO - 'tests': ['tsvgm']}}, 17:41:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:41:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:41:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:41:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:41:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:41:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:41:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:41:21 INFO - 'talos_options': ['--disable-e10s'], 17:41:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:41:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:41:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:41:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:41:21 INFO - 'talos_options': ['--disable-e10s'], 17:41:21 INFO - 'tests': ['damp', 'tps']}, 17:41:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:41:21 INFO - 'tests': ['damp', 'tps']}, 17:41:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:41:21 INFO - 'tests': ['dromaeo_dom']}, 17:41:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:41:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:41:21 INFO - 'tests': ['basic_compositor_video']}, 17:41:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:41:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:41:21 INFO - 'tests': ['a11yr', 17:41:21 INFO - 'ts_paint', 17:41:21 INFO - 'tpaint', 17:41:21 INFO - 'sessionrestore', 17:41:21 INFO - 'sessionrestore_no_auto_restore', 17:41:21 INFO - 'tabpaint']}, 17:41:21 INFO - 'other-e10s': {'tests': ['a11yr', 17:41:21 INFO - 'ts_paint', 17:41:21 INFO - 'tpaint', 17:41:21 INFO - 'sessionrestore', 17:41:21 INFO - 'sessionrestore_no_auto_restore', 17:41:21 INFO - 'tabpaint']}, 17:41:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:41:21 INFO - 'ts_paint', 17:41:21 INFO - 'tpaint', 17:41:21 INFO - 'sessionrestore', 17:41:21 INFO - 'sessionrestore_no_auto_restore', 17:41:21 INFO - 'tabpaint']}, 17:41:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:41:21 INFO - 'ts_paint', 17:41:21 INFO - 'tpaint', 17:41:21 INFO - 'sessionrestore', 17:41:21 INFO - 'sessionrestore_no_auto_restore', 17:41:21 INFO - 'tabpaint']}, 17:41:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:41:21 INFO - 'tests': ['a11yr', 17:41:21 INFO - 'ts_paint', 17:41:21 INFO - 'tpaint', 17:41:21 INFO - 'sessionrestore', 17:41:21 INFO - 'sessionrestore_no_auto_restore', 17:41:21 INFO - 'tabpaint']}, 17:41:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:41:21 INFO - 'tests': ['a11yr', 17:41:21 INFO - 'ts_paint', 17:41:21 INFO - 'tpaint', 17:41:21 INFO - 'sessionrestore', 17:41:21 INFO - 'sessionrestore_no_auto_restore', 17:41:21 INFO - 'tabpaint']}, 17:41:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:41:21 INFO - 'tests': ['tsvgx', 17:41:21 INFO - 'tsvgr_opacity', 17:41:21 INFO - 'tart', 17:41:21 INFO - 'tscrollx', 17:41:21 INFO - 'cart', 17:41:21 INFO - 'tsvg_static']}, 17:41:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:41:21 INFO - 'tsvgr_opacity', 17:41:21 INFO - 'tart', 17:41:21 INFO - 'tscrollx', 17:41:21 INFO - 'cart', 17:41:21 INFO - 'tsvg_static']}, 17:41:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:41:21 INFO - 'talos_options': ['--disable-e10s'], 17:41:21 INFO - 'tests': ['tp5o']}, 17:41:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:41:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:41:21 INFO - 'talos_options': ['--disable-e10s', 17:41:21 INFO - '--xperf_path', 17:41:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:41:21 INFO - 'tests': ['tp5n']}, 17:41:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:41:21 INFO - 'talos_options': ['--xperf_path', 17:41:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:41:21 INFO - 'tests': ['tp5n']}}, 17:41:21 INFO - 'talos.zip': {'path': '', 17:41:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:41:21 INFO - Running post-action listener: _resource_record_post_action 17:41:21 INFO - [mozharness: 2017-02-05 01:41:21.957156Z] Finished populate-webroot step (success) 17:41:21 INFO - [mozharness: 2017-02-05 01:41:21.957247Z] Running create-virtualenv step. 17:41:21 INFO - Running pre-action listener: _resource_record_pre_action 17:41:21 INFO - Running main action method: create_virtualenv 17:41:21 INFO - Creating virtualenv /builds/slave/test/build/venv 17:41:21 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 17:41:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:41:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:41:22 INFO - Using real prefix '/usr' 17:41:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:41:22 INFO - Installing distribute.............................................................................................................................................................................................done. 17:41:24 INFO - Installing pip.................done. 17:41:24 INFO - Return code: 0 17:41:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:41:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:41:24 INFO - Reading from file tmpfile_stdout 17:41:24 INFO - Output received: 17:41:24 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) 17:41:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:41:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:24 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 0x14ff1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1610a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1871480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186e820>, '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 0x186f520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186f9b0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1486257084.675137-1044810650', '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 17:41:24 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 17:41:24 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 17:41:24 INFO - Using env: {'DISPLAY': ':0', 17:41:24 INFO - 'HOME': '/home/cltbld', 17:41:24 INFO - 'LANG': 'en_US.UTF-8', 17:41:24 INFO - 'LANGUAGE': 'en_US:en', 17:41:24 INFO - 'LOGNAME': 'cltbld', 17:41:24 INFO - 'MAIL': '/var/mail/cltbld', 17:41:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:24 INFO - 'MOZ_NO_REMOTE': '1', 17:41:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:24 INFO - 'NO_EM_RESTART': '1', 17:41:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:24 INFO - 'PWD': '/builds/slave/test', 17:41:24 INFO - 'SHELL': '/bin/bash', 17:41:24 INFO - 'SHLVL': '1', 17:41:24 INFO - 'TERM': 'linux', 17:41:24 INFO - 'TMOUT': '86400', 17:41:24 INFO - 'USER': 'cltbld', 17:41:24 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1486257084.675137-1044810650', 17:41:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:24 INFO - '_': '/tools/buildbot/bin/python'} 17:41:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:24 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 17:41:24 INFO - Cleaning up... 17:41:24 INFO - Return code: 0 17:41:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:41:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:24 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 0x14ff1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1610a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1871480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186e820>, '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 0x186f520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186f9b0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1486257084.675137-1044810650', '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 17:41:24 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 17:41:24 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 17:41:24 INFO - Using env: {'DISPLAY': ':0', 17:41:24 INFO - 'HOME': '/home/cltbld', 17:41:24 INFO - 'LANG': 'en_US.UTF-8', 17:41:24 INFO - 'LANGUAGE': 'en_US:en', 17:41:24 INFO - 'LOGNAME': 'cltbld', 17:41:24 INFO - 'MAIL': '/var/mail/cltbld', 17:41:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:24 INFO - 'MOZ_NO_REMOTE': '1', 17:41:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:24 INFO - 'NO_EM_RESTART': '1', 17:41:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:24 INFO - 'PWD': '/builds/slave/test', 17:41:24 INFO - 'SHELL': '/bin/bash', 17:41:24 INFO - 'SHLVL': '1', 17:41:24 INFO - 'TERM': 'linux', 17:41:24 INFO - 'TMOUT': '86400', 17:41:24 INFO - 'USER': 'cltbld', 17:41:24 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1486257084.675137-1044810650', 17:41:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:24 INFO - '_': '/tools/buildbot/bin/python'} 17:41:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:25 INFO - Downloading/unpacking psutil>=3.1.1 17:41:25 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 17:41:25 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 17:41:25 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 17:41:25 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 17:41:25 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 17:41:25 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 17:41:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:41:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:41:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:41:27 INFO - Installing collected packages: psutil 17:41:27 INFO - Running setup.py install for psutil 17:41:27 INFO - building 'psutil._psutil_linux' extension 17:41:27 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 17:41:27 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 17:41:27 INFO - building 'psutil._psutil_posix' extension 17:41:27 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 17:41:27 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 17:41:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:41:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:41:27 INFO - Successfully installed psutil 17:41:27 INFO - Cleaning up... 17:41:27 INFO - Return code: 0 17:41:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:41:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:27 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 0x14ff1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1610a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1871480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186e820>, '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 0x186f520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186f9b0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1486257084.675137-1044810650', '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 17:41:27 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 17:41:27 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 17:41:27 INFO - Using env: {'DISPLAY': ':0', 17:41:27 INFO - 'HOME': '/home/cltbld', 17:41:27 INFO - 'LANG': 'en_US.UTF-8', 17:41:27 INFO - 'LANGUAGE': 'en_US:en', 17:41:27 INFO - 'LOGNAME': 'cltbld', 17:41:27 INFO - 'MAIL': '/var/mail/cltbld', 17:41:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:27 INFO - 'MOZ_NO_REMOTE': '1', 17:41:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:27 INFO - 'NO_EM_RESTART': '1', 17:41:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:27 INFO - 'PWD': '/builds/slave/test', 17:41:27 INFO - 'SHELL': '/bin/bash', 17:41:27 INFO - 'SHLVL': '1', 17:41:27 INFO - 'TERM': 'linux', 17:41:27 INFO - 'TMOUT': '86400', 17:41:27 INFO - 'USER': 'cltbld', 17:41:27 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1486257084.675137-1044810650', 17:41:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:27 INFO - '_': '/tools/buildbot/bin/python'} 17:41:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:41:28 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 17:41:28 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 17:41:28 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 17:41:28 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 17:41:28 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 17:41:28 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 17:41:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:41:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:41:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:41:30 INFO - Installing collected packages: mozsystemmonitor 17:41:30 INFO - Running setup.py install for mozsystemmonitor 17:41:30 INFO - Successfully installed mozsystemmonitor 17:41:30 INFO - Cleaning up... 17:41:30 INFO - Return code: 0 17:41:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:41:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:41:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:30 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 0x14ff1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1610a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1871480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186e820>, '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 0x186f520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186f9b0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1486257084.675137-1044810650', '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 17:41:30 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 17:41:30 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 17:41:30 INFO - Using env: {'DISPLAY': ':0', 17:41:30 INFO - 'HOME': '/home/cltbld', 17:41:30 INFO - 'LANG': 'en_US.UTF-8', 17:41:30 INFO - 'LANGUAGE': 'en_US:en', 17:41:30 INFO - 'LOGNAME': 'cltbld', 17:41:30 INFO - 'MAIL': '/var/mail/cltbld', 17:41:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:30 INFO - 'MOZ_NO_REMOTE': '1', 17:41:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:30 INFO - 'NO_EM_RESTART': '1', 17:41:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:30 INFO - 'PWD': '/builds/slave/test', 17:41:30 INFO - 'SHELL': '/bin/bash', 17:41:30 INFO - 'SHLVL': '1', 17:41:30 INFO - 'TERM': 'linux', 17:41:30 INFO - 'TMOUT': '86400', 17:41:30 INFO - 'USER': 'cltbld', 17:41:30 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1486257084.675137-1044810650', 17:41:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:30 INFO - '_': '/tools/buildbot/bin/python'} 17:41:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:30 INFO - Downloading/unpacking jsonschema==2.5.1 17:41:30 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 17:41:30 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 17:41:30 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 17:41:30 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 17:41:30 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 17:41:30 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 17:41:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:41:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:41:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:41:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:41:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:41:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:41:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:41:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:41:32 INFO - Downloading functools32-3.2.3-2.tar.gz 17:41:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:41:32 INFO - warning: no files found matching '*.txt' 17:41:32 INFO - no previously-included directories found matching 'build' 17:41:32 INFO - no previously-included directories found matching 'dist' 17:41:32 INFO - no previously-included directories found matching '.git*' 17:41:32 INFO - Installing collected packages: jsonschema, functools32 17:41:32 INFO - Running setup.py install for functools32 17:41:32 INFO - warning: no files found matching '*.txt' 17:41:32 INFO - no previously-included directories found matching 'build' 17:41:32 INFO - no previously-included directories found matching 'dist' 17:41:32 INFO - no previously-included directories found matching '.git*' 17:41:32 INFO - Successfully installed jsonschema functools32 17:41:32 INFO - Cleaning up... 17:41:33 INFO - Return code: 0 17:41:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:41: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')]} 17:41:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41: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')]} 17:41:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41: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', '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 0x14ff1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1610a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1871480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186e820>, '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 0x186f520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186f9b0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1486257084.675137-1044810650', '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 17:41: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:41: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 functools32==3.2.3-2 17:41:33 INFO - Using env: {'DISPLAY': ':0', 17:41:33 INFO - 'HOME': '/home/cltbld', 17:41:33 INFO - 'LANG': 'en_US.UTF-8', 17:41:33 INFO - 'LANGUAGE': 'en_US:en', 17:41:33 INFO - 'LOGNAME': 'cltbld', 17:41:33 INFO - 'MAIL': '/var/mail/cltbld', 17:41:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:33 INFO - 'MOZ_NO_REMOTE': '1', 17:41:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:33 INFO - 'NO_EM_RESTART': '1', 17:41:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:33 INFO - 'PWD': '/builds/slave/test', 17:41:33 INFO - 'SHELL': '/bin/bash', 17:41:33 INFO - 'SHLVL': '1', 17:41:33 INFO - 'TERM': 'linux', 17:41:33 INFO - 'TMOUT': '86400', 17:41:33 INFO - 'USER': 'cltbld', 17:41:33 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1486257084.675137-1044810650', 17:41:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:33 INFO - '_': '/tools/buildbot/bin/python'} 17:41:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:41:33 INFO - Cleaning up... 17:41:33 INFO - Return code: 0 17:41:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:41: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')]} 17:41:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41: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')]} 17:41:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41: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', '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 0x14ff1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1610a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1871480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186e820>, '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 0x186f520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186f9b0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1486257084.675137-1044810650', '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 17:41: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:41: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 blobuploader==1.2.4 17:41:33 INFO - Using env: {'DISPLAY': ':0', 17:41:33 INFO - 'HOME': '/home/cltbld', 17:41:33 INFO - 'LANG': 'en_US.UTF-8', 17:41:33 INFO - 'LANGUAGE': 'en_US:en', 17:41:33 INFO - 'LOGNAME': 'cltbld', 17:41:33 INFO - 'MAIL': '/var/mail/cltbld', 17:41:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:33 INFO - 'MOZ_NO_REMOTE': '1', 17:41:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:33 INFO - 'NO_EM_RESTART': '1', 17:41:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:33 INFO - 'PWD': '/builds/slave/test', 17:41:33 INFO - 'SHELL': '/bin/bash', 17:41:33 INFO - 'SHLVL': '1', 17:41:33 INFO - 'TERM': 'linux', 17:41:33 INFO - 'TMOUT': '86400', 17:41:33 INFO - 'USER': 'cltbld', 17:41:33 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1486257084.675137-1044810650', 17:41:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:33 INFO - '_': '/tools/buildbot/bin/python'} 17:41:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:33 INFO - Downloading/unpacking blobuploader==1.2.4 17:41:33 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 17:41:33 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 17:41:33 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 17:41:33 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 17:41:33 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 17:41:33 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 17:41:35 INFO - Downloading blobuploader-1.2.4.tar.gz 17:41:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:41:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:41:35 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 17:41:35 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 17:41:35 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 17:41:35 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 17:41:35 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 17:41:35 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 17:41:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:41:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:41:35 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 17:41:35 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 17:41:35 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 17:41:35 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 17:41:35 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 17:41:35 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 17:41:36 INFO - Downloading docopt-0.6.1.tar.gz 17:41:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:41:36 INFO - Installing collected packages: blobuploader, requests, docopt 17:41:36 INFO - Running setup.py install for blobuploader 17:41:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:41:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:41:36 INFO - Running setup.py install for requests 17:41:36 INFO - Running setup.py install for docopt 17:41:36 INFO - Successfully installed blobuploader requests docopt 17:41:36 INFO - Cleaning up... 17:41:36 INFO - Return code: 0 17:41:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:41: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')]} 17:41:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41: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')]} 17:41:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:36 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 0x14ff1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1610a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1871480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186e820>, '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 0x186f520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186f9b0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1486257084.675137-1044810650', '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 17:41:36 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 17:41:36 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 17:41:36 INFO - Using env: {'DISPLAY': ':0', 17:41:36 INFO - 'HOME': '/home/cltbld', 17:41:36 INFO - 'LANG': 'en_US.UTF-8', 17:41:36 INFO - 'LANGUAGE': 'en_US:en', 17:41:36 INFO - 'LOGNAME': 'cltbld', 17:41:36 INFO - 'MAIL': '/var/mail/cltbld', 17:41:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:36 INFO - 'MOZ_NO_REMOTE': '1', 17:41:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:36 INFO - 'NO_EM_RESTART': '1', 17:41:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:36 INFO - 'PWD': '/builds/slave/test', 17:41:36 INFO - 'SHELL': '/bin/bash', 17:41:36 INFO - 'SHLVL': '1', 17:41:36 INFO - 'TERM': 'linux', 17:41:36 INFO - 'TMOUT': '86400', 17:41:36 INFO - 'USER': 'cltbld', 17:41:36 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1486257084.675137-1044810650', 17:41:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:36 INFO - '_': '/tools/buildbot/bin/python'} 17:41:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:41:37 INFO - Running setup.py (path:/tmp/pip-5r5cnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:41:37 INFO - Running setup.py (path:/tmp/pip-hkfDnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:41:37 INFO - Running setup.py (path:/tmp/pip-HVc_Sr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:41:37 INFO - Running setup.py (path:/tmp/pip-VXTP8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:41:37 INFO - Running setup.py (path:/tmp/pip-lvsmgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:41:37 INFO - Running setup.py (path:/tmp/pip-KTaBjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:41:37 INFO - Running setup.py (path:/tmp/pip-ei7S30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:41:37 INFO - Running setup.py (path:/tmp/pip-X3B2SB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:41:37 INFO - Running setup.py (path:/tmp/pip-eNk2XK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:41:37 INFO - Running setup.py (path:/tmp/pip-WIPPzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:41:37 INFO - Running setup.py (path:/tmp/pip-ipCJxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:41:37 INFO - Running setup.py (path:/tmp/pip-yPFZ85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:41:37 INFO - Running setup.py (path:/tmp/pip-0Mkt_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:41:38 INFO - Running setup.py (path:/tmp/pip-NERkhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:41:38 INFO - Running setup.py (path:/tmp/pip-7AzvZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:41:38 INFO - Running setup.py (path:/tmp/pip-cyHomV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:41:38 INFO - Running setup.py (path:/tmp/pip-9sqmoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:41:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:41:38 INFO - Running setup.py install for manifestparser 17:41:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:41:38 INFO - Running setup.py install for mozcrash 17:41:38 INFO - Running setup.py install for mozdebug 17:41:38 INFO - Running setup.py install for mozdevice 17:41:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:41:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:41:38 INFO - Running setup.py install for mozfile 17:41:38 INFO - Running setup.py install for mozhttpd 17:41:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:41:38 INFO - Running setup.py install for mozinfo 17:41:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:41:39 INFO - Running setup.py install for mozInstall 17:41:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:41:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:41:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:41:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:41:39 INFO - Running setup.py install for mozleak 17:41:39 INFO - Running setup.py install for mozlog 17:41:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:41:39 INFO - Running setup.py install for moznetwork 17:41:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:41:39 INFO - Running setup.py install for mozprocess 17:41:39 INFO - Running setup.py install for mozprofile 17:41:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:41:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:41:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:41:39 INFO - Running setup.py install for mozrunner 17:41:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:41:39 INFO - Running setup.py install for mozscreenshot 17:41:39 INFO - Running setup.py install for moztest 17:41:40 INFO - Running setup.py install for mozversion 17:41:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:41:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:41:40 INFO - Cleaning up... 17:41:40 INFO - Return code: 0 17:41:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:41:40 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')]} 17:41:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:40 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')]} 17:41:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:40 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 0x14ff1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1610a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1871480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186e820>, '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 0x186f520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186f9b0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1486257084.675137-1044810650', '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 17:41:40 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 17:41:40 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 17:41:40 INFO - Using env: {'DISPLAY': ':0', 17:41:40 INFO - 'HOME': '/home/cltbld', 17:41:40 INFO - 'LANG': 'en_US.UTF-8', 17:41:40 INFO - 'LANGUAGE': 'en_US:en', 17:41:40 INFO - 'LOGNAME': 'cltbld', 17:41:40 INFO - 'MAIL': '/var/mail/cltbld', 17:41:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:40 INFO - 'MOZ_NO_REMOTE': '1', 17:41:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:40 INFO - 'NO_EM_RESTART': '1', 17:41:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:40 INFO - 'PWD': '/builds/slave/test', 17:41:40 INFO - 'SHELL': '/bin/bash', 17:41:40 INFO - 'SHLVL': '1', 17:41:40 INFO - 'TERM': 'linux', 17:41:40 INFO - 'TMOUT': '86400', 17:41:40 INFO - 'USER': 'cltbld', 17:41:40 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1486257084.675137-1044810650', 17:41:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:40 INFO - '_': '/tools/buildbot/bin/python'} 17:41:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:41:40 INFO - Running setup.py (path:/tmp/pip-yEAV2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:41:40 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)) 17:41:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:41:40 INFO - Running setup.py (path:/tmp/pip-WKZaZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:41:40 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)) 17:41:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:41:40 INFO - Running setup.py (path:/tmp/pip-B4gWrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:41:40 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)) 17:41:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:41:40 INFO - Running setup.py (path:/tmp/pip-7tTPdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:41:40 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)) 17:41:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:41:40 INFO - Running setup.py (path:/tmp/pip-XT1sul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:41:40 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)) 17:41:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:41:40 INFO - Running setup.py (path:/tmp/pip-emfGj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:41:40 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)) 17:41:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:41:40 INFO - Running setup.py (path:/tmp/pip-9z9rOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:41:40 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)) 17:41:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:41:40 INFO - Running setup.py (path:/tmp/pip-kDohnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:41:40 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)) 17:41:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:41:40 INFO - Running setup.py (path:/tmp/pip-wuMRjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:41:41 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)) 17:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:41:41 INFO - Running setup.py (path:/tmp/pip-2LPVzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:41:41 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)) 17:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:41:41 INFO - Running setup.py (path:/tmp/pip-t_PMHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:41:41 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)) 17:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:41:41 INFO - Running setup.py (path:/tmp/pip-ZgqgFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:41:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 17:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:41:41 INFO - Running setup.py (path:/tmp/pip-NL9BCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:41:41 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)) 17:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:41:41 INFO - Running setup.py (path:/tmp/pip-22ZDC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:41:41 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)) 17:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:41:41 INFO - Running setup.py (path:/tmp/pip-0X9yJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:41:41 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)) 17:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:41:41 INFO - Running setup.py (path:/tmp/pip-aEfiFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:41:41 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)) 17:41:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:41:41 INFO - Running setup.py (path:/tmp/pip-5MrnLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:41:41 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)) 17:41:41 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)) 17:41:41 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)) 17:41:41 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)) 17:41:41 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)) 17:41:41 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)) 17:41:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:41: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 17:41: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 17:41: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 17:41: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 17:41: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 17:41: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 17:41:43 INFO - Downloading blessings-1.6.tar.gz 17:41:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:41:43 INFO - Installing collected packages: blessings 17:41:43 INFO - Running setup.py install for blessings 17:41:43 INFO - Successfully installed blessings 17:41:43 INFO - Cleaning up... 17:41:43 INFO - Return code: 0 17:41:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:41:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:41:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:41:44 INFO - Reading from file tmpfile_stdout 17:41:44 INFO - Current package versions: 17:41:44 INFO - argparse == 1.2.1 17:41:44 INFO - blessings == 1.6 17:41:44 INFO - blobuploader == 1.2.4 17:41:44 INFO - docopt == 0.6.1 17:41:44 INFO - functools32 == 3.2.3-2 17:41:44 INFO - jsonschema == 2.5.1 17:41:44 INFO - manifestparser == 1.1 17:41:44 INFO - mozInstall == 1.12 17:41:44 INFO - mozcrash == 1.0 17:41:44 INFO - mozdebug == 0.1 17:41:44 INFO - mozdevice == 0.49 17:41:44 INFO - mozfile == 1.2 17:41:44 INFO - mozhttpd == 0.7 17:41:44 INFO - mozinfo == 0.9 17:41:44 INFO - mozleak == 0.1 17:41:44 INFO - mozlog == 3.4 17:41:44 INFO - moznetwork == 0.27 17:41:44 INFO - mozprocess == 0.24 17:41:44 INFO - mozprofile == 0.28 17:41:44 INFO - mozrunner == 6.13 17:41:44 INFO - mozscreenshot == 0.1 17:41:44 INFO - mozsystemmonitor == 0.3 17:41:44 INFO - moztest == 0.8 17:41:44 INFO - mozversion == 1.4 17:41:44 INFO - psutil == 3.1.1 17:41:44 INFO - requests == 1.2.3 17:41:44 INFO - wsgiref == 0.1.2 17:41:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:41:44 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')]} 17:41:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:44 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')]} 17:41:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:44 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 0x14ff1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1610a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1871480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186e820>, '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 0x186f520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186f9b0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1486257084.675137-1044810650', '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 17:41:44 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 17:41:44 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 17:41:44 INFO - Using env: {'DISPLAY': ':0', 17:41:44 INFO - 'HOME': '/home/cltbld', 17:41:44 INFO - 'LANG': 'en_US.UTF-8', 17:41:44 INFO - 'LANGUAGE': 'en_US:en', 17:41:44 INFO - 'LOGNAME': 'cltbld', 17:41:44 INFO - 'MAIL': '/var/mail/cltbld', 17:41:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:44 INFO - 'MOZ_NO_REMOTE': '1', 17:41:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:44 INFO - 'NO_EM_RESTART': '1', 17:41:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:44 INFO - 'PWD': '/builds/slave/test', 17:41:44 INFO - 'SHELL': '/bin/bash', 17:41:44 INFO - 'SHLVL': '1', 17:41:44 INFO - 'TERM': 'linux', 17:41:44 INFO - 'TMOUT': '86400', 17:41:44 INFO - 'USER': 'cltbld', 17:41:44 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1486257084.675137-1044810650', 17:41:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:44 INFO - '_': '/tools/buildbot/bin/python'} 17:41:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:44 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)) 17:41:44 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)) 17:41:44 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)) 17:41:44 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)) 17:41:44 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)) 17:41:44 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)) 17:41:44 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)) 17:41:44 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)) 17:41:44 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)) 17:41:44 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)) 17:41:44 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)) 17:41:44 INFO - Cleaning up... 17:41:44 INFO - Return code: 0 17:41:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:41:44 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')]} 17:41:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:44 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')]} 17:41:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:44 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 0x14ff1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1610a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1871480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186e820>, '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 0x186f520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186f9b0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1486257084.675137-1044810650', '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 17:41:44 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 17:41:44 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 17:41:44 INFO - Using env: {'DISPLAY': ':0', 17:41:44 INFO - 'HOME': '/home/cltbld', 17:41:44 INFO - 'LANG': 'en_US.UTF-8', 17:41:44 INFO - 'LANGUAGE': 'en_US:en', 17:41:44 INFO - 'LOGNAME': 'cltbld', 17:41:44 INFO - 'MAIL': '/var/mail/cltbld', 17:41:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:44 INFO - 'MOZ_NO_REMOTE': '1', 17:41:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:44 INFO - 'NO_EM_RESTART': '1', 17:41:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:44 INFO - 'PWD': '/builds/slave/test', 17:41:44 INFO - 'SHELL': '/bin/bash', 17:41:44 INFO - 'SHLVL': '1', 17:41:44 INFO - 'TERM': 'linux', 17:41:44 INFO - 'TMOUT': '86400', 17:41:44 INFO - 'USER': 'cltbld', 17:41:44 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1486257084.675137-1044810650', 17:41:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:44 INFO - '_': '/tools/buildbot/bin/python'} 17:41:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:41:44 INFO - Cleaning up... 17:41:44 INFO - Return code: 0 17:41:44 INFO - Running post-action listener: _resource_record_post_action 17:41:44 INFO - Running post-action listener: _start_resource_monitoring 17:41:44 INFO - Starting resource monitoring. 17:41:44 INFO - [mozharness: 2017-02-05 01:41:44.625506Z] Finished create-virtualenv step (success) 17:41:44 INFO - [mozharness: 2017-02-05 01:41:44.625997Z] Running install step. 17:41:44 INFO - Running pre-action listener: _resource_record_pre_action 17:41:44 INFO - Running main action method: install 17:41:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:41:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:41:44 INFO - Reading from file tmpfile_stdout 17:41:44 INFO - Detecting whether we're running mozinstall >=1.0... 17:41:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:41:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:41:44 INFO - Reading from file tmpfile_stdout 17:41:44 INFO - Output received: 17:41:44 INFO - Usage: mozinstall [options] installer 17:41:44 INFO - Options: 17:41:44 INFO - -h, --help show this help message and exit 17:41:44 INFO - -d DEST, --destination=DEST 17:41:44 INFO - Directory to install application into. [default: 17:41:44 INFO - "/builds/slave/test"] 17:41:44 INFO - --app=APP Application being installed. [default: firefox] 17:41:44 INFO - mkdir: /builds/slave/test/build/application 17:41:44 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'] 17:41:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:42:01 INFO - Reading from file tmpfile_stdout 17:42:01 INFO - Output received: 17:42:01 INFO - /builds/slave/test/build/application/firefox/firefox 17:42:01 INFO - Running post-action listener: _resource_record_post_action 17:42:01 INFO - [mozharness: 2017-02-05 01:42:01.134192Z] Finished install step (success) 17:42:01 INFO - [mozharness: 2017-02-05 01:42:01.134466Z] Running run-tests step. 17:42:01 INFO - Running pre-action listener: _resource_record_pre_action 17:42:01 INFO - Running main action method: run_tests 17:42:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:42:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:42:01 INFO - Python 2.7.3 17:42:01 INFO - Return code: 0 17:42:01 INFO - grabbing minidump binary from tooltool 17:42:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:01 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 0x186e820>, '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 0x186f520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186f9b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:42:01 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 17:42:01 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 17:42:01 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 17:42:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:42:01 INFO - Return code: 0 17:42:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:42:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:42:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:42:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:42:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:42:01 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/dA3DHMjvS6OSbEEzgaOT1A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 17:42:01 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/dA3DHMjvS6OSbEEzgaOT1A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 17:42:01 INFO - Using env: {'DISPLAY': ':0', 17:42:01 INFO - 'HOME': '/home/cltbld', 17:42:01 INFO - 'LANG': 'en_US.UTF-8', 17:42:01 INFO - 'LANGUAGE': 'en_US:en', 17:42:01 INFO - 'LOGNAME': 'cltbld', 17:42:01 INFO - 'MAIL': '/var/mail/cltbld', 17:42:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:42:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:42:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:01 INFO - 'MOZ_NO_REMOTE': '1', 17:42:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:42:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:01 INFO - 'NO_EM_RESTART': '1', 17:42:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:01 INFO - 'PWD': '/builds/slave/test', 17:42:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:42:01 INFO - 'SHELL': '/bin/bash', 17:42:01 INFO - 'SHLVL': '1', 17:42:01 INFO - 'TERM': 'linux', 17:42:01 INFO - 'TMOUT': '86400', 17:42:01 INFO - 'USER': 'cltbld', 17:42:01 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1486257084.675137-1044810650', 17:42:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:01 INFO - '_': '/tools/buildbot/bin/python'} 17:42:01 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/dA3DHMjvS6OSbEEzgaOT1A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 17:42:01 INFO - mozversion application_buildid: 20170205010650 17:42:01 INFO - mozversion application_changeset: 3e555770a90a41e04bbb4ac41b65fa2f1db6977d 17:42:01 INFO - mozversion application_display_name: Nightly 17:42:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:42:01 INFO - mozversion application_name: Firefox 17:42:01 INFO - mozversion application_remotingname: firefox 17:42:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:42:01 INFO - mozversion application_vendor: Mozilla 17:42:01 INFO - mozversion application_version: 54.0a1 17:42:01 INFO - mozversion platform_buildid: 20170205010650 17:42:01 INFO - mozversion platform_changeset: 3e555770a90a41e04bbb4ac41b65fa2f1db6977d 17:42:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:42:01 INFO - mozversion platform_version: 54.0a1 17:42:01 INFO - using testdate: 1486258921 17:42:01 INFO - actual date: 1486258921 17:42:01 INFO - starting webserver on 'localhost:48857' 17:42:01 INFO - SUITE-START | Running 2 tests 17:42:01 INFO - TEST-START | dromaeo_css 17:42:01 INFO - operating with platform_type : linux_ 17:42:01 INFO - Initialising browser for dromaeo_css test... 17:42:01 INFO - TEST-INFO | started process 4022 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_fmsHB/profile http://localhost:48857/getInfo.html) 17:42:06 INFO - PROCESS | 4022 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 17:42:06 INFO - PROCESS | 4022 | __metrics Screen width/height:1600/1200 17:42:06 INFO - PROCESS | 4022 | colorDepth:24 17:42:06 INFO - PROCESS | 4022 | Browser inner width/height: 1024/697 17:42:06 INFO - PROCESS | 4022 | __metrics 17:42:07 INFO - PROCESS | 4022 | 1486258927077 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < permitUnload@remote-browser.xml:353:13 < CanCloseWindow@browser.js:6303:36 < canClose@browser.js:5169:12 < forceQuit@jar:file:///tmp/tmp_fmsHB/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmp_fmsHB/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmp_fmsHB/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmp_fmsHB/profile/extensions/talos-powers@TalosPowersService.js:55:9 17:42:07 ERROR - PROCESS | 4022 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 17:42:08 INFO - TEST-INFO | 4022: exit 0 17:42:08 INFO - Browser initialized. 17:42:08 INFO - Running cycle 1/1 for dromaeo_css test... 17:42:08 INFO - TEST-INFO | started process 4140 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_fmsHB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:42:20 INFO - PROCESS | 4140 | RSS: Main: 159121408 17:42:20 INFO - PROCESS | 4140 | 17:45:24 INFO - PROCESS | 4140 | Cycle 1(1): loaded http://localhost:48857/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48857/tests/dromaeo/cssquery-ext.html) 17:45:26 INFO - PROCESS | 4140 | RSS: Main: 168882176 17:45:26 INFO - PROCESS | 4140 | 17:47:08 INFO - PROCESS | 4140 | ************************* 17:47:08 INFO - PROCESS | 4140 | A coding exception was thrown and uncaught in a Task. 17:47:08 INFO - PROCESS | 4140 | 17:47:08 ERROR - PROCESS | 4140 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:47:08 INFO - PROCESS | 4140 | Full stack: 17:47:08 INFO - PROCESS | 4140 | ************************* 17:48:28 INFO - PROCESS | 4140 | Cycle 1(1): loaded http://localhost:48857/tests/dromaeo/cssquery-ext.html (next: http://localhost:48857/tests/dromaeo/cssquery-jquery.html) 17:48:29 INFO - PROCESS | 4140 | RSS: Main: 164020224 17:48:29 INFO - PROCESS | 4140 | 17:51:31 INFO - PROCESS | 4140 | Cycle 1(1): loaded http://localhost:48857/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48857/tests/dromaeo/cssquery-mootools.html) 17:51:32 INFO - PROCESS | 4140 | RSS: Main: 171597824 17:51:32 INFO - PROCESS | 4140 | 17:54:34 INFO - PROCESS | 4140 | Cycle 1(1): loaded http://localhost:48857/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48857/tests/dromaeo/cssquery-prototype.html) 17:54:34 INFO - PROCESS | 4140 | RSS: Main: 164679680 17:54:34 INFO - PROCESS | 4140 | 17:57:38 INFO - PROCESS | 4140 | Cycle 1(1): loaded http://localhost:48857/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48857/tests/dromaeo/cssquery-yui.html) 17:57:38 INFO - PROCESS | 4140 | RSS: Main: 168284160 17:57:38 INFO - PROCESS | 4140 | 18:00:41 INFO - PROCESS | 4140 | Cycle 1(1): loaded http://localhost:48857/tests/dromaeo/cssquery-yui.html (next: http://localhost:48857/tests/dromaeo/cssquery-dojo.html) 18:00:41 INFO - PROCESS | 4140 | RSS: Main: 169971712 18:00:41 INFO - PROCESS | 4140 | 18:00:41 INFO - PROCESS | 4140 | __start_tp_report 18:00:41 INFO - PROCESS | 4140 | _x_x_mozilla_page_load 18:00:41 INFO - PROCESS | 4140 | _x_x_mozilla_page_load_details 18:00:41 INFO - PROCESS | 4140 | |i|pagename|runs| 18:00:41 INFO - PROCESS | 4140 | |0;dojo.html;2548.0699544666195;2588.715241323454;2590.6502622146004;2611.0339174505434;2622.4886147201305;4534.705244159136;4776.928346074812;4785.18651829189;4811.7594120294025;4823.541763532463;4542.409486766724;4585.312203169527;4615.907681846361;4707.411573553306;4716.10394025135;4285.078708077771;4354.303311470166;4369.453818272716;4424.690271680984;4470.575295346936;4109.856155034575;4370.38814565961;4475.888102797439;4488.932666009996;4505.752183629916;4156.958430415718;4452.0873220989615;4459.910801783963;4507.954920450787;4508.526604706508;4244.745315281093;4249.660027197817;4256.531781504032;4299.677524185668;4314.1371725655;4312.762798046107;4327.221100201962;4333.783310834478;4360.280553708634;4369.3227549729845;4602.746848923308;4629.768511574408;4652.185867473178;4662.673612847102;4670.859874203746;4770.403699537558;4846.151923413424;4962.8759281018265;4964.528369804862;5002.574781143607;5089.465606111342;5130.563902068328;5132.897342053176;5182.533571978503;5183.974080129575;4781.617470602343;4789.233722604366;4789.688670236424;4802.063597598435;4846.442659094249;4942.975285123552;5016.347874776328;5244.580433565306;5247.790088396498;5290.550303224192;4944.554990050912;5018.84943451697;5032.84901452957;5040.2691609716385;5069.087564238399;5067.771950262247;5114.616403769732;5121.974390128025;5133.820316288912;5186.92219616706;4762.761861906891;5074.2895994560795;5088.109580823341;5104.821331253463;5165.14775062118;4807.831725889647;4823.734694591831;4855.927161092586;4876.049170411736;4877.317175595419;4151.56408577095;4158.272302347077;4162.521310049323;4166.041810383568;4166.250074986531;3660.5058317127377;3661.7802931824176;3672.8347224374966;3696.9445458318146;3717.8141092945784;4384.7369157850635;4405.845795397146;4412.911741765147;4439.800208990603;4454.955450445454;4970.353853998957;5082.74586270685;5091.159958606862;5101.336826212569;5139.665921715076;4241.809118589671;4272.6154646082;4331.631811296075;4392.538783427758;4396.60430561251;4501.954980450154;4577.3362862384765;4588.931166032512;4622.098690755338;4627.120847039052;4764.833230836974;4767.880802979815;4773.284007398918;4783.330333753347;4809.567138957371;4849.127157111613;4867.367242258625;4973.378327709036;5088.949110508847;5124.666896651705;4630.166570017294;4657.138429390574;4666.160091183619;4685.461171965131;4703.647226457961;4906.846890980688;4911.336969509213;4912.828051018198;4925.507449255189;4953.72754498506;4810.975945120252;4862.610991120772;4911.926321105115;4933.55597996182;4974.204127339608;4602.194615942263;4630.166570017429;4670.766461676971;4684.0866031123605;4726.10204061241;4642.257238841769;4664.370310008241;4683.1336202802595;4687.015726697432;4720.905581888274;4494.528074552125;4669.322948172428;4702.694324868872;4738.7867545959825;4744.833930812405;4813.590844778093;4834;4852.927206091841;4856.68431551948;4868.805247790048;4722.244440889442;4789.4971028041555;4816.8554943350355;4852.951470485391;4872.074305881871 18:00:41 INFO - PROCESS | 4140 | |1;ext.html;461.50157829544094;472.709283790469;486.84177642266263;514.6448950224345;515.1860061103456;36650.26699466012;38066.42900356493;38105.80947095264;41063.589364106425;41201.381979270336;37958.24083518328;38450.230995380145;38484.42273365895;38491.80754096233;38527.42208866862;7384.298491643312;7668.156502784689;7669.578173200472;8993;9315.068493150698;8934.106589341047;9148.268138548934;9148.359614826932;9150.901891772997;9170.49562274078;9006.054364291753;9155.95422022889;9231.492267925261;9231.753713248692;9241.122093401149;9031.27749780016;9126.402879496061;9139.177474027369;9145.908540914572;9146.405483643575;9090.454572725657;9205;9214.170724634749;9253.72238832836;9317.928438229555;31724.682753172405;32047.51928721071;32098.679013209803;32179.19552011195;32202.83898580492;3345.565076540034;3418.435958066916;3429.8274096460673;3480.077779388464;3505.474178873164;24384.756152438604;24577.631335529983;24763.752362476323;24774.380640483952;25531;3308.387948229561;3328.151321413048;3345.2974875276223;3367.663233676613;3425.6403077676982;240534;240781;240886;243111;243137;39301.60698393037;40350.59649403527;40592.797036015225;45946.5405345949;46508.7674561625;47063;47442.76278618654;47565.76217118892;47585.76207118942;47698;11259.831102533468;11477.253978491372;11482.253653512495;11500.712482187844;11524.88475115255;8571.185737354941;8606.096359882247;8652.178043085896;8710.433821801562;8727.476351418809;15387.230638468032;15396.230188490754;15442.227888605525;15476.535703928676;15650.295736691876;6229.53278504114;6297.71755206464;6329.2721337045905;6493.51298652603;6509.414152726277;768.2202564397141;769.9923000770033;771.733751855609;782.3428320210936;795.6697970342359;25387.36531586725;25935.870320648275;26534.785818319713;26942.32644183911;26968.460630787667;878.767126711422;902.4991129922824;926.2451102351562;960.5149399553181;1065.7708592652616;12750.61748147557;12814.871851281368;12872.742545149045;13030.674233144058;13034.348282586023;371267;372916;374918;375233;377009;40607.7969610156;40622.59377406247;40693;40709.389359159046;40987.7950610251;1121.7980763462492;1137.5336112194127;1194.3192380343294;1194.4266751959108;1200.3098218524208;22156.88921555382;22264.666030009237;23693.289201323987;23843.761562384156;23913.52172956566;34593.65406346005;34998.30003399867;35262.294754105285;35329;35329.29341413106;331970;337375;337632;337688;339192;22530.5493890118;22952.245730512444;23767.52464950726;23919.282421527383;25088.874555627106;34699.4795078069;34760.304793904485;35419.46870796889;35436.29127417489;35917.64082359143;30007.249818754706;30455;30718.539221911244;31142.53286200754;31179.68820311768;29556.704432955394;29688.406231875673;30086.24784380408;30512.84743576268;30805.845970770002;29809.403811924072;30640.540391894585;30867.536986944764;30889.536656949713;30943;26461.33846653849;26985;27718.722812771615;27868.16395508138;28230;21347;21464.46338841479;21888;21903.561928761017;22320.77679223187 18:00:41 INFO - PROCESS | 4140 | |2;jquery.html;366.1121779684265;376.64595280436396;378.6232698465027;389.84795929587483;400.17164469548027;16436.178191090457;16770.83229167708;17344;17361.82638173618;17498.912505437485;10853.186011049163;16937.3225070997;17447.12764361783;17763.733543996852;17884.64230715385;4494.550544945504;4725.456572494156;4734.26618874075;4739.194336962707;4744.217204161309;4617.399738034051;4733.455652599943;5156.123459011977;5458.153986132136;5461.453854614547;5481.945180548183;5553.278073850393;5554.555635549166;5555.972220138894;5562.916556251659;5497.175423686439;5564.972175139119;5929.318128415244;5986.8503287417725;5996.820095397145;5349.384820745586;5351.384590772072;5359.035373632744;5372.898555796052;5375.865603359908;11984.460699268553;12008.579699710468;12078.21491603043;12124.515019399214;12129.393530323448;2083.2812679625504;2089;2158.589867925105;2190.8904554772357;2196.5277465344866;9124.270058395312;9262.305327100494;9274.118958698913;9286.860697089549;9816.509174541245;1611.5165450364962;1634.618747158649;1664.6254592716664;1672.9749053764203;1681.697294486992;77175;78449.3898061735;78851;81557;82443.58778206131;9895.505224738734;10446;10497.26519143668;10595.311304765166;10939.812037592514;13345.532906348231;13494.325283735774;13522.661933451742;13523.932380338232;13726.245056521988;6529.902051469232;6670.433013193933;6766.932330676728;6772.255051944282;6845.931540684529;6166.290876549254;6239.937600623935;6318.936810631927;6350.110984462179;6360.554761166766;4220.303649897733;4295.656347492193;4333.5016473106;4415.802580714889;4529.84145554904;1818.8272114149136;1913.3781521005728;1913.885166889991;1927.296536764071;1955.9413217603494;737.2380011771869;752.6199269368933;781.8709912864314;791.5409062743595;794.031281836159;16468.588285292724;16883.577910552336;17297.221625026905;17340.219690113976;17537;778.2062296457582;784.3568274015366;785.5483097219122;788.3062904643991;790.1940021178366;9378.85931711025;9824.45965471906;9880.505974701236;9894.653687120915;10028.398296102258;324532;330819;331593;494309;501186;91945;95777;96347;97536.51231743938;101195.49402252941;937.9437233765996;950.4867371619387;981.4798156976814;987.4322264697971;996.3075662414698;15774.60563485876;16149.75775363394;16218.432354867524;16592.917035414746;16692.666146676755;40041;40297.798511008434;40413.393799092446;40447;40547.59452405556;57691.423085768605;58186.4181358181;58855.411445884994;59312.703436482545;59398;7479.738209162871;7749.496282741604;7831.177726338652;7975.401844861774;8137.023557173177;8635.913640863762;8686.522241276538;8702.521361325187;9285.164335209864;12133.393330333625;7939.483933544301;8126.984126984127;8239.588020599065;8291.212334828182;8326.666933322842;7883.763487095396;7974.242446967529;8132.227438393344;8256.463329883538;8344.415890887822;8225.629846657035;8249.711260105867;8339.833203335778;8391.244787968868;8719.302455803647;12601.18092323996;12636.494540218657;12671.619851404472;12727.427265773247;12751.489940402651;11930.821037684615;12023.398830058637;12051.096167787626;12135.878641213829;12453.25280483174 18:00:41 INFO - PROCESS | 4140 | |3;mootools.html;1286.665466978586;1299.3892870350937;1302.5506200360876;1306.1314226039683;1315.480385247827;7342.632868356574;7386.630668466575;7614.73348432805;7770.8445831083345;7774.37804975602;7422.18355980843;7543.735969241077;7551.131619863717;7551.471397002212;7593.962030189855;2101.0860275780046;2120.9893950530227;2131.328631481086;2135.049902793258;2137.3908436095717;2054.7534295884516;2093.9895300523553;2106.136484041543;2112.13402504973;2115.333669893986;2052.343250159942;2071.989640051798;2093.1418118571387;2102.1696429910176;2103.3374487036535;2044.4786579422228;2058;2068.420842164189;2069.1206237349143;2070.4099331690395;1742.3204950069482;1803.9458816235533;2000.6298834715624;2039.1333683184735;2108.9050992705365;7223.89164162538;7534.133574638932;7562.810929726746;7725.729599463992;7748.6900523978975;4506.053728716974;4683.625309975194;4692.81228750853;4699.600533954618;4712.575868171847;2804.9902035267287;2814.521531339677;2817.760490358322;2898.884044638212;2906.8401237931907;1063.1919740996898;1083.285031878964;1120.3278033180109;1122.5341483284428;1148.3683973814368;10203.489825508768;10205.948970255102;10240.692779216635;10314.79370412595;10315.742106447324;3727.6645101940953;3886.3393223152134;3946.565877753445;3959.089409435788;3972.6226008529143;8207.343412526983;8224.218699223564;8251.33989280856;8255.917440825515;8277.130901255281;4513.300438432048;4513.864584062483;4518.367428560005;4518.728876267434;4531.864044078683;4001.7198796083994;4034.959650403517;4247.065645557972;4261.083866968616;4262.23279809631;3323.5014747788027;3358.7984720916825;3366.2762506061313;3428.7599868009;3433.5879694436826;1013.5996281468779;1015.9847602285971;1016.1616666250374;1022.4989755019986;1025.108155904353;722.37514549915;744.4639859301294;756.3684323589754;765.1812560560147;777.5917643237345;4682.1338052460405;4773.809047638125;4796;5057.089723849669;5185.948140518546;843.4433274039227;865.7619154732373;892.2727976698969;903.8644203369547;905.4431524612316;3147.464930961742;3241.2221066944235;3246.366958443128;3342.2647017656077;3394.6605339465855;8530.70142545008;8854.29165666745;8896.733098007071;8914.821703565893;9210.217131543759;8995.415298005608;9147.679831205876;9207.539623018822;9212.63149474027;9230.400023998553;6755.695993680296;7008.26413226614;7092.943046516556;7250.637468126678;7267.4549408794555;4735.12400205963;4763.833265835818;5056.089903817348;5070.645054846125;5129.281900533853;7867.213278672316;8303.211194936472;8456.957715211385;8479.19447652472;8534.658613655385;8448.662053518035;8542.487450752975;8577.313814894918;8640.56797160127;8653;6478.4169424752;6675.766348177791;6682.599044057372;6694.765683201064;6694.765683201064;7067.893981590178;7079.1505019398;7114.964425177841;7290.05229320185;7324.926750732425;6567;6820.624865632438;6823;6831.658417079226;6848.246692863681;6747.696353664195;6800.489963252677;6868.553544019623;6903.93096069053;6979.162500499972;5524.8342549723575;5556.611037227355;5588.972055139699;5601.719914004365;5614.747336369792;4294.947737804133;4395.7362558246605;4457.576530229623;4471.8434854779925;4480.9103817924115;4338.52276249606;4361.869143925687;4453.844115455943;4470.351798989193;4473.105378924293 18:00:41 INFO - PROCESS | 4140 | |4;prototype.html;331.99336013279736;334.6954271612832;338.71717116207964;340.319361277445;340.6100015482273;4860.416749990001;4888.291197776325;4888.340074089997;4898.216285394337;4966.343006491518;4758.405199350082;4805;4837.5646191842725;4907.582855457282;4933.703977761337;3634.109643137435;3767.472553842464;3767.7550959187565;3807.7524960877454;3825.7321987460887;3736.8878933632036;3752.9061773455746;3786.7503723771088;3802.6500592289754;3815.7138214633874;3697.8151092445405;3776.3580191367532;3781.0925377909243;3816.313063648542;3824.5984171661994;3615.783053016801;3709.6290370962956;3710.8515659373593;3782.3002744492355;3808.409696497047;3242.4325742994884;3244.8864289749745;3268.5750852389037;3280.2127489402374;3305.3389322135667;4710.199266124767;4757.976210118962;4758.857234282977;4766.833160839388;4783.330333753277;4178.289690752549;4233.407322974786;4255.936160957588;4289;4298.26929421999;4863.176308884168;5093.974530127326;5111.974440127813;5120.795168193268;5162.277281180638;3518.9120271993147;3551.928961420783;3580.856765729368;3581.6239294874185;3585.2470981093743;5168.948310516885;5302.2311764793885;5331.546818520431;5425.864353391197;5443.374011988632;3859.8842034739005;3885.1841113365945;3915.2365288768415;3919.5492518360184;3969.8809035728973;3936.4292177634084;3966.861159859391;3981.5222173339384;3995.300822356134;4004.4593979812935;4436.933445998313;4444.177827101932;4444.200043992112;4447.844325448658;4473.763118440779;4976.975115124401;5142.87142821425;5156.92264616031;5181.45070626622;5191.480851914854;1294.7863602505481;1333.306680526121;1335.6861137632648;1336.6992426703914;1346.7104572516955;877.2236570635034;958.4488918871676;958.9020571445795;960.1900417712662;964.6334392930642;4279.529251782302;4283.30809330319;4329.653627709776;4335.176316499855;4360.8909777255185;5017.222330538772;5029.622778291643;5094.61790365724;5195.610329225323;5228.503292187236;4156.646685031807;4250.512320687734;4288.592583704543;4352.260115780325;4425.756583387944;2618.698849632279;2646.4177880866177;2679.4507126039116;2719.360950176707;2738.6713594368803;4711.505291944365;4729.62163026957;4738.573528382393;4758.333833263346;4788.712677239377;5092.439831618593;5145.093022442308;5147.716875571879;5161.896762064813;5208.401033881077;4819.819144309667;4922.827701030446;4930.827421040318;4949.480304567968;4982.352294201731;5227.503387178212;5257.132573125392;5291.7618707159045;5373.005993891143;5405.702686352289;4877.878053048702;5070.645054846273;5147.433782283871;5209.322788037531;5249.480249480194;4643.930341044955;4800.3279540865005;4861.586765125004;4961.305417241517;4979.402471703419;3648.543932008499;3663.413853783382;3667.449882517644;3670.302642497917;3683.9631603684693;5111.258867464271;5150.9742451289;5183.844484665466;5210.713410762444;5216.37403511581;4766.880827979328;4848.12733707936;4921.212605983169;4957.652964292609;5005.849824505271;4920.286558449076;4930.778114984762;4934.457209707001;4935.087008903364;4948.703077815343;4972.453030166751;5011.596752909046;5013.949860501494;5019.548240658358;5073.720945348041;4786;5004;5057.443681194992;5077.974610126926;5128.538431541179;4880.170371036861;4974.651774375759;5000.2499625056535;5022.518357084742;5032.955062187324 18:00:41 INFO - PROCESS | 4140 | |5;yui.html;581.7004242814949;582.199475720884;613.2028363127934;639.3798015924555;648.1573953859983;11541.134414918883;12042.819357709619;12203.26780393177;12318.81521777173;12832.743345133114;11995.820062699066;12606.93696531516;12658.81011784824;12739.61781146567;12757.808632870514;745.258467824514;775.2867362026949;778.4395235430482;787.2639082457891;787.5117427195147;736.9594672293022;770.9190534993801;777.5334799120538;779.5089093870854;785.2030189357806;816.4529765057396;819.8073452738602;820.4543978254453;820.6799348254185;821.4167940762036;810.4084018666348;815.339574944297;815.9388045896522;816.2408959667507;818.2472125644422;596.931352894414;597.7608956417424;599.1821164110958;599.5443462968176;600.5315853634172;12352.135350525466;12556;12556.121071524996;12643.810342844772;12716.300603466805;11553.711157221052;12125.454354554066;12212.633620991295;12216.511339546407;12288.508459661603;10295.227857910686;10425.113865321457;10525.526351314209;10591.470426478645;10612.416317102556;3019.290466740314;3037.893673721409;3061.8928337508305;3129.04564107947;3138.2625083105454;59531.40468595302;59571;59604.40395596032;59940;60078;9083.772905677279;9124.178823905748;9268.814623707489;9322.86015709765;9666.806663866684;15328.463503777315;15508.379664813507;15555.533333999998;16167;16193.514194574182;5946;5961.731722072517;5964.582479226499;6016.729247183887;6119.938800611937;3173.1273899677312;3191.3617276544783;3320.966790332114;3336.1492819330915;3441.5698037745283;2939;2990.1029691092585;2999.2651800309063;3017.1551965449707;3037.9544306835414;498.5288901987587;499.98500044998707;503.8866255092575;504.1203100589495;506.5668853130594;588.4027711872453;612.6109920200705;615.6183166436838;620.8882401167742;631.26457676806;8302.294304984023;8344.958275208584;8378.371622128365;8472.618732156945;8480.406371553932;600.687642425936;626.9811905642838;627.8744251149789;628.1331762168179;629.4586655476287;3740.8490118182153;3748.11919198988;3851.826667799956;3864;3916.804159791999;61329.69335153296;61763.38236617666;62454;62851.37148628547;65615.67192164008;55338.72330638402;56415;59000;59355.109673354935;61120;44994.325085123746;50396;51666;52855.73572132115;54463.727681362136;7237.3486386225495;7483.027206463125;7563.243675632392;7661.502002369828;7686.346660533917;34902.30195396027;35572.644273556936;35658.82170589131;35945.64054359423;36597.634023659426;43427.34858977181;43719;43731.34402983894;43765.15526490768;46069;9188.540572971458;9477.668281610111;9568.952155239458;9674.516274186404;9686.321957463191;9532.618695252113;9788.657396991071;9897.703068907944;9944;10006.44964526958;9290.907090929275;9439.952800235955;9454.05459454049;9516.6643480335;9932.056454636799;9792.902070979198;9833.792250289454;9985.950070249603;9999.900000999896;10084;9090.363674542983;9147.588358524015;9176.220021298264;9327.626894924399;9733.756656083655;7626.923730762844;7823.217678232131;8107.635156417858;8117.147699491468;8117.472364296302;6899.793006209822;6933.514653974174;6991.165011249423;7131.215566287808;7244 18:00:41 INFO - PROCESS | 4140 | __end_tp_report 18:00:41 INFO - PROCESS | 4140 | __start_cc_report 18:00:41 INFO - PROCESS | 4140 | _x_x_mozilla_cycle_collect,393 18:00:41 INFO - PROCESS | 4140 | __end_cc_report 18:00:41 INFO - PROCESS | 4140 | __startTimestamp1486260041909__endTimestamp 18:00:41 INFO - PROCESS | 4140 | 18:00:41 INFO - PROCESS | 4140 | ------- Summary: start ------- 18:00:41 INFO - PROCESS | 4140 | Number of tests: 6 18:00:41 INFO - PROCESS | 4140 | 18:00:41 INFO - PROCESS | 4140 | [#0] dojo.html Cycles:165 Average:4624.91 Median:4720.91 stddev:487.55 (10.3%) stddev-sans-first:461.02 18:00:41 INFO - PROCESS | 4140 | Values: 2548.1 2588.7 2590.7 2611.0 2622.5 4534.7 4776.9 4785.2 4811.8 4823.5 4542.4 4585.3 4615.9 4707.4 4716.1 4285.1 4354.3 4369.5 4424.7 4470.6 4109.9 4370.4 4475.9 4488.9 4505.8 4157.0 4452.1 4459.9 4508.0 4508.5 4244.7 4249.7 4256.5 4299.7 4314.1 4312.8 4327.2 4333.8 4360.3 4369.3 4602.7 4629.8 4652.2 4662.7 4670.9 4770.4 4846.2 4962.9 4964.5 5002.6 5089.5 5130.6 5132.9 5182.5 5184.0 4781.6 4789.2 4789.7 4802.1 4846.4 4943.0 5016.3 5244.6 5247.8 5290.6 4944.6 5018.8 5032.8 5040.3 5069.1 5067.8 5114.6 5122.0 5133.8 5186.9 4762.8 5074.3 5088.1 5104.8 5165.1 4807.8 4823.7 4855.9 4876.0 4877.3 4151.6 4158.3 4162.5 4166.0 4166.3 3660.5 3661.8 3672.8 3696.9 3717.8 4384.7 4405.8 4412.9 4439.8 4455.0 4970.4 5082.7 5091.2 5101.3 5139.7 4241.8 4272.6 4331.6 4392.5 4396.6 4502.0 4577.3 4588.9 4622.1 4627.1 4764.8 4767.9 4773.3 4783.3 4809.6 4849.1 4867.4 4973.4 5088.9 5124.7 4630.2 4657.1 4666.2 4685.5 4703.6 4906.8 4911.3 4912.8 4925.5 4953.7 4811.0 4862.6 4911.9 4933.6 4974.2 4602.2 4630.2 4670.8 4684.1 4726.1 4642.3 4664.4 4683.1 4687.0 4720.9 4494.5 4669.3 4702.7 4738.8 4744.8 4813.6 4834.0 4852.9 4856.7 4868.8 4722.2 4789.5 4816.9 4853.0 4872.1 18:00:41 INFO - PROCESS | 4140 | 18:00:41 INFO - PROCESS | 4140 | [#1] ext.html Cycles:180 Average:44772.04 Median:34729.89 stddev:85137.74 (245.1%) stddev-sans-first:85311.57 18:00:41 INFO - PROCESS | 4140 | Values: 461.5 472.7 486.8 514.6 515.2 36650.3 38066.4 38105.8 41063.6 41201.4 37958.2 38450.2 38484.4 38491.8 38527.4 7384.3 7668.2 7669.6 8993.0 9315.1 8934.1 9148.3 9148.4 9150.9 9170.5 9006.1 9156.0 9231.5 9231.8 9241.1 9031.3 9126.4 9139.2 9145.9 9146.4 9090.5 9205.0 9214.2 9253.7 9317.9 31724.7 32047.5 32098.7 32179.2 32202.8 3345.6 3418.4 3429.8 3480.1 3505.5 24384.8 24577.6 24763.8 24774.4 25531.0 3308.4 3328.2 3345.3 3367.7 3425.6 240534.0 240781.0 240886.0 243111.0 243137.0 39301.6 40350.6 40592.8 45946.5 46508.8 47063.0 47442.8 47565.8 47585.8 47698.0 11259.8 11477.3 11482.3 11500.7 11524.9 8571.2 8606.1 8652.2 8710.4 8727.5 15387.2 15396.2 15442.2 15476.5 15650.3 6229.5 6297.7 6329.3 6493.5 6509.4 768.2 770.0 771.7 782.3 795.7 25387.4 25935.9 26534.8 26942.3 26968.5 878.8 902.5 926.2 960.5 1065.8 12750.6 12814.9 12872.7 13030.7 13034.3 371267.0 372916.0 374918.0 375233.0 377009.0 40607.8 40622.6 40693.0 40709.4 40987.8 1121.8 1137.5 1194.3 1194.4 1200.3 22156.9 22264.7 23693.3 23843.8 23913.5 34593.7 34998.3 35262.3 35329.0 35329.3 331970.0 337375.0 337632.0 337688.0 339192.0 22530.5 22952.2 23767.5 23919.3 25088.9 34699.5 34760.3 35419.5 35436.3 35917.6 30007.2 30455.0 30718.5 31142.5 31179.7 29556.7 29688.4 30086.2 30512.8 30805.8 29809.4 30640.5 30867.5 30889.5 30943.0 26461.3 26985.0 27718.7 27868.2 28230.0 21347.0 21464.5 21888.0 21903.6 22320.8 18:00:41 INFO - PROCESS | 4140 | 18:00:41 INFO - PROCESS | 4140 | [#2] jquery.html Cycles:180 Average:25358.43 Median:5350.38 stddev:67749.78 (1266.3%) stddev-sans-first:67913.84 18:00:41 INFO - PROCESS | 4140 | Values: 366.1 376.6 378.6 389.8 400.2 16436.2 16770.8 17344.0 17361.8 17498.9 10853.2 16937.3 17447.1 17763.7 17884.6 4494.6 4725.5 4734.3 4739.2 4744.2 4617.4 4733.5 5156.1 5458.2 5461.5 5481.9 5553.3 5554.6 5556.0 5562.9 5497.2 5565.0 5929.3 5986.9 5996.8 5349.4 5351.4 5359.0 5372.9 5375.9 11984.5 12008.6 12078.2 12124.5 12129.4 2083.3 2089.0 2158.6 2190.9 2196.5 9124.3 9262.3 9274.1 9286.9 9816.5 1611.5 1634.6 1664.6 1673.0 1681.7 77175.0 78449.4 78851.0 81557.0 82443.6 9895.5 10446.0 10497.3 10595.3 10939.8 13345.5 13494.3 13522.7 13523.9 13726.2 6529.9 6670.4 6766.9 6772.3 6845.9 6166.3 6239.9 6318.9 6350.1 6360.6 4220.3 4295.7 4333.5 4415.8 4529.8 1818.8 1913.4 1913.9 1927.3 1955.9 737.2 752.6 781.9 791.5 794.0 16468.6 16883.6 17297.2 17340.2 17537.0 778.2 784.4 785.5 788.3 790.2 9378.9 9824.5 9880.5 9894.7 10028.4 324532.0 330819.0 331593.0 494309.0 501186.0 91945.0 95777.0 96347.0 97536.5 101195.5 937.9 950.5 981.5 987.4 996.3 15774.6 16149.8 16218.4 16592.9 16692.7 40041.0 40297.8 40413.4 40447.0 40547.6 57691.4 58186.4 58855.4 59312.7 59398.0 7479.7 7749.5 7831.2 7975.4 8137.0 8635.9 8686.5 8702.5 9285.2 12133.4 7939.5 8127.0 8239.6 8291.2 8326.7 7883.8 7974.2 8132.2 8256.5 8344.4 8225.6 8249.7 8339.8 8391.2 8719.3 12601.2 12636.5 12671.6 12727.4 12751.5 11930.8 12023.4 12051.1 12135.9 12453.3 18:00:41 INFO - PROCESS | 4140 | 18:00:41 INFO - PROCESS | 4140 | [#3] mootools.html Cycles:180 Average:4917.35 Median:4723.85 stddev:2740.37 (58.0%) stddev-sans-first:2734.47 18:00:41 INFO - PROCESS | 4140 | Values: 1286.7 1299.4 1302.6 1306.1 1315.5 7342.6 7386.6 7614.7 7770.8 7774.4 7422.2 7543.7 7551.1 7551.5 7594.0 2101.1 2121.0 2131.3 2135.0 2137.4 2054.8 2094.0 2106.1 2112.1 2115.3 2052.3 2072.0 2093.1 2102.2 2103.3 2044.5 2058.0 2068.4 2069.1 2070.4 1742.3 1803.9 2000.6 2039.1 2108.9 7223.9 7534.1 7562.8 7725.7 7748.7 4506.1 4683.6 4692.8 4699.6 4712.6 2805.0 2814.5 2817.8 2898.9 2906.8 1063.2 1083.3 1120.3 1122.5 1148.4 10203.5 10205.9 10240.7 10314.8 10315.7 3727.7 3886.3 3946.6 3959.1 3972.6 8207.3 8224.2 8251.3 8255.9 8277.1 4513.3 4513.9 4518.4 4518.7 4531.9 4001.7 4035.0 4247.1 4261.1 4262.2 3323.5 3358.8 3366.3 3428.8 3433.6 1013.6 1016.0 1016.2 1022.5 1025.1 722.4 744.5 756.4 765.2 777.6 4682.1 4773.8 4796.0 5057.1 5185.9 843.4 865.8 892.3 903.9 905.4 3147.5 3241.2 3246.4 3342.3 3394.7 8530.7 8854.3 8896.7 8914.8 9210.2 8995.4 9147.7 9207.5 9212.6 9230.4 6755.7 7008.3 7092.9 7250.6 7267.5 4735.1 4763.8 5056.1 5070.6 5129.3 7867.2 8303.2 8457.0 8479.2 8534.7 8448.7 8542.5 8577.3 8640.6 8653.0 6478.4 6675.8 6682.6 6694.8 6694.8 7067.9 7079.2 7115.0 7290.1 7324.9 6567.0 6820.6 6823.0 6831.7 6848.2 6747.7 6800.5 6868.6 6903.9 6979.2 5524.8 5556.6 5589.0 5601.7 5614.7 4294.9 4395.7 4457.6 4471.8 4480.9 4338.5 4361.9 4453.8 4470.4 4473.1 18:00:41 INFO - PROCESS | 4140 | 18:00:41 INFO - PROCESS | 4140 | [#4] prototype.html Cycles:180 Average:4202.62 Median:4775.11 stddev:1203.46 (25.2%) stddev-sans-first:1171.24 18:00:41 INFO - PROCESS | 4140 | Values: 332.0 334.7 338.7 340.3 340.6 4860.4 4888.3 4888.3 4898.2 4966.3 4758.4 4805.0 4837.6 4907.6 4933.7 3634.1 3767.5 3767.8 3807.8 3825.7 3736.9 3752.9 3786.8 3802.7 3815.7 3697.8 3776.4 3781.1 3816.3 3824.6 3615.8 3709.6 3710.9 3782.3 3808.4 3242.4 3244.9 3268.6 3280.2 3305.3 4710.2 4758.0 4758.9 4766.8 4783.3 4178.3 4233.4 4255.9 4289.0 4298.3 4863.2 5094.0 5112.0 5120.8 5162.3 3518.9 3551.9 3580.9 3581.6 3585.2 5168.9 5302.2 5331.5 5425.9 5443.4 3859.9 3885.2 3915.2 3919.5 3969.9 3936.4 3966.9 3981.5 3995.3 4004.5 4436.9 4444.2 4444.2 4447.8 4473.8 4977.0 5142.9 5156.9 5181.5 5191.5 1294.8 1333.3 1335.7 1336.7 1346.7 877.2 958.4 958.9 960.2 964.6 4279.5 4283.3 4329.7 4335.2 4360.9 5017.2 5029.6 5094.6 5195.6 5228.5 4156.6 4250.5 4288.6 4352.3 4425.8 2618.7 2646.4 2679.5 2719.4 2738.7 4711.5 4729.6 4738.6 4758.3 4788.7 5092.4 5145.1 5147.7 5161.9 5208.4 4819.8 4922.8 4930.8 4949.5 4982.4 5227.5 5257.1 5291.8 5373.0 5405.7 4877.9 5070.6 5147.4 5209.3 5249.5 4643.9 4800.3 4861.6 4961.3 4979.4 3648.5 3663.4 3667.4 3670.3 3684.0 5111.3 5151.0 5183.8 5210.7 5216.4 4766.9 4848.1 4921.2 4957.7 5005.8 4920.3 4930.8 4934.5 4935.1 4948.7 4972.5 5011.6 5013.9 5019.5 5073.7 4786.0 5004.0 5057.4 5078.0 5128.5 4880.2 4974.7 5000.2 5022.5 5033.0 18:00:41 INFO - PROCESS | 4140 | 18:00:41 INFO - PROCESS | 4140 | [#5] yui.html Cycles:180 Average:13911.72 Median:600.61 stddev:18011.36 (2998.8%) stddev-sans-first:18034.07 18:00:41 INFO - PROCESS | 4140 | Values: 581.7 582.2 613.2 639.4 648.2 11541.1 12042.8 12203.3 12318.8 12832.7 11995.8 12606.9 12658.8 12739.6 12757.8 745.3 775.3 778.4 787.3 787.5 737.0 770.9 777.5 779.5 785.2 816.5 819.8 820.5 820.7 821.4 810.4 815.3 815.9 816.2 818.2 596.9 597.8 599.2 599.5 600.5 12352.1 12556.0 12556.1 12643.8 12716.3 11553.7 12125.5 12212.6 12216.5 12288.5 10295.2 10425.1 10525.5 10591.5 10612.4 3019.3 3037.9 3061.9 3129.0 3138.3 59531.4 59571.0 59604.4 59940.0 60078.0 9083.8 9124.2 9268.8 9322.9 9666.8 15328.5 15508.4 15555.5 16167.0 16193.5 5946.0 5961.7 5964.6 6016.7 6119.9 3173.1 3191.4 3321.0 3336.1 3441.6 2939.0 2990.1 2999.3 3017.2 3038.0 498.5 500.0 503.9 504.1 506.6 588.4 612.6 615.6 620.9 631.3 8302.3 8345.0 8378.4 8472.6 8480.4 600.7 627.0 627.9 628.1 629.5 3740.8 3748.1 3851.8 3864.0 3916.8 61329.7 61763.4 62454.0 62851.4 65615.7 55338.7 56415.0 59000.0 59355.1 61120.0 44994.3 50396.0 51666.0 52855.7 54463.7 7237.3 7483.0 7563.2 7661.5 7686.3 34902.3 35572.6 35658.8 35945.6 36597.6 43427.3 43719.0 43731.3 43765.2 46069.0 9188.5 9477.7 9569.0 9674.5 9686.3 9532.6 9788.7 9897.7 9944.0 10006.4 9290.9 9440.0 9454.1 9516.7 9932.1 9792.9 9833.8 9986.0 9999.9 10084.0 9090.4 9147.6 9176.2 9327.6 9733.8 7626.9 7823.2 8107.6 8117.1 8117.5 6899.8 6933.5 6991.2 7131.2 7244.0 18:00:41 INFO - PROCESS | 4140 | -------- Summary: end -------- 18:00:41 INFO - PROCESS | 4140 | 18:00:42 INFO - TEST-INFO | 4140: exit 0 18:00:42 INFO - TEST-OK | dromaeo_css | took 1121422ms 18:00:42 INFO - TEST-START | kraken 18:00:42 INFO - operating with platform_type : linux_ 18:00:42 INFO - Initialising browser for kraken test... 18:00:42 INFO - TEST-INFO | started process 4488 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5QOJem/profile http://localhost:48857/getInfo.html) 18:00:47 INFO - PROCESS | 4488 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 18:00:47 INFO - PROCESS | 4488 | __metrics Screen width/height:1600/1200 18:00:47 INFO - PROCESS | 4488 | colorDepth:24 18:00:47 INFO - PROCESS | 4488 | Browser inner width/height: 1024/697 18:00:47 INFO - PROCESS | 4488 | __metrics 18:00:48 INFO - PROCESS | 4488 | 1486260048236 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < permitUnload@remote-browser.xml:353:13 < CanCloseWindow@browser.js:6303:36 < canClose@browser.js:5169:12 < forceQuit@jar:file:///tmp/tmp5QOJem/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmp5QOJem/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmp5QOJem/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmp5QOJem/profile/extensions/talos-powers@TalosPowersService.js:55:9 18:00:48 ERROR - PROCESS | 4488 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 18:00:49 INFO - TEST-INFO | 4488: exit 0 18:00:49 INFO - Browser initialized. 18:00:49 INFO - Running cycle 1/1 for kraken test... 18:00:49 INFO - TEST-INFO | started process 4607 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5QOJem/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:01:01 INFO - PROCESS | 4607 | RSS: Main: 159748096 18:01:01 INFO - PROCESS | 4607 | 18:01:04 INFO - PROCESS | 4607 | Cycle 1(1): loaded http://localhost:48857/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48857/tests/kraken/driver.html?testName=audio-beat-detection) 18:01:05 INFO - PROCESS | 4607 | RSS: Main: 166240256 18:01:05 INFO - PROCESS | 4607 | 18:01:08 INFO - PROCESS | 4607 | Cycle 1(1): loaded http://localhost:48857/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48857/tests/kraken/driver.html?testName=audio-dft) 18:01:09 INFO - PROCESS | 4607 | RSS: Main: 165289984 18:01:09 INFO - PROCESS | 4607 | 18:01:12 INFO - PROCESS | 4607 | Cycle 1(1): loaded http://localhost:48857/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48857/tests/kraken/driver.html?testName=audio-fft) 18:01:12 INFO - PROCESS | 4607 | RSS: Main: 161677312 18:01:12 INFO - PROCESS | 4607 | 18:01:14 INFO - PROCESS | 4607 | Cycle 1(1): loaded http://localhost:48857/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48857/tests/kraken/driver.html?testName=audio-oscillator) 18:01:15 INFO - PROCESS | 4607 | RSS: Main: 162709504 18:01:15 INFO - PROCESS | 4607 | 18:01:17 INFO - PROCESS | 4607 | Cycle 1(1): loaded http://localhost:48857/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48857/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:01:18 INFO - PROCESS | 4607 | RSS: Main: 162672640 18:01:18 INFO - PROCESS | 4607 | 18:01:21 INFO - PROCESS | 4607 | Cycle 1(1): loaded http://localhost:48857/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48857/tests/kraken/driver.html?testName=imaging-darkroom) 18:01:22 INFO - PROCESS | 4607 | RSS: Main: 167489536 18:01:22 INFO - PROCESS | 4607 | 18:01:25 INFO - PROCESS | 4607 | Cycle 1(1): loaded http://localhost:48857/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48857/tests/kraken/driver.html?testName=imaging-desaturate) 18:01:26 INFO - PROCESS | 4607 | RSS: Main: 163786752 18:01:26 INFO - PROCESS | 4607 | 18:01:29 INFO - PROCESS | 4607 | Cycle 1(1): loaded http://localhost:48857/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48857/tests/kraken/driver.html?testName=json-parse-financial) 18:01:29 INFO - PROCESS | 4607 | RSS: Main: 165203968 18:01:29 INFO - PROCESS | 4607 | 18:01:31 INFO - PROCESS | 4607 | Cycle 1(1): loaded http://localhost:48857/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48857/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:01:32 INFO - PROCESS | 4607 | RSS: Main: 165023744 18:01:32 INFO - PROCESS | 4607 | 18:01:34 INFO - PROCESS | 4607 | Cycle 1(1): loaded http://localhost:48857/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48857/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:01:34 INFO - PROCESS | 4607 | RSS: Main: 165269504 18:01:34 INFO - PROCESS | 4607 | 18:01:37 INFO - PROCESS | 4607 | Cycle 1(1): loaded http://localhost:48857/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48857/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:01:37 INFO - PROCESS | 4607 | RSS: Main: 165908480 18:01:37 INFO - PROCESS | 4607 | 18:01:40 INFO - PROCESS | 4607 | Cycle 1(1): loaded http://localhost:48857/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48857/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:01:41 INFO - PROCESS | 4607 | RSS: Main: 166649856 18:01:41 INFO - PROCESS | 4607 | 18:01:44 INFO - PROCESS | 4607 | Cycle 1(1): loaded http://localhost:48857/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48857/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:01:45 INFO - PROCESS | 4607 | RSS: Main: 168673280 18:01:45 INFO - PROCESS | 4607 | 18:01:46 INFO - PROCESS | 4607 | Cycle 1(1): loaded http://localhost:48857/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48857/tests/kraken/driver.html?testName=ai-astar) 18:01:47 INFO - PROCESS | 4607 | RSS: Main: 172142592 18:01:47 INFO - PROCESS | 4607 | 18:01:47 INFO - PROCESS | 4607 | __start_tp_report 18:01:47 INFO - PROCESS | 4607 | _x_x_mozilla_page_load 18:01:47 INFO - PROCESS | 4607 | _x_x_mozilla_page_load_details 18:01:47 INFO - PROCESS | 4607 | |i|pagename|runs| 18:01:47 INFO - PROCESS | 4607 | |0;ai-astar;109;124;118;127;117;127;116;117;119;127 18:01:47 INFO - PROCESS | 4607 | |1;audio-beat-detection;172;129;137;185;128;127;132;135;181;128 18:01:47 INFO - PROCESS | 4607 | |2;audio-dft;165;173;176;165;163;166;163;164;171;183 18:01:47 INFO - PROCESS | 4607 | |3;audio-fft;78;76;78;117;79;78;78;80;106;77 18:01:47 INFO - PROCESS | 4607 | |4;audio-oscillator;84;84;117;93;85;84;111;85;85;106 18:01:47 INFO - PROCESS | 4607 | |5;imaging-gaussian-blur;129;118;130;120;123;118;119;118;123;119 18:01:47 INFO - PROCESS | 4607 | |6;imaging-darkroom;155;155;151;152;151;151;152;154;150;150 18:01:47 INFO - PROCESS | 4607 | |7;imaging-desaturate;98;107;96;96;102;96;106;98;103;96 18:01:47 INFO - PROCESS | 4607 | |8;json-parse-financial;68;68;66;69;67;67;66;67;68;68 18:01:47 INFO - PROCESS | 4607 | |9;json-stringify-tinderbox;67;67;67;67;67;66;66;65;72;74 18:01:47 INFO - PROCESS | 4607 | |10;stanford-crypto-aes;87;87;93;87;88;95;93;86;86;93 18:01:47 INFO - PROCESS | 4607 | |11;stanford-crypto-ccm;143;155;138;136;145;138;140;135;194;143 18:01:47 INFO - PROCESS | 4607 | |12;stanford-crypto-pbkdf2;189;182;180;183;194;203;186;177;178;192 18:01:47 INFO - PROCESS | 4607 | |13;stanford-crypto-sha256-iterative;82;70;69;77;79;68;69;70;79;70 18:01:47 INFO - PROCESS | 4607 | __end_tp_report 18:01:47 INFO - PROCESS | 4607 | __start_cc_report 18:01:47 INFO - PROCESS | 4607 | _x_x_mozilla_cycle_collect,915 18:01:47 INFO - PROCESS | 4607 | __end_cc_report 18:01:47 INFO - PROCESS | 4607 | __startTimestamp1486260107226__endTimestamp 18:01:47 INFO - PROCESS | 4607 | 18:01:47 INFO - PROCESS | 4607 | ------- Summary: start ------- 18:01:47 INFO - PROCESS | 4607 | Number of tests: 14 18:01:47 INFO - PROCESS | 4607 | 18:01:47 INFO - PROCESS | 4607 | [#0] ai-astar Cycles:10 Average:120.10 Median:121.50 stddev:5.99 (4.9%) stddev-sans-first:4.82 18:01:47 INFO - PROCESS | 4607 | Values: 109.0 124.0 118.0 127.0 117.0 127.0 116.0 117.0 119.0 127.0 18:01:47 INFO - PROCESS | 4607 | 18:01:47 INFO - PROCESS | 4607 | [#1] audio-beat-detection Cycles:10 Average:145.40 Median:136.00 stddev:23.84 (17.5%) stddev-sans-first:23.26 18:01:47 INFO - PROCESS | 4607 | Values: 172.0 129.0 137.0 185.0 128.0 127.0 132.0 135.0 181.0 128.0 18:01:47 INFO - PROCESS | 4607 | 18:01:47 INFO - PROCESS | 4607 | [#2] audio-dft Cycles:10 Average:168.90 Median:168.50 stddev:6.69 (4.0%) stddev-sans-first:6.95 18:01:47 INFO - PROCESS | 4607 | Values: 165.0 173.0 176.0 165.0 163.0 166.0 163.0 164.0 171.0 183.0 18:01:47 INFO - PROCESS | 4607 | 18:01:47 INFO - PROCESS | 4607 | [#3] audio-fft Cycles:10 Average:84.70 Median:78.00 stddev:14.40 (18.5%) stddev-sans-first:15.07 18:01:47 INFO - PROCESS | 4607 | Values: 78.0 76.0 78.0 117.0 79.0 78.0 78.0 80.0 106.0 77.0 18:01:47 INFO - PROCESS | 4607 | 18:01:47 INFO - PROCESS | 4607 | [#4] audio-oscillator Cycles:10 Average:93.40 Median:84.50 stddev:12.92 (15.3%) stddev-sans-first:13.25 18:01:47 INFO - PROCESS | 4607 | Values: 84.0 84.0 117.0 93.0 85.0 84.0 111.0 85.0 85.0 106.0 18:01:47 INFO - PROCESS | 4607 | 18:01:47 INFO - PROCESS | 4607 | [#5] imaging-gaussian-blur Cycles:10 Average:121.70 Median:121.50 stddev:4.52 (3.7%) stddev-sans-first:3.95 18:01:47 INFO - PROCESS | 4607 | Values: 129.0 118.0 130.0 120.0 123.0 118.0 119.0 118.0 123.0 119.0 18:01:47 INFO - PROCESS | 4607 | 18:01:47 INFO - PROCESS | 4607 | [#6] imaging-darkroom Cycles:10 Average:152.10 Median:152.00 stddev:1.91 (1.3%) stddev-sans-first:1.72 18:01:47 INFO - PROCESS | 4607 | Values: 155.0 155.0 151.0 152.0 151.0 151.0 152.0 154.0 150.0 150.0 18:01:47 INFO - PROCESS | 4607 | 18:01:47 INFO - PROCESS | 4607 | [#7] imaging-desaturate Cycles:10 Average:99.80 Median:96.00 stddev:4.34 (4.5%) stddev-sans-first:4.56 18:01:47 INFO - PROCESS | 4607 | Values: 98.0 107.0 96.0 96.0 102.0 96.0 106.0 98.0 103.0 96.0 18:01:47 INFO - PROCESS | 4607 | 18:01:47 INFO - PROCESS | 4607 | [#8] json-parse-financial Cycles:10 Average:67.40 Median:68.00 stddev:0.97 (1.4%) stddev-sans-first:1.00 18:01:47 INFO - PROCESS | 4607 | Values: 68.0 68.0 66.0 69.0 67.0 67.0 66.0 67.0 68.0 68.0 18:01:47 INFO - PROCESS | 4607 | 18:01:47 INFO - PROCESS | 4607 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:67.00 stddev:2.86 (4.3%) stddev-sans-first:3.02 18:01:47 INFO - PROCESS | 4607 | Values: 67.0 67.0 67.0 67.0 67.0 66.0 66.0 65.0 72.0 74.0 18:01:47 INFO - PROCESS | 4607 | 18:01:47 INFO - PROCESS | 4607 | [#10] stanford-crypto-aes Cycles:10 Average:89.50 Median:90.50 stddev:3.54 (3.9%) stddev-sans-first:3.63 18:01:47 INFO - PROCESS | 4607 | Values: 87.0 87.0 93.0 87.0 88.0 95.0 93.0 86.0 86.0 93.0 18:01:47 INFO - PROCESS | 4607 | 18:01:47 INFO - PROCESS | 4607 | [#11] stanford-crypto-ccm Cycles:10 Average:146.70 Median:143.00 stddev:17.59 (12.3%) stddev-sans-first:18.60 18:01:47 INFO - PROCESS | 4607 | Values: 143.0 155.0 138.0 136.0 145.0 138.0 140.0 135.0 194.0 143.0 18:01:47 INFO - PROCESS | 4607 | 18:01:47 INFO - PROCESS | 4607 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.40 Median:187.50 stddev:8.18 (4.4%) stddev-sans-first:8.62 18:01:47 INFO - PROCESS | 4607 | Values: 189.0 182.0 180.0 183.0 194.0 203.0 186.0 177.0 178.0 192.0 18:01:47 INFO - PROCESS | 4607 | 18:01:47 INFO - PROCESS | 4607 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.30 Median:73.50 stddev:5.29 (7.2%) stddev-sans-first:4.58 18:01:47 INFO - PROCESS | 4607 | Values: 82.0 70.0 69.0 77.0 79.0 68.0 69.0 70.0 79.0 70.0 18:01:47 INFO - PROCESS | 4607 | -------- Summary: end -------- 18:01:47 INFO - PROCESS | 4607 | 18:01:48 INFO - TEST-INFO | 4607: exit 0 18:01:48 INFO - TEST-OK | kraken | took 65604ms 18:01:48 INFO - SUITE-END | took 1187s 18:01:48 INFO - Completed test suite (00:19:47) 18:01:48 INFO - javascript benchmark 18:01:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6141.654611937263, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2548.0699544666195, 2588.715241323454, 2590.6502622146004, 2611.0339174505434, 2622.4886147201305, 4534.705244159136, 4776.928346074812, 4785.18651829189, 4811.7594120294025, 4823.541763532463, 4542.409486766724, 4585.312203169527, 4615.907681846361, 4707.411573553306, 4716.10394025135, 4285.078708077771, 4354.303311470166, 4369.453818272716, 4424.690271680984, 4470.575295346936, 4109.856155034575, 4370.38814565961, 4475.888102797439, 4488.932666009996, 4505.752183629916, 4156.958430415718, 4452.0873220989615, 4459.910801783963, 4507.954920450787, 4508.526604706508, 4244.745315281093, 4249.660027197817, 4256.531781504032, 4299.677524185668, 4314.1371725655, 4312.762798046107, 4327.221100201962, 4333.783310834478, 4360.280553708634, 4369.3227549729845, 4602.746848923308, 4629.768511574408, 4652.185867473178, 4662.673612847102, 4670.859874203746, 4770.403699537558, 4846.151923413424, 4962.8759281018265, 4964.528369804862, 5002.574781143607, 5089.465606111342, 5130.563902068328, 5132.897342053176, 5182.533571978503, 5183.974080129575, 4781.617470602343, 4789.233722604366, 4789.688670236424, 4802.063597598435, 4846.442659094249, 4942.975285123552, 5016.347874776328, 5244.580433565306, 5247.790088396498, 5290.550303224192, 4944.554990050912, 5018.84943451697, 5032.84901452957, 5040.2691609716385, 5069.087564238399, 5067.771950262247, 5114.616403769732, 5121.974390128025, 5133.820316288912, 5186.92219616706, 4762.761861906891, 5074.2895994560795, 5088.109580823341, 5104.821331253463, 5165.14775062118, 4807.831725889647, 4823.734694591831, 4855.927161092586, 4876.049170411736, 4877.317175595419, 4151.56408577095, 4158.272302347077, 4162.521310049323, 4166.041810383568, 4166.250074986531, 3660.5058317127377, 3661.7802931824176, 3672.8347224374966, 3696.9445458318146, 3717.8141092945784, 4384.7369157850635, 4405.845795397146, 4412.911741765147, 4439.800208990603, 4454.955450445454, 4970.353853998957, 5082.74586270685, 5091.159958606862, 5101.336826212569, 5139.665921715076, 4241.809118589671, 4272.6154646082, 4331.631811296075, 4392.538783427758, 4396.60430561251, 4501.954980450154, 4577.3362862384765, 4588.931166032512, 4622.098690755338, 4627.120847039052, 4764.833230836974, 4767.880802979815, 4773.284007398918, 4783.330333753347, 4809.567138957371, 4849.127157111613, 4867.367242258625, 4973.378327709036, 5088.949110508847, 5124.666896651705, 4630.166570017294, 4657.138429390574, 4666.160091183619, 4685.461171965131, 4703.647226457961, 4906.846890980688, 4911.336969509213, 4912.828051018198, 4925.507449255189, 4953.72754498506, 4810.975945120252, 4862.610991120772, 4911.926321105115, 4933.55597996182, 4974.204127339608, 4602.194615942263, 4630.166570017429, 4670.766461676971, 4684.0866031123605, 4726.10204061241, 4642.257238841769, 4664.370310008241, 4683.1336202802595, 4687.015726697432, 4720.905581888274, 4494.528074552125, 4669.322948172428, 4702.694324868872, 4738.7867545959825, 4744.833930812405, 4813.590844778093, 4834.0, 4852.927206091841, 4856.68431551948, 4868.805247790048, 4722.244440889442, 4789.4971028041555, 4816.8554943350355, 4852.951470485391, 4872.074305881871], "value": 4593.752450752254, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [461.50157829544094, 472.709283790469, 486.84177642266263, 514.6448950224345, 515.1860061103456, 36650.26699466012, 38066.42900356493, 38105.80947095264, 41063.589364106425, 41201.381979270336, 37958.24083518328, 38450.230995380145, 38484.42273365895, 38491.80754096233, 38527.42208866862, 7384.298491643312, 7668.156502784689, 7669.578173200472, 8993.0, 9315.068493150698, 8934.106589341047, 9148.268138548934, 9148.359614826932, 9150.901891772997, 9170.49562274078, 9006.054364291753, 9155.95422022889, 9231.492267925261, 9231.753713248692, 9241.122093401149, 9031.27749780016, 9126.402879496061, 9139.177474027369, 9145.908540914572, 9146.405483643575, 9090.454572725657, 9205.0, 9214.170724634749, 9253.72238832836, 9317.928438229555, 31724.682753172405, 32047.51928721071, 32098.679013209803, 32179.19552011195, 32202.83898580492, 3345.565076540034, 3418.435958066916, 3429.8274096460673, 3480.077779388464, 3505.474178873164, 24384.756152438604, 24577.631335529983, 24763.752362476323, 24774.380640483952, 25531.0, 3308.387948229561, 3328.151321413048, 3345.2974875276223, 3367.663233676613, 3425.6403077676982, 240534.0, 240781.0, 240886.0, 243111.0, 243137.0, 39301.60698393037, 40350.59649403527, 40592.797036015225, 45946.5405345949, 46508.7674561625, 47063.0, 47442.76278618654, 47565.76217118892, 47585.76207118942, 47698.0, 11259.831102533468, 11477.253978491372, 11482.253653512495, 11500.712482187844, 11524.88475115255, 8571.185737354941, 8606.096359882247, 8652.178043085896, 8710.433821801562, 8727.476351418809, 15387.230638468032, 15396.230188490754, 15442.227888605525, 15476.535703928676, 15650.295736691876, 6229.53278504114, 6297.71755206464, 6329.2721337045905, 6493.51298652603, 6509.414152726277, 768.2202564397141, 769.9923000770033, 771.733751855609, 782.3428320210936, 795.6697970342359, 25387.36531586725, 25935.870320648275, 26534.785818319713, 26942.32644183911, 26968.460630787667, 878.767126711422, 902.4991129922824, 926.2451102351562, 960.5149399553181, 1065.7708592652616, 12750.61748147557, 12814.871851281368, 12872.742545149045, 13030.674233144058, 13034.348282586023, 371267.0, 372916.0, 374918.0, 375233.0, 377009.0, 40607.7969610156, 40622.59377406247, 40693.0, 40709.389359159046, 40987.7950610251, 1121.7980763462492, 1137.5336112194127, 1194.3192380343294, 1194.4266751959108, 1200.3098218524208, 22156.88921555382, 22264.666030009237, 23693.289201323987, 23843.761562384156, 23913.52172956566, 34593.65406346005, 34998.30003399867, 35262.294754105285, 35329.0, 35329.29341413106, 331970.0, 337375.0, 337632.0, 337688.0, 339192.0, 22530.5493890118, 22952.245730512444, 23767.52464950726, 23919.282421527383, 25088.874555627106, 34699.4795078069, 34760.304793904485, 35419.46870796889, 35436.29127417489, 35917.64082359143, 30007.249818754706, 30455.0, 30718.539221911244, 31142.53286200754, 31179.68820311768, 29556.704432955394, 29688.406231875673, 30086.24784380408, 30512.84743576268, 30805.845970770002, 29809.403811924072, 30640.540391894585, 30867.536986944764, 30889.536656949713, 30943.0, 26461.33846653849, 26985.0, 27718.722812771615, 27868.16395508138, 28230.0, 21347.0, 21464.46338841479, 21888.0, 21903.561928761017, 22320.77679223187], "value": 16162.429796146107, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.1121779684265, 376.64595280436396, 378.6232698465027, 389.84795929587483, 400.17164469548027, 16436.178191090457, 16770.83229167708, 17344.0, 17361.82638173618, 17498.912505437485, 10853.186011049163, 16937.3225070997, 17447.12764361783, 17763.733543996852, 17884.64230715385, 4494.550544945504, 4725.456572494156, 4734.26618874075, 4739.194336962707, 4744.217204161309, 4617.399738034051, 4733.455652599943, 5156.123459011977, 5458.153986132136, 5461.453854614547, 5481.945180548183, 5553.278073850393, 5554.555635549166, 5555.972220138894, 5562.916556251659, 5497.175423686439, 5564.972175139119, 5929.318128415244, 5986.8503287417725, 5996.820095397145, 5349.384820745586, 5351.384590772072, 5359.035373632744, 5372.898555796052, 5375.865603359908, 11984.460699268553, 12008.579699710468, 12078.21491603043, 12124.515019399214, 12129.393530323448, 2083.2812679625504, 2089.0, 2158.589867925105, 2190.8904554772357, 2196.5277465344866, 9124.270058395312, 9262.305327100494, 9274.118958698913, 9286.860697089549, 9816.509174541245, 1611.5165450364962, 1634.618747158649, 1664.6254592716664, 1672.9749053764203, 1681.697294486992, 77175.0, 78449.3898061735, 78851.0, 81557.0, 82443.58778206131, 9895.505224738734, 10446.0, 10497.26519143668, 10595.311304765166, 10939.812037592514, 13345.532906348231, 13494.325283735774, 13522.661933451742, 13523.932380338232, 13726.245056521988, 6529.902051469232, 6670.433013193933, 6766.932330676728, 6772.255051944282, 6845.931540684529, 6166.290876549254, 6239.937600623935, 6318.936810631927, 6350.110984462179, 6360.554761166766, 4220.303649897733, 4295.656347492193, 4333.5016473106, 4415.802580714889, 4529.84145554904, 1818.8272114149136, 1913.3781521005728, 1913.885166889991, 1927.296536764071, 1955.9413217603494, 737.2380011771869, 752.6199269368933, 781.8709912864314, 791.5409062743595, 794.031281836159, 16468.588285292724, 16883.577910552336, 17297.221625026905, 17340.219690113976, 17537.0, 778.2062296457582, 784.3568274015366, 785.5483097219122, 788.3062904643991, 790.1940021178366, 9378.85931711025, 9824.45965471906, 9880.505974701236, 9894.653687120915, 10028.398296102258, 324532.0, 330819.0, 331593.0, 494309.0, 501186.0, 91945.0, 95777.0, 96347.0, 97536.51231743938, 101195.49402252941, 937.9437233765996, 950.4867371619387, 981.4798156976814, 987.4322264697971, 996.3075662414698, 15774.60563485876, 16149.75775363394, 16218.432354867524, 16592.917035414746, 16692.666146676755, 40041.0, 40297.798511008434, 40413.393799092446, 40447.0, 40547.59452405556, 57691.423085768605, 58186.4181358181, 58855.411445884994, 59312.703436482545, 59398.0, 7479.738209162871, 7749.496282741604, 7831.177726338652, 7975.401844861774, 8137.023557173177, 8635.913640863762, 8686.522241276538, 8702.521361325187, 9285.164335209864, 12133.393330333625, 7939.483933544301, 8126.984126984127, 8239.588020599065, 8291.212334828182, 8326.666933322842, 7883.763487095396, 7974.242446967529, 8132.227438393344, 8256.463329883538, 8344.415890887822, 8225.629846657035, 8249.711260105867, 8339.833203335778, 8391.244787968868, 8719.302455803647, 12601.18092323996, 12636.494540218657, 12671.619851404472, 12727.427265773247, 12751.489940402651, 11930.821037684615, 12023.398830058637, 12051.096167787626, 12135.878641213829, 12453.25280483174], "value": 8152.444254725722, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1286.665466978586, 1299.3892870350937, 1302.5506200360876, 1306.1314226039683, 1315.480385247827, 7342.632868356574, 7386.630668466575, 7614.73348432805, 7770.8445831083345, 7774.37804975602, 7422.18355980843, 7543.735969241077, 7551.131619863717, 7551.471397002212, 7593.962030189855, 2101.0860275780046, 2120.9893950530227, 2131.328631481086, 2135.049902793258, 2137.3908436095717, 2054.7534295884516, 2093.9895300523553, 2106.136484041543, 2112.13402504973, 2115.333669893986, 2052.343250159942, 2071.989640051798, 2093.1418118571387, 2102.1696429910176, 2103.3374487036535, 2044.4786579422228, 2058.0, 2068.420842164189, 2069.1206237349143, 2070.4099331690395, 1742.3204950069482, 1803.9458816235533, 2000.6298834715624, 2039.1333683184735, 2108.9050992705365, 7223.89164162538, 7534.133574638932, 7562.810929726746, 7725.729599463992, 7748.6900523978975, 4506.053728716974, 4683.625309975194, 4692.81228750853, 4699.600533954618, 4712.575868171847, 2804.9902035267287, 2814.521531339677, 2817.760490358322, 2898.884044638212, 2906.8401237931907, 1063.1919740996898, 1083.285031878964, 1120.3278033180109, 1122.5341483284428, 1148.3683973814368, 10203.489825508768, 10205.948970255102, 10240.692779216635, 10314.79370412595, 10315.742106447324, 3727.6645101940953, 3886.3393223152134, 3946.565877753445, 3959.089409435788, 3972.6226008529143, 8207.343412526983, 8224.218699223564, 8251.33989280856, 8255.917440825515, 8277.130901255281, 4513.300438432048, 4513.864584062483, 4518.367428560005, 4518.728876267434, 4531.864044078683, 4001.7198796083994, 4034.959650403517, 4247.065645557972, 4261.083866968616, 4262.23279809631, 3323.5014747788027, 3358.7984720916825, 3366.2762506061313, 3428.7599868009, 3433.5879694436826, 1013.5996281468779, 1015.9847602285971, 1016.1616666250374, 1022.4989755019986, 1025.108155904353, 722.37514549915, 744.4639859301294, 756.3684323589754, 765.1812560560147, 777.5917643237345, 4682.1338052460405, 4773.809047638125, 4796.0, 5057.089723849669, 5185.948140518546, 843.4433274039227, 865.7619154732373, 892.2727976698969, 903.8644203369547, 905.4431524612316, 3147.464930961742, 3241.2221066944235, 3246.366958443128, 3342.2647017656077, 3394.6605339465855, 8530.70142545008, 8854.29165666745, 8896.733098007071, 8914.821703565893, 9210.217131543759, 8995.415298005608, 9147.679831205876, 9207.539623018822, 9212.63149474027, 9230.400023998553, 6755.695993680296, 7008.26413226614, 7092.943046516556, 7250.637468126678, 7267.4549408794555, 4735.12400205963, 4763.833265835818, 5056.089903817348, 5070.645054846125, 5129.281900533853, 7867.213278672316, 8303.211194936472, 8456.957715211385, 8479.19447652472, 8534.658613655385, 8448.662053518035, 8542.487450752975, 8577.313814894918, 8640.56797160127, 8653.0, 6478.4169424752, 6675.766348177791, 6682.599044057372, 6694.765683201064, 6694.765683201064, 7067.893981590178, 7079.1505019398, 7114.964425177841, 7290.05229320185, 7324.926750732425, 6567.0, 6820.624865632438, 6823.0, 6831.658417079226, 6848.246692863681, 6747.696353664195, 6800.489963252677, 6868.553544019623, 6903.93096069053, 6979.162500499972, 5524.8342549723575, 5556.611037227355, 5588.972055139699, 5601.719914004365, 5614.747336369792, 4294.947737804133, 4395.7362558246605, 4457.576530229623, 4471.8434854779925, 4480.9103817924115, 4338.52276249606, 4361.869143925687, 4453.844115455943, 4470.351798989193, 4473.105378924293], "value": 3964.9733066201784, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.99336013279736, 334.6954271612832, 338.71717116207964, 340.319361277445, 340.6100015482273, 4860.416749990001, 4888.291197776325, 4888.340074089997, 4898.216285394337, 4966.343006491518, 4758.405199350082, 4805.0, 4837.5646191842725, 4907.582855457282, 4933.703977761337, 3634.109643137435, 3767.472553842464, 3767.7550959187565, 3807.7524960877454, 3825.7321987460887, 3736.8878933632036, 3752.9061773455746, 3786.7503723771088, 3802.6500592289754, 3815.7138214633874, 3697.8151092445405, 3776.3580191367532, 3781.0925377909243, 3816.313063648542, 3824.5984171661994, 3615.783053016801, 3709.6290370962956, 3710.8515659373593, 3782.3002744492355, 3808.409696497047, 3242.4325742994884, 3244.8864289749745, 3268.5750852389037, 3280.2127489402374, 3305.3389322135667, 4710.199266124767, 4757.976210118962, 4758.857234282977, 4766.833160839388, 4783.330333753277, 4178.289690752549, 4233.407322974786, 4255.936160957588, 4289.0, 4298.26929421999, 4863.176308884168, 5093.974530127326, 5111.974440127813, 5120.795168193268, 5162.277281180638, 3518.9120271993147, 3551.928961420783, 3580.856765729368, 3581.6239294874185, 3585.2470981093743, 5168.948310516885, 5302.2311764793885, 5331.546818520431, 5425.864353391197, 5443.374011988632, 3859.8842034739005, 3885.1841113365945, 3915.2365288768415, 3919.5492518360184, 3969.8809035728973, 3936.4292177634084, 3966.861159859391, 3981.5222173339384, 3995.300822356134, 4004.4593979812935, 4436.933445998313, 4444.177827101932, 4444.200043992112, 4447.844325448658, 4473.763118440779, 4976.975115124401, 5142.87142821425, 5156.92264616031, 5181.45070626622, 5191.480851914854, 1294.7863602505481, 1333.306680526121, 1335.6861137632648, 1336.6992426703914, 1346.7104572516955, 877.2236570635034, 958.4488918871676, 958.9020571445795, 960.1900417712662, 964.6334392930642, 4279.529251782302, 4283.30809330319, 4329.653627709776, 4335.176316499855, 4360.8909777255185, 5017.222330538772, 5029.622778291643, 5094.61790365724, 5195.610329225323, 5228.503292187236, 4156.646685031807, 4250.512320687734, 4288.592583704543, 4352.260115780325, 4425.756583387944, 2618.698849632279, 2646.4177880866177, 2679.4507126039116, 2719.360950176707, 2738.6713594368803, 4711.505291944365, 4729.62163026957, 4738.573528382393, 4758.333833263346, 4788.712677239377, 5092.439831618593, 5145.093022442308, 5147.716875571879, 5161.896762064813, 5208.401033881077, 4819.819144309667, 4922.827701030446, 4930.827421040318, 4949.480304567968, 4982.352294201731, 5227.503387178212, 5257.132573125392, 5291.7618707159045, 5373.005993891143, 5405.702686352289, 4877.878053048702, 5070.645054846273, 5147.433782283871, 5209.322788037531, 5249.480249480194, 4643.930341044955, 4800.3279540865005, 4861.586765125004, 4961.305417241517, 4979.402471703419, 3648.543932008499, 3663.413853783382, 3667.449882517644, 3670.302642497917, 3683.9631603684693, 5111.258867464271, 5150.9742451289, 5183.844484665466, 5210.713410762444, 5216.37403511581, 4766.880827979328, 4848.12733707936, 4921.212605983169, 4957.652964292609, 5005.849824505271, 4920.286558449076, 4930.778114984762, 4934.457209707001, 4935.087008903364, 4948.703077815343, 4972.453030166751, 5011.596752909046, 5013.949860501494, 5019.548240658358, 5073.720945348041, 4786.0, 5004.0, 5057.443681194992, 5077.974610126926, 5128.538431541179, 4880.170371036861, 4974.651774375759, 5000.2499625056535, 5022.518357084742, 5032.955062187324], "value": 3836.854190917718, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.7004242814949, 582.199475720884, 613.2028363127934, 639.3798015924555, 648.1573953859983, 11541.134414918883, 12042.819357709619, 12203.26780393177, 12318.81521777173, 12832.743345133114, 11995.820062699066, 12606.93696531516, 12658.81011784824, 12739.61781146567, 12757.808632870514, 745.258467824514, 775.2867362026949, 778.4395235430482, 787.2639082457891, 787.5117427195147, 736.9594672293022, 770.9190534993801, 777.5334799120538, 779.5089093870854, 785.2030189357806, 816.4529765057396, 819.8073452738602, 820.4543978254453, 820.6799348254185, 821.4167940762036, 810.4084018666348, 815.339574944297, 815.9388045896522, 816.2408959667507, 818.2472125644422, 596.931352894414, 597.7608956417424, 599.1821164110958, 599.5443462968176, 600.5315853634172, 12352.135350525466, 12556.0, 12556.121071524996, 12643.810342844772, 12716.300603466805, 11553.711157221052, 12125.454354554066, 12212.633620991295, 12216.511339546407, 12288.508459661603, 10295.227857910686, 10425.113865321457, 10525.526351314209, 10591.470426478645, 10612.416317102556, 3019.290466740314, 3037.893673721409, 3061.8928337508305, 3129.04564107947, 3138.2625083105454, 59531.40468595302, 59571.0, 59604.40395596032, 59940.0, 60078.0, 9083.772905677279, 9124.178823905748, 9268.814623707489, 9322.86015709765, 9666.806663866684, 15328.463503777315, 15508.379664813507, 15555.533333999998, 16167.0, 16193.514194574182, 5946.0, 5961.731722072517, 5964.582479226499, 6016.729247183887, 6119.938800611937, 3173.1273899677312, 3191.3617276544783, 3320.966790332114, 3336.1492819330915, 3441.5698037745283, 2939.0, 2990.1029691092585, 2999.2651800309063, 3017.1551965449707, 3037.9544306835414, 498.5288901987587, 499.98500044998707, 503.8866255092575, 504.1203100589495, 506.5668853130594, 588.4027711872453, 612.6109920200705, 615.6183166436838, 620.8882401167742, 631.26457676806, 8302.294304984023, 8344.958275208584, 8378.371622128365, 8472.618732156945, 8480.406371553932, 600.687642425936, 626.9811905642838, 627.8744251149789, 628.1331762168179, 629.4586655476287, 3740.8490118182153, 3748.11919198988, 3851.826667799956, 3864.0, 3916.804159791999, 61329.69335153296, 61763.38236617666, 62454.0, 62851.37148628547, 65615.67192164008, 55338.72330638402, 56415.0, 59000.0, 59355.109673354935, 61120.0, 44994.325085123746, 50396.0, 51666.0, 52855.73572132115, 54463.727681362136, 7237.3486386225495, 7483.027206463125, 7563.243675632392, 7661.502002369828, 7686.346660533917, 34902.30195396027, 35572.644273556936, 35658.82170589131, 35945.64054359423, 36597.634023659426, 43427.34858977181, 43719.0, 43731.34402983894, 43765.15526490768, 46069.0, 9188.540572971458, 9477.668281610111, 9568.952155239458, 9674.516274186404, 9686.321957463191, 9532.618695252113, 9788.657396991071, 9897.703068907944, 9944.0, 10006.44964526958, 9290.907090929275, 9439.952800235955, 9454.05459454049, 9516.6643480335, 9932.056454636799, 9792.902070979198, 9833.792250289454, 9985.950070249603, 9999.900000999896, 10084.0, 9090.363674542983, 9147.588358524015, 9176.220021298264, 9327.626894924399, 9733.756656083655, 7626.923730762844, 7823.217678232131, 8107.635156417858, 8117.147699491468, 8117.472364296302, 6899.793006209822, 6933.514653974174, 6991.165011249423, 7131.215566287808, 7244.0], "value": 5827.564088854051, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1617.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 124.0, 118.0, 127.0, 117.0, 127.0, 116.0, 117.0, 119.0, 127.0], "value": 120.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 129.0, 137.0, 185.0, 128.0, 127.0, 132.0, 135.0, 181.0, 128.0], "value": 145.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 173.0, 176.0, 165.0, 163.0, 166.0, 163.0, 164.0, 171.0, 183.0], "value": 168.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 78.0, 117.0, 79.0, 78.0, 78.0, 80.0, 106.0, 77.0], "value": 84.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 117.0, 93.0, 85.0, 84.0, 111.0, 85.0, 85.0, 106.0], "value": 93.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 118.0, 130.0, 120.0, 123.0, 118.0, 119.0, 118.0, 123.0, 119.0], "value": 121.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 155.0, 151.0, 152.0, 151.0, 151.0, 152.0, 154.0, 150.0, 150.0], "value": 152.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 107.0, 96.0, 96.0, 102.0, 96.0, 106.0, 98.0, 103.0, 96.0], "value": 99.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 66.0, 69.0, 67.0, 67.0, 66.0, 67.0, 68.0, 68.0], "value": 67.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 66.0, 66.0, 65.0, 72.0, 74.0], "value": 67.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 93.0, 87.0, 88.0, 95.0, 93.0, 86.0, 86.0, 93.0], "value": 89.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 155.0, 138.0, 136.0, 145.0, 138.0, 140.0, 135.0, 194.0, 143.0], "value": 146.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 182.0, 180.0, 183.0, 194.0, 203.0, 186.0, 177.0, 178.0, 192.0], "value": 186.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 70.0, 69.0, 77.0, 79.0, 68.0, 69.0, 70.0, 79.0, 70.0], "value": 73.3, "unit": "score"}]}]} 18:01:48 INFO - Return code: 0 18:01:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:01:49 ERROR - # TBPL SUCCESS # 18:01:49 INFO - Running post-action listener: _resource_record_post_action 18:01:49 INFO - [mozharness: 2017-02-05 02:01:49.031129Z] Finished run-tests step (success) 18:01:49 INFO - Running post-run listener: _resource_record_post_run 18:01:49 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 405061632; Read time: 8; Write time: 393296 18:01:49 INFO - TinderboxPrint: CPU usage
13.5% 18:01:49 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 18:01:49 INFO - TinderboxPrint: I/O write bytes / time
405,061,632 / 393,296 18:01:49 INFO - TinderboxPrint: CPU idle
8,313.5 (86.5%) 18:01:49 INFO - TinderboxPrint: CPU user
1,233.4 (12.8%) 18:01:49 INFO - TinderboxPrint: Swap in / out
0 / 0 18:01:49 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 99799040; Read time: 0; Write time: 136108 18:01:49 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 293097472; Read time: 0; Write time: 252844 18:01:49 INFO - Running post-run listener: _upload_blobber_files 18:01:49 INFO - Blob upload gear active. 18:01:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:01:49 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 18:01:49 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'] 18:01:49 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 18:01:50 INFO - (blobuploader) - INFO - Open directory for files ... 18:01:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:01:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:01:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:01:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:01:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:01:50 INFO - (blobuploader) - INFO - Done attempting. 18:01:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:01:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:01:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:01:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:01:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:01:51 INFO - (blobuploader) - INFO - Done attempting. 18:01:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:01:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:01:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:01:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:01:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:01:54 INFO - (blobuploader) - INFO - Done attempting. 18:01:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:01:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:01:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:01:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:01:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:01:55 INFO - (blobuploader) - INFO - Done attempting. 18:01:55 INFO - (blobuploader) - INFO - Iteration through files over. 18:01:55 INFO - Return code: 0 18:01:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:01:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:01:55 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a38577ebacd927865350a40afd6244ab5976b085c0e35195122abdc3cbe3ecb5c4d51125c66ebc795927883e435a765a5bfa20dbf9729fefafe1b516d6a652ae", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/24c84b198cdce8bfde07f7908188371fe4c7a0cba40634c42abf6ec12fd4bbb191a81a45ef29ea34a9d4899dfbd63bd0a4e0fa424a6f874b5f228c3f6387cc57", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f80845236ed14e7965f0f713289a07cd2a5e1cfebbf318fac79bbf6422aba8e2373c112943f4cb8c7004ed6183464279b41f14b843a14f41889b3ba9b452c19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/584fcedd9ec09ab95b3faa630b9b2c3895ff5a3bf7c566498378083a8d894531702b9cbe1e2e8daa926cba05ae1f8eaa9e108a8f2f3a1bcc1a1025abc149b9c6"} 18:01:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:01:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:01:55 INFO - Contents: 18:01:55 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a38577ebacd927865350a40afd6244ab5976b085c0e35195122abdc3cbe3ecb5c4d51125c66ebc795927883e435a765a5bfa20dbf9729fefafe1b516d6a652ae", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/24c84b198cdce8bfde07f7908188371fe4c7a0cba40634c42abf6ec12fd4bbb191a81a45ef29ea34a9d4899dfbd63bd0a4e0fa424a6f874b5f228c3f6387cc57", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f80845236ed14e7965f0f713289a07cd2a5e1cfebbf318fac79bbf6422aba8e2373c112943f4cb8c7004ed6183464279b41f14b843a14f41889b3ba9b452c19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/584fcedd9ec09ab95b3faa630b9b2c3895ff5a3bf7c566498378083a8d894531702b9cbe1e2e8daa926cba05ae1f8eaa9e108a8f2f3a1bcc1a1025abc149b9c6"} 18:01:55 INFO - Running post-run listener: copy_logs_to_upload_dir 18:01:55 INFO - Copying logs to upload dir... 18:01:55 INFO - mkdir: /builds/slave/test/build/upload/logs 18:01:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.538678 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-02-04 18:01:53.170811) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-04 18:01:53.174553) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1486257084.675137-1044810650 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a38577ebacd927865350a40afd6244ab5976b085c0e35195122abdc3cbe3ecb5c4d51125c66ebc795927883e435a765a5bfa20dbf9729fefafe1b516d6a652ae", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/24c84b198cdce8bfde07f7908188371fe4c7a0cba40634c42abf6ec12fd4bbb191a81a45ef29ea34a9d4899dfbd63bd0a4e0fa424a6f874b5f228c3f6387cc57", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f80845236ed14e7965f0f713289a07cd2a5e1cfebbf318fac79bbf6422aba8e2373c112943f4cb8c7004ed6183464279b41f14b843a14f41889b3ba9b452c19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/584fcedd9ec09ab95b3faa630b9b2c3895ff5a3bf7c566498378083a8d894531702b9cbe1e2e8daa926cba05ae1f8eaa9e108a8f2f3a1bcc1a1025abc149b9c6"} build_url:https://queue.taskcluster.net/v1/task/dA3DHMjvS6OSbEEzgaOT1A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011212 build_url: 'https://queue.taskcluster.net/v1/task/dA3DHMjvS6OSbEEzgaOT1A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a38577ebacd927865350a40afd6244ab5976b085c0e35195122abdc3cbe3ecb5c4d51125c66ebc795927883e435a765a5bfa20dbf9729fefafe1b516d6a652ae", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/24c84b198cdce8bfde07f7908188371fe4c7a0cba40634c42abf6ec12fd4bbb191a81a45ef29ea34a9d4899dfbd63bd0a4e0fa424a6f874b5f228c3f6387cc57", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f80845236ed14e7965f0f713289a07cd2a5e1cfebbf318fac79bbf6422aba8e2373c112943f4cb8c7004ed6183464279b41f14b843a14f41889b3ba9b452c19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/584fcedd9ec09ab95b3faa630b9b2c3895ff5a3bf7c566498378083a8d894531702b9cbe1e2e8daa926cba05ae1f8eaa9e108a8f2f3a1bcc1a1025abc149b9c6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-04 18:01:53.199843) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-04 18:01:53.200188) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1486257084.675137-1044810650 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004455 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-04 18:01:53.283089) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-04 18:01:53.283394) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-04 18:01:53.283733) ========= ========= Total master_lag: 0.14 =========