builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-018 starttime: 1494280843.74 results: success (0) revision: e0955584782e6eb13bb1e7b197d3064660bb756f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-08 15:00:43.736515) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-08 15:00:43.737505) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-08 15:00:43.738181) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-08 15:00:43.754841) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 15:00:43.755571) ========= 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=62c568580acbfdaac3eec7be000001dc-1494280843.277378-2014983101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-08 15:00:43-- 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% 38.0M=0s 2017-05-08 15:00:44 (38.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128893 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 15:00:43.901106) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 15:00:43.901604) ========= 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=62c568580acbfdaac3eec7be000001dc-1494280843.277378-2014983101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014544 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 15:00:43.954762) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-08 15:00:43.955438) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e0955584782e6eb13bb1e7b197d3064660bb756f --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 e0955584782e6eb13bb1e7b197d3064660bb756f --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=62c568580acbfdaac3eec7be000001dc-1494280843.277378-2014983101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-08 15:00:44,193 truncating revision to first 12 chars 2017-05-08 15:00:44,193 Setting DEBUG logging. 2017-05-08 15:00:44,193 attempt 1/10 2017-05-08 15:00:44,193 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e0955584782e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-08 15:00:45,464 unpacking tar archive at: mozilla-central-e0955584782e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.608807 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-08 15:00:45.582547) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-08 15:00:45.583209) ========= script_repo_revision: e0955584782e6eb13bb1e7b197d3064660bb756f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-08 15:00:45.584082) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-08 15:00:45.584720) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-08 15:00:45.597168) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-05-08 15:00:45.597508) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1494280843.277378-2014983101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:00:45 INFO - MultiFileLogger online at 20170508 15:00:45 in /builds/slave/test 15:00:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:00:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:00:45 INFO - {'append_to_log': False, 15:00:45 INFO - 'base_work_dir': '/builds/slave/test', 15:00:45 INFO - 'blob_upload_branch': 'Firefox', 15:00:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:00:45 INFO - 'branch': 'Firefox', 15:00:45 INFO - 'buildbot_json_path': 'buildprops.json', 15:00:45 INFO - 'config_files': ('talos/linux_config.py',), 15:00:45 INFO - 'default_actions': ('clobber', 15:00:45 INFO - 'read-buildbot-config', 15:00:45 INFO - 'download-and-extract', 15:00:45 INFO - 'populate-webroot', 15:00:45 INFO - 'create-virtualenv', 15:00:45 INFO - 'install', 15:00:45 INFO - 'run-tests'), 15:00:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:00:45 INFO - 'download_minidump_stackwalk': True, 15:00:45 INFO - 'download_symbols': 'ondemand', 15:00:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:00:45 INFO - 'tooltool.py': '/tools/tooltool.py', 15:00:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:00:45 INFO - '/tools/misc-python/virtualenv.py')}, 15:00:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:00:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:00:45 INFO - 'gecko_profile': False, 15:00:45 INFO - 'gecko_profile_interval': 0, 15:00:45 INFO - 'installer_path': 'installer.exe', 15:00:45 INFO - 'log_level': 'info', 15:00:45 INFO - 'log_name': 'talos', 15:00:45 INFO - 'log_to_console': True, 15:00:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:00:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:00:45 INFO - 'opt_config_files': (), 15:00:45 INFO - 'pip_index': False, 15:00:45 INFO - 'suite': 'dromaeojs', 15:00:45 INFO - 'system_bits': '32', 15:00:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:00:45 INFO - 'title': 'talos-linux64-ix-018', 15:00:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:00:45 INFO - 'use_talos_json': True, 15:00:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:00:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:00:45 INFO - 'work_dir': 'build'} 15:00:45 INFO - [mozharness: 2017-05-08 22:00:45.938714Z] Running clobber step. 15:00:45 INFO - Running pre-action listener: _resource_record_pre_action 15:00:45 INFO - Running main action method: clobber 15:00:45 INFO - rmtree: /builds/slave/test/build 15:00:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:00:46 INFO - Running post-action listener: _resource_record_post_action 15:00:46 INFO - [mozharness: 2017-05-08 22:00:46.867116Z] Finished clobber step (success) 15:00:46 INFO - [mozharness: 2017-05-08 22:00:46.867217Z] Running read-buildbot-config step. 15:00:46 INFO - Running pre-action listener: _resource_record_pre_action 15:00:46 INFO - Running main action method: read_buildbot_config 15:00:46 INFO - Using buildbot properties: 15:00:46 INFO - { 15:00:46 INFO - "project": "", 15:00:46 INFO - "product": "firefox", 15:00:46 INFO - "who": "kwierso@gmail.com", 15:00:46 INFO - "installer_path": "public/build/target.tar.bz2", 15:00:46 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 15:00:46 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 15:00:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 15:00:46 INFO - "stage_platform": "linux64-pgo", 15:00:46 INFO - "basedir": "/builds/slave/test", 15:00:46 INFO - "buildnumber": 171, 15:00:46 INFO - "platform": "ubuntu64_hw", 15:00:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:00:46 INFO - "slavebuilddir": "test", 15:00:46 INFO - "taskId": "EfdYGTAcTWGAJqNtpXIsuQ", 15:00:46 INFO - "branch": "mozilla-central", 15:00:46 INFO - "script_repo_revision": "production", 15:00:46 INFO - "revision": "e0955584782e6eb13bb1e7b197d3064660bb756f", 15:00:46 INFO - "slavename": "talos-linux64-ix-018", 15:00:46 INFO - "repo_path": "mozilla-central" 15:00:46 INFO - } 15:00:46 INFO - Finding installer, test and symbols from parent task. 15:00:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EfdYGTAcTWGAJqNtpXIsuQ'}, attempt #1 15:00:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EfdYGTAcTWGAJqNtpXIsuQ'}, attempt #1 15:00:47 INFO - Task dependencies: J-SiESv6RQGICOFXUkGBcg 15:00:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J-SiESv6RQGICOFXUkGBcg'}, attempt #1 15:00:48 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/J-SiESv6RQGICOFXUkGBcg/artifacts/public/build/target.tar.bz2 15:00:48 INFO - Set test_url: https://queue.taskcluster.net/v1/task/J-SiESv6RQGICOFXUkGBcg/artifacts/public/build/test_packages.json 15:00:48 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/J-SiESv6RQGICOFXUkGBcg/artifacts/public/build/target.crashreporter-symbols.zip 15:00:48 INFO - Running post-action listener: _resource_record_post_action 15:00:48 INFO - [mozharness: 2017-05-08 22:00:48.243654Z] Finished read-buildbot-config step (success) 15:00:48 INFO - [mozharness: 2017-05-08 22:00:48.243872Z] Running download-and-extract step. 15:00:48 INFO - Running pre-action listener: _resource_record_pre_action 15:00:48 INFO - Running main action method: download_and_extract 15:00:48 INFO - mkdir: /builds/slave/test/build/tests 15:00:48 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')]} 15:00:48 INFO - trying https://queue.taskcluster.net/v1/task/J-SiESv6RQGICOFXUkGBcg/artifacts/public/build/target.test_packages.json 15:00:48 INFO - Downloading https://queue.taskcluster.net/v1/task/J-SiESv6RQGICOFXUkGBcg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:00:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J-SiESv6RQGICOFXUkGBcg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:00:48 INFO - Downloaded 986 bytes. 15:00:48 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:00:48 INFO - Using the following test package requirements: 15:00:48 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:00:48 INFO - u'common': [u'target.common.tests.zip'], 15:00:48 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:00:48 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:00:48 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:00:48 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:00:48 INFO - u'mozbase': [u'target.common.tests.zip'], 15:00:48 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:00:48 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:00:48 INFO - u'web-platform': [u'target.common.tests.zip', 15:00:48 INFO - u'target.web-platform.tests.zip'], 15:00:48 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:00:48 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:00:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J-SiESv6RQGICOFXUkGBcg/artifacts/public/build/target.common.tests.zip 15:00:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J-SiESv6RQGICOFXUkGBcg/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:00:48 INFO - Fetch https://queue.taskcluster.net/v1/task/J-SiESv6RQGICOFXUkGBcg/artifacts/public/build/target.common.tests.zip into memory 15:00:49 INFO - Content-Length response header: 60574855 15:00:49 INFO - Bytes received: 60574855 15:00:59 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:00:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J-SiESv6RQGICOFXUkGBcg/artifacts/public/build/target.common.tests.zip 15:00:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J-SiESv6RQGICOFXUkGBcg/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:00:59 INFO - Fetch https://queue.taskcluster.net/v1/task/J-SiESv6RQGICOFXUkGBcg/artifacts/public/build/target.common.tests.zip into memory 15:01:01 INFO - Content-Length response header: 60574855 15:01:01 INFO - Bytes received: 60574855 15:01:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J-SiESv6RQGICOFXUkGBcg/artifacts/public/build/target.talos.tests.zip 15:01:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J-SiESv6RQGICOFXUkGBcg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:01:11 INFO - Fetch https://queue.taskcluster.net/v1/task/J-SiESv6RQGICOFXUkGBcg/artifacts/public/build/target.talos.tests.zip into memory 15:01:12 INFO - Content-Length response header: 14409362 15:01:12 INFO - Bytes received: 14409362 15:01:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:13 INFO - trying https://queue.taskcluster.net/v1/task/J-SiESv6RQGICOFXUkGBcg/artifacts/public/build/target.tar.bz2 15:01:13 INFO - Downloading https://queue.taskcluster.net/v1/task/J-SiESv6RQGICOFXUkGBcg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:01:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J-SiESv6RQGICOFXUkGBcg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:01:14 INFO - Downloaded 64028344 bytes. 15:01:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J-SiESv6RQGICOFXUkGBcg/artifacts/public/build/target.tar.bz2 15:01:14 INFO - mkdir: /builds/slave/test/properties 15:01:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:01:14 INFO - Writing to file /builds/slave/test/properties/build_url 15:01:14 INFO - Contents: 15:01:14 INFO - build_url:https://queue.taskcluster.net/v1/task/J-SiESv6RQGICOFXUkGBcg/artifacts/public/build/target.tar.bz2 15:01:14 INFO - Running post-action listener: _resource_record_post_action 15:01:14 INFO - Running post-action listener: set_extra_try_arguments 15:01:14 INFO - [mozharness: 2017-05-08 22:01:14.167010Z] Finished download-and-extract step (success) 15:01:14 INFO - [mozharness: 2017-05-08 22:01:14.167107Z] Running populate-webroot step. 15:01:14 INFO - Running pre-action listener: _resource_record_pre_action 15:01:14 INFO - Running main action method: populate_webroot 15:01:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:01:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:01:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:01:14 INFO - '--tppagecycles', 15:01:14 INFO - '7'], 15:01:14 INFO - 'tests': ['tsvgm']}}, 15:01:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:01:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:01:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:01:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:01:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:01:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:01:14 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:01:14 INFO - 'talos_options': ['--disable-e10s'], 15:01:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:01:14 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:01:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:01:14 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:01:14 INFO - 'talos_options': ['--disable-e10s'], 15:01:14 INFO - 'tests': ['damp', 'tps']}, 15:01:14 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:01:14 INFO - 'tests': ['damp', 'tps']}, 15:01:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:01:14 INFO - 'tests': ['dromaeo_dom']}, 15:01:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:01:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:01:14 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 15:01:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:01:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:01:14 INFO - 'tests': ['a11yr', 15:01:14 INFO - 'ts_paint', 15:01:14 INFO - 'tpaint', 15:01:14 INFO - 'sessionrestore', 15:01:14 INFO - 'sessionrestore_no_auto_restore', 15:01:14 INFO - 'tabpaint']}, 15:01:14 INFO - 'other-e10s': {'tests': ['a11yr', 15:01:14 INFO - 'ts_paint', 15:01:14 INFO - 'tpaint', 15:01:14 INFO - 'sessionrestore', 15:01:14 INFO - 'sessionrestore_no_auto_restore', 15:01:14 INFO - 'tabpaint']}, 15:01:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:01:14 INFO - 'ts_paint', 15:01:14 INFO - 'tpaint', 15:01:14 INFO - 'sessionrestore', 15:01:14 INFO - 'sessionrestore_no_auto_restore', 15:01:14 INFO - 'tabpaint']}, 15:01:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:01:14 INFO - 'ts_paint', 15:01:14 INFO - 'tpaint', 15:01:14 INFO - 'sessionrestore', 15:01:14 INFO - 'sessionrestore_no_auto_restore', 15:01:14 INFO - 'tabpaint']}, 15:01:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:01:14 INFO - 'tests': ['a11yr', 15:01:14 INFO - 'ts_paint', 15:01:14 INFO - 'tpaint', 15:01:14 INFO - 'sessionrestore', 15:01:14 INFO - 'sessionrestore_no_auto_restore', 15:01:14 INFO - 'tabpaint']}, 15:01:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:01:14 INFO - 'tests': ['a11yr', 15:01:14 INFO - 'ts_paint', 15:01:14 INFO - 'tpaint', 15:01:14 INFO - 'sessionrestore', 15:01:14 INFO - 'sessionrestore_no_auto_restore', 15:01:14 INFO - 'tabpaint']}, 15:01:14 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 15:01:14 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 15:01:14 INFO - 'bloom_basic_ref']}, 15:01:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:01:14 INFO - 'tests': ['tsvgx', 15:01:14 INFO - 'tsvgr_opacity', 15:01:14 INFO - 'tart', 15:01:14 INFO - 'tscrollx', 15:01:14 INFO - 'cart', 15:01:14 INFO - 'tsvg_static']}, 15:01:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:01:14 INFO - 'tsvgr_opacity', 15:01:14 INFO - 'tart', 15:01:14 INFO - 'tscrollx', 15:01:14 INFO - 'cart', 15:01:14 INFO - 'tsvg_static']}, 15:01:14 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:01:14 INFO - 'talos_options': ['--disable-e10s'], 15:01:14 INFO - 'tests': ['tp5o']}, 15:01:14 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:01:14 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:01:14 INFO - 'talos_options': ['--disable-e10s', 15:01:14 INFO - '--xperf_path', 15:01:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:01:14 INFO - 'tests': ['tp5n']}, 15:01:14 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:01:14 INFO - 'talos_options': ['--xperf_path', 15:01:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:01:14 INFO - 'tests': ['tp5n']}}, 15:01:14 INFO - 'talos.zip': {'path': '', 15:01:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:01:14 INFO - Running post-action listener: _resource_record_post_action 15:01:14 INFO - [mozharness: 2017-05-08 22:01:14.180677Z] Finished populate-webroot step (success) 15:01:14 INFO - [mozharness: 2017-05-08 22:01:14.180766Z] Running create-virtualenv step. 15:01:14 INFO - Running pre-action listener: _resource_record_pre_action 15:01:14 INFO - Running main action method: create_virtualenv 15:01:14 INFO - Creating virtualenv /builds/slave/test/build/venv 15:01:14 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 15:01:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:01:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:01:14 INFO - Using real prefix '/usr' 15:01:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:01:14 INFO - Installing distribute.............................................................................................................................................................................................done. 15:01:16 INFO - Installing pip.................done. 15:01:16 INFO - Return code: 0 15:01:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:01:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:01:16 INFO - Reading from file tmpfile_stdout 15:01:16 INFO - Output received: 15:01:16 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) 15:01:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:01:16 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')]} 15:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:16 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')]} 15:01:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:16 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 0x10d51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1447770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1444a30>, '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 0x14457f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1445ca0>, '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': '62c568580acbfdaac3eec7be000001dc-1494280843.277378-2014983101', '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 15:01:16 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 15:01:16 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 15:01:16 INFO - Using env: {'DISPLAY': ':0', 15:01:16 INFO - 'HOME': '/home/cltbld', 15:01:16 INFO - 'LANG': 'en_US.UTF-8', 15:01:16 INFO - 'LANGUAGE': 'en_US:en', 15:01:16 INFO - 'LOGNAME': 'cltbld', 15:01:16 INFO - 'MAIL': '/var/mail/cltbld', 15:01:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:16 INFO - 'MOZ_NO_REMOTE': '1', 15:01:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:16 INFO - 'NO_EM_RESTART': '1', 15:01:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:16 INFO - 'PWD': '/builds/slave/test', 15:01:16 INFO - 'SHELL': '/bin/bash', 15:01:16 INFO - 'SHLVL': '1', 15:01:16 INFO - 'TERM': 'linux', 15:01:16 INFO - 'TMOUT': '86400', 15:01:16 INFO - 'USER': 'cltbld', 15:01:16 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1494280843.277378-2014983101', 15:01:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:16 INFO - '_': '/tools/buildbot/bin/python'} 15:01:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:17 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 15:01:17 INFO - Cleaning up... 15:01:17 INFO - Return code: 0 15:01:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:01:17 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')]} 15:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:17 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')]} 15:01:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:17 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 0x10d51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1447770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1444a30>, '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 0x14457f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1445ca0>, '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': '62c568580acbfdaac3eec7be000001dc-1494280843.277378-2014983101', '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 15:01:17 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 15:01:17 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 15:01:17 INFO - Using env: {'DISPLAY': ':0', 15:01:17 INFO - 'HOME': '/home/cltbld', 15:01:17 INFO - 'LANG': 'en_US.UTF-8', 15:01:17 INFO - 'LANGUAGE': 'en_US:en', 15:01:17 INFO - 'LOGNAME': 'cltbld', 15:01:17 INFO - 'MAIL': '/var/mail/cltbld', 15:01:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:17 INFO - 'MOZ_NO_REMOTE': '1', 15:01:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:17 INFO - 'NO_EM_RESTART': '1', 15:01:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:17 INFO - 'PWD': '/builds/slave/test', 15:01:17 INFO - 'SHELL': '/bin/bash', 15:01:17 INFO - 'SHLVL': '1', 15:01:17 INFO - 'TERM': 'linux', 15:01:17 INFO - 'TMOUT': '86400', 15:01:17 INFO - 'USER': 'cltbld', 15:01:17 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1494280843.277378-2014983101', 15:01:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:17 INFO - '_': '/tools/buildbot/bin/python'} 15:01:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:17 INFO - Downloading/unpacking psutil>=3.1.1 15:01:17 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 15:01:17 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 15:01:17 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 15:01:17 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 15:01:17 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 15:01:17 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 15:01:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:01:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:01:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:01:18 INFO - Installing collected packages: psutil 15:01:18 INFO - Running setup.py install for psutil 15:01:18 INFO - building 'psutil._psutil_linux' extension 15:01:18 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 15:01:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:01:18 INFO - building 'psutil._psutil_posix' extension 15:01:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:01:19 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 15:01:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:01:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:01:19 INFO - Successfully installed psutil 15:01:19 INFO - Cleaning up... 15:01:19 INFO - Return code: 0 15:01:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:01:19 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')]} 15:01:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:19 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')]} 15:01:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:19 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 0x10d51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1447770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1444a30>, '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 0x14457f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1445ca0>, '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': '62c568580acbfdaac3eec7be000001dc-1494280843.277378-2014983101', '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 15:01:19 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 15:01:19 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 15:01:19 INFO - Using env: {'DISPLAY': ':0', 15:01:19 INFO - 'HOME': '/home/cltbld', 15:01:19 INFO - 'LANG': 'en_US.UTF-8', 15:01:19 INFO - 'LANGUAGE': 'en_US:en', 15:01:19 INFO - 'LOGNAME': 'cltbld', 15:01:19 INFO - 'MAIL': '/var/mail/cltbld', 15:01:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:19 INFO - 'MOZ_NO_REMOTE': '1', 15:01:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:19 INFO - 'NO_EM_RESTART': '1', 15:01:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:19 INFO - 'PWD': '/builds/slave/test', 15:01:19 INFO - 'SHELL': '/bin/bash', 15:01:19 INFO - 'SHLVL': '1', 15:01:19 INFO - 'TERM': 'linux', 15:01:19 INFO - 'TMOUT': '86400', 15:01:19 INFO - 'USER': 'cltbld', 15:01:19 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1494280843.277378-2014983101', 15:01:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:19 INFO - '_': '/tools/buildbot/bin/python'} 15:01:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:01:19 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 15:01:19 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 15:01:19 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 15:01:19 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 15:01:19 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 15:01:19 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 15:01:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:01:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:01:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:01:20 INFO - Installing collected packages: mozsystemmonitor 15:01:20 INFO - Running setup.py install for mozsystemmonitor 15:01:20 INFO - Successfully installed mozsystemmonitor 15:01:20 INFO - Cleaning up... 15:01:20 INFO - Return code: 0 15:01:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:01: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')]} 15:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01: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')]} 15:01:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1447770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1444a30>, '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 0x14457f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1445ca0>, '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': '62c568580acbfdaac3eec7be000001dc-1494280843.277378-2014983101', '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 15:01:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:01:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:01:20 INFO - Using env: {'DISPLAY': ':0', 15:01:20 INFO - 'HOME': '/home/cltbld', 15:01:20 INFO - 'LANG': 'en_US.UTF-8', 15:01:20 INFO - 'LANGUAGE': 'en_US:en', 15:01:20 INFO - 'LOGNAME': 'cltbld', 15:01:20 INFO - 'MAIL': '/var/mail/cltbld', 15:01:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:20 INFO - 'MOZ_NO_REMOTE': '1', 15:01:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:20 INFO - 'NO_EM_RESTART': '1', 15:01:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:20 INFO - 'PWD': '/builds/slave/test', 15:01:20 INFO - 'SHELL': '/bin/bash', 15:01:20 INFO - 'SHLVL': '1', 15:01:20 INFO - 'TERM': 'linux', 15:01:20 INFO - 'TMOUT': '86400', 15:01:20 INFO - 'USER': 'cltbld', 15:01:20 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1494280843.277378-2014983101', 15:01:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:20 INFO - '_': '/tools/buildbot/bin/python'} 15:01:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:20 INFO - Downloading/unpacking jsonschema==2.5.1 15:01:20 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 15:01:20 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 15:01:20 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 15:01:20 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 15:01:20 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 15:01:20 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 15:01:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:01:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:01:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:23 INFO - Downloading functools32-3.2.3-2.tar.gz 15:01:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:01:23 INFO - warning: no files found matching '*.txt' 15:01:23 INFO - no previously-included directories found matching 'build' 15:01:23 INFO - no previously-included directories found matching 'dist' 15:01:23 INFO - no previously-included directories found matching '.git*' 15:01:23 INFO - Installing collected packages: jsonschema, functools32 15:01:23 INFO - Running setup.py install for functools32 15:01:23 INFO - warning: no files found matching '*.txt' 15:01:23 INFO - no previously-included directories found matching 'build' 15:01:23 INFO - no previously-included directories found matching 'dist' 15:01:23 INFO - no previously-included directories found matching '.git*' 15:01:23 INFO - Successfully installed jsonschema functools32 15:01:23 INFO - Cleaning up... 15:01:23 INFO - Return code: 0 15:01:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:01:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1447770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1444a30>, '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 0x14457f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1445ca0>, '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': '62c568580acbfdaac3eec7be000001dc-1494280843.277378-2014983101', '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 15:01:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:01:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:01:23 INFO - Using env: {'DISPLAY': ':0', 15:01:23 INFO - 'HOME': '/home/cltbld', 15:01:23 INFO - 'LANG': 'en_US.UTF-8', 15:01:23 INFO - 'LANGUAGE': 'en_US:en', 15:01:23 INFO - 'LOGNAME': 'cltbld', 15:01:23 INFO - 'MAIL': '/var/mail/cltbld', 15:01:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:23 INFO - 'MOZ_NO_REMOTE': '1', 15:01:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:23 INFO - 'NO_EM_RESTART': '1', 15:01:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:23 INFO - 'PWD': '/builds/slave/test', 15:01:23 INFO - 'SHELL': '/bin/bash', 15:01:23 INFO - 'SHLVL': '1', 15:01:23 INFO - 'TERM': 'linux', 15:01:23 INFO - 'TMOUT': '86400', 15:01:23 INFO - 'USER': 'cltbld', 15:01:23 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1494280843.277378-2014983101', 15:01:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:23 INFO - '_': '/tools/buildbot/bin/python'} 15:01:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:01:23 INFO - Cleaning up... 15:01:23 INFO - Return code: 0 15:01:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:01:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1447770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1444a30>, '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 0x14457f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1445ca0>, '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': '62c568580acbfdaac3eec7be000001dc-1494280843.277378-2014983101', '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 15:01:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:01:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:01:23 INFO - Using env: {'DISPLAY': ':0', 15:01:23 INFO - 'HOME': '/home/cltbld', 15:01:23 INFO - 'LANG': 'en_US.UTF-8', 15:01:23 INFO - 'LANGUAGE': 'en_US:en', 15:01:23 INFO - 'LOGNAME': 'cltbld', 15:01:23 INFO - 'MAIL': '/var/mail/cltbld', 15:01:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:23 INFO - 'MOZ_NO_REMOTE': '1', 15:01:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:23 INFO - 'NO_EM_RESTART': '1', 15:01:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:23 INFO - 'PWD': '/builds/slave/test', 15:01:23 INFO - 'SHELL': '/bin/bash', 15:01:23 INFO - 'SHLVL': '1', 15:01:23 INFO - 'TERM': 'linux', 15:01:23 INFO - 'TMOUT': '86400', 15:01:23 INFO - 'USER': 'cltbld', 15:01:23 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1494280843.277378-2014983101', 15:01:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:23 INFO - '_': '/tools/buildbot/bin/python'} 15:01:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:23 INFO - Downloading/unpacking blobuploader==1.2.4 15:01:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:24 INFO - Downloading blobuploader-1.2.4.tar.gz 15:01:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:01:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:01: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 15:01: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 15:01: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 15:01: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 15:01: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 15:01: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 15:01:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:01:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:01: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 15:01: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 15:01: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 15:01: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 15:01: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 15:01: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 15:01:25 INFO - Downloading docopt-0.6.1.tar.gz 15:01:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:01:25 INFO - Installing collected packages: blobuploader, requests, docopt 15:01:25 INFO - Running setup.py install for blobuploader 15:01:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:01:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:01:25 INFO - Running setup.py install for requests 15:01:26 INFO - Running setup.py install for docopt 15:01:26 INFO - Successfully installed blobuploader requests docopt 15:01:26 INFO - Cleaning up... 15:01:26 INFO - Return code: 0 15:01:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:01:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:26 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 0x10d51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1447770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1444a30>, '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 0x14457f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1445ca0>, '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': '62c568580acbfdaac3eec7be000001dc-1494280843.277378-2014983101', '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 15:01:26 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 15:01:26 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 15:01:26 INFO - Using env: {'DISPLAY': ':0', 15:01:26 INFO - 'HOME': '/home/cltbld', 15:01:26 INFO - 'LANG': 'en_US.UTF-8', 15:01:26 INFO - 'LANGUAGE': 'en_US:en', 15:01:26 INFO - 'LOGNAME': 'cltbld', 15:01:26 INFO - 'MAIL': '/var/mail/cltbld', 15:01:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:26 INFO - 'MOZ_NO_REMOTE': '1', 15:01:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:26 INFO - 'NO_EM_RESTART': '1', 15:01:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:26 INFO - 'PWD': '/builds/slave/test', 15:01:26 INFO - 'SHELL': '/bin/bash', 15:01:26 INFO - 'SHLVL': '1', 15:01:26 INFO - 'TERM': 'linux', 15:01:26 INFO - 'TMOUT': '86400', 15:01:26 INFO - 'USER': 'cltbld', 15:01:26 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1494280843.277378-2014983101', 15:01:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:26 INFO - '_': '/tools/buildbot/bin/python'} 15:01:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:01:26 INFO - Running setup.py (path:/tmp/pip-rvbogd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:01:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:01:26 INFO - Running setup.py (path:/tmp/pip-lqQw1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:01:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:01:26 INFO - Running setup.py (path:/tmp/pip-tLdcxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:01:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:01:26 INFO - Running setup.py (path:/tmp/pip-HYkJGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:01:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:01:26 INFO - Running setup.py (path:/tmp/pip-U3j7Dv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:01:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:01:26 INFO - Running setup.py (path:/tmp/pip-IJixf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:01:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:01:26 INFO - Running setup.py (path:/tmp/pip-CN7PgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:01:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:01:26 INFO - Running setup.py (path:/tmp/pip-NSsgkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:01:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:01:26 INFO - Running setup.py (path:/tmp/pip-INJcVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:01:27 INFO - Running setup.py (path:/tmp/pip-UDHxhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:01:27 INFO - Running setup.py (path:/tmp/pip-VRq5Dm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:01:27 INFO - Running setup.py (path:/tmp/pip-qzf5K4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:01:27 INFO - Running setup.py (path:/tmp/pip-2onNIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:01:27 INFO - Running setup.py (path:/tmp/pip-9SRgM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:27 INFO - Running setup.py (path:/tmp/pip-cETN6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:01:27 INFO - Running setup.py (path:/tmp/pip-XCjRoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:01:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:01:27 INFO - Running setup.py (path:/tmp/pip-gwy_Xi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:01:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:01:27 INFO - Running setup.py install for manifestparser 15:01:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:01:27 INFO - Running setup.py install for mozcrash 15:01:27 INFO - Running setup.py install for mozdebug 15:01:27 INFO - Running setup.py install for mozdevice 15:01:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:01:28 INFO - Running setup.py install for mozfile 15:01:28 INFO - Running setup.py install for mozhttpd 15:01:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:01:28 INFO - Running setup.py install for mozinfo 15:01:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:01:28 INFO - Running setup.py install for mozInstall 15:01:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:01:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:01:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:01:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:01:28 INFO - Running setup.py install for mozleak 15:01:28 INFO - Running setup.py install for mozlog 15:01:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:01:28 INFO - Running setup.py install for moznetwork 15:01:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:01:28 INFO - Running setup.py install for mozprocess 15:01:28 INFO - Running setup.py install for mozprofile 15:01:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:01:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:01:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:01:28 INFO - Running setup.py install for mozrunner 15:01:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:01:29 INFO - Running setup.py install for mozscreenshot 15:01:29 INFO - Running setup.py install for moztest 15:01:29 INFO - Running setup.py install for mozversion 15:01:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:01:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:01:29 INFO - Cleaning up... 15:01:29 INFO - Return code: 0 15:01:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:01:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:29 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 0x10d51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1447770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1444a30>, '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 0x14457f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1445ca0>, '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': '62c568580acbfdaac3eec7be000001dc-1494280843.277378-2014983101', '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 15:01:29 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 15:01:29 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 15:01:29 INFO - Using env: {'DISPLAY': ':0', 15:01:29 INFO - 'HOME': '/home/cltbld', 15:01:29 INFO - 'LANG': 'en_US.UTF-8', 15:01:29 INFO - 'LANGUAGE': 'en_US:en', 15:01:29 INFO - 'LOGNAME': 'cltbld', 15:01:29 INFO - 'MAIL': '/var/mail/cltbld', 15:01:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:29 INFO - 'MOZ_NO_REMOTE': '1', 15:01:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:29 INFO - 'NO_EM_RESTART': '1', 15:01:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:29 INFO - 'PWD': '/builds/slave/test', 15:01:29 INFO - 'SHELL': '/bin/bash', 15:01:29 INFO - 'SHLVL': '1', 15:01:29 INFO - 'TERM': 'linux', 15:01:29 INFO - 'TMOUT': '86400', 15:01:29 INFO - 'USER': 'cltbld', 15:01:29 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1494280843.277378-2014983101', 15:01:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:29 INFO - '_': '/tools/buildbot/bin/python'} 15:01:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:01:29 INFO - Running setup.py (path:/tmp/pip-RYNdul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:01:29 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)) 15:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:01:29 INFO - Running setup.py (path:/tmp/pip-bb6Skw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:01:29 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)) 15:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:01:29 INFO - Running setup.py (path:/tmp/pip-qfDp4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:01:29 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)) 15:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:01:29 INFO - Running setup.py (path:/tmp/pip-ec9RfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:01:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 15:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:01:29 INFO - Running setup.py (path:/tmp/pip-XyxE6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:01:29 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)) 15:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:01:29 INFO - Running setup.py (path:/tmp/pip-FzHy2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:01:30 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)) 15:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:01:30 INFO - Running setup.py (path:/tmp/pip-lg8Mj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:01:30 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)) 15:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:01:30 INFO - Running setup.py (path:/tmp/pip-uVYJ1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:01:30 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)) 15:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:01:30 INFO - Running setup.py (path:/tmp/pip-J0Y2Ru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:01:30 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)) 15:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:01:30 INFO - Running setup.py (path:/tmp/pip-YjDhLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:01:30 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)) 15:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:01:30 INFO - Running setup.py (path:/tmp/pip-5rCOcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:01:30 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)) 15:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:01:30 INFO - Running setup.py (path:/tmp/pip-baXQBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:01:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:01:30 INFO - Running setup.py (path:/tmp/pip-tDnMyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:01:30 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)) 15:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:01:30 INFO - Running setup.py (path:/tmp/pip-BqSV0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:01:30 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)) 15:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:30 INFO - Running setup.py (path:/tmp/pip-HmsOcZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:30 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)) 15:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:01:30 INFO - Running setup.py (path:/tmp/pip-pejAX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:01:30 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)) 15:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:01:30 INFO - Running setup.py (path:/tmp/pip-Z19mN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:01:30 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)) 15:01:30 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)) 15:01:30 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)) 15:01:30 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)) 15:01:30 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:01:30 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:01:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:01: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 15:01: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 15:01: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 15:01: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 15:01: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 15:01: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 15:01:31 INFO - Downloading blessings-1.6.tar.gz 15:01:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:01:32 INFO - Installing collected packages: blessings 15:01:32 INFO - Running setup.py install for blessings 15:01:32 INFO - Successfully installed blessings 15:01:32 INFO - Cleaning up... 15:01:32 INFO - Return code: 0 15:01:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:01:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:01:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:01:32 INFO - Reading from file tmpfile_stdout 15:01:32 INFO - Current package versions: 15:01:32 INFO - argparse == 1.2.1 15:01:32 INFO - blessings == 1.6 15:01:32 INFO - blobuploader == 1.2.4 15:01:32 INFO - docopt == 0.6.1 15:01:32 INFO - functools32 == 3.2.3-2 15:01:32 INFO - jsonschema == 2.5.1 15:01:32 INFO - manifestparser == 1.1 15:01:32 INFO - mozInstall == 1.12 15:01:32 INFO - mozcrash == 1.0 15:01:32 INFO - mozdebug == 0.1 15:01:32 INFO - mozdevice == 0.50 15:01:32 INFO - mozfile == 1.2 15:01:32 INFO - mozhttpd == 0.7 15:01:32 INFO - mozinfo == 0.9 15:01:32 INFO - mozleak == 0.1 15:01:32 INFO - mozlog == 3.4 15:01:32 INFO - moznetwork == 0.27 15:01:32 INFO - mozprocess == 0.25 15:01:32 INFO - mozprofile == 0.28 15:01:32 INFO - mozrunner == 6.13 15:01:32 INFO - mozscreenshot == 0.1 15:01:32 INFO - mozsystemmonitor == 0.3 15:01:32 INFO - moztest == 0.8 15:01:32 INFO - mozversion == 1.4 15:01:32 INFO - psutil == 3.1.1 15:01:32 INFO - requests == 1.2.3 15:01:32 INFO - wsgiref == 0.1.2 15:01:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:01:32 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')]} 15:01:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:32 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')]} 15:01:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:32 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 0x10d51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1447770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1444a30>, '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 0x14457f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1445ca0>, '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': '62c568580acbfdaac3eec7be000001dc-1494280843.277378-2014983101', '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 15:01:32 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 15:01:32 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 15:01:32 INFO - Using env: {'DISPLAY': ':0', 15:01:32 INFO - 'HOME': '/home/cltbld', 15:01:32 INFO - 'LANG': 'en_US.UTF-8', 15:01:32 INFO - 'LANGUAGE': 'en_US:en', 15:01:32 INFO - 'LOGNAME': 'cltbld', 15:01:32 INFO - 'MAIL': '/var/mail/cltbld', 15:01:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:32 INFO - 'MOZ_NO_REMOTE': '1', 15:01:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:32 INFO - 'NO_EM_RESTART': '1', 15:01:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:32 INFO - 'PWD': '/builds/slave/test', 15:01:32 INFO - 'SHELL': '/bin/bash', 15:01:32 INFO - 'SHLVL': '1', 15:01:32 INFO - 'TERM': 'linux', 15:01:32 INFO - 'TMOUT': '86400', 15:01:32 INFO - 'USER': 'cltbld', 15:01:32 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1494280843.277378-2014983101', 15:01:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:32 INFO - '_': '/tools/buildbot/bin/python'} 15:01:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:32 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)) 15:01:32 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)) 15:01:32 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)) 15:01:32 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)) 15:01:32 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)) 15:01:32 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)) 15:01:32 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)) 15:01:32 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)) 15:01:32 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)) 15:01:32 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)) 15:01:32 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)) 15:01:32 INFO - Cleaning up... 15:01:32 INFO - Return code: 0 15:01:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:01:32 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')]} 15:01:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:32 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')]} 15:01:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:32 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 0x10d51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1447770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1444a30>, '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 0x14457f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1445ca0>, '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': '62c568580acbfdaac3eec7be000001dc-1494280843.277378-2014983101', '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 15:01:32 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 15:01:32 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 15:01:32 INFO - Using env: {'DISPLAY': ':0', 15:01:32 INFO - 'HOME': '/home/cltbld', 15:01:32 INFO - 'LANG': 'en_US.UTF-8', 15:01:32 INFO - 'LANGUAGE': 'en_US:en', 15:01:32 INFO - 'LOGNAME': 'cltbld', 15:01:32 INFO - 'MAIL': '/var/mail/cltbld', 15:01:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:32 INFO - 'MOZ_NO_REMOTE': '1', 15:01:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:32 INFO - 'NO_EM_RESTART': '1', 15:01:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:32 INFO - 'PWD': '/builds/slave/test', 15:01:32 INFO - 'SHELL': '/bin/bash', 15:01:32 INFO - 'SHLVL': '1', 15:01:32 INFO - 'TERM': 'linux', 15:01:32 INFO - 'TMOUT': '86400', 15:01:32 INFO - 'USER': 'cltbld', 15:01:32 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1494280843.277378-2014983101', 15:01:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:32 INFO - '_': '/tools/buildbot/bin/python'} 15:01:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:01:32 INFO - Cleaning up... 15:01:32 INFO - Return code: 0 15:01:32 INFO - Running post-action listener: _resource_record_post_action 15:01:32 INFO - Running post-action listener: _start_resource_monitoring 15:01:32 INFO - Starting resource monitoring. 15:01:32 INFO - [mozharness: 2017-05-08 22:01:32.906462Z] Finished create-virtualenv step (success) 15:01:32 INFO - [mozharness: 2017-05-08 22:01:32.906968Z] Running install step. 15:01:32 INFO - Running pre-action listener: _resource_record_pre_action 15:01:32 INFO - Running main action method: install 15:01:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:01:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:01:33 INFO - Reading from file tmpfile_stdout 15:01:33 INFO - Detecting whether we're running mozinstall >=1.0... 15:01:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:01:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:01:33 INFO - Reading from file tmpfile_stdout 15:01:33 INFO - Output received: 15:01:33 INFO - Usage: mozinstall [options] installer 15:01:33 INFO - Options: 15:01:33 INFO - -h, --help show this help message and exit 15:01:33 INFO - -d DEST, --destination=DEST 15:01:33 INFO - Directory to install application into. [default: 15:01:33 INFO - "/builds/slave/test"] 15:01:33 INFO - --app=APP Application being installed. [default: firefox] 15:01:33 INFO - mkdir: /builds/slave/test/build/application 15:01:33 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'] 15:01:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:01:49 INFO - Reading from file tmpfile_stdout 15:01:49 INFO - Output received: 15:01:49 INFO - /builds/slave/test/build/application/firefox/firefox 15:01:49 INFO - Running post-action listener: _resource_record_post_action 15:01:49 INFO - [mozharness: 2017-05-08 22:01:49.387883Z] Finished install step (success) 15:01:49 INFO - [mozharness: 2017-05-08 22:01:49.388162Z] Running run-tests step. 15:01:49 INFO - Running pre-action listener: _resource_record_pre_action 15:01:49 INFO - Running main action method: run_tests 15:01:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:01:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:01:49 INFO - Python 2.7.3 15:01:49 INFO - Return code: 0 15:01:49 INFO - grabbing minidump binary from tooltool 15:01:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:49 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 0x1444a30>, '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 0x14457f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1445ca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:01:49 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 15:01:49 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 15:01:49 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 15:01:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:01:49 INFO - Return code: 0 15:01:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:01:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:01:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:01:49 INFO - ENV: RUST_BACKTRACE is now 1 15:01:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:01:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:01:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J-SiESv6RQGICOFXUkGBcg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:01:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/J-SiESv6RQGICOFXUkGBcg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:01:49 INFO - Using env: {'DISPLAY': ':0', 15:01:49 INFO - 'HOME': '/home/cltbld', 15:01:49 INFO - 'LANG': 'en_US.UTF-8', 15:01:49 INFO - 'LANGUAGE': 'en_US:en', 15:01:49 INFO - 'LOGNAME': 'cltbld', 15:01:49 INFO - 'MAIL': '/var/mail/cltbld', 15:01:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:01:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:01:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:49 INFO - 'MOZ_NO_REMOTE': '1', 15:01:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:01:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:49 INFO - 'NO_EM_RESTART': '1', 15:01:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:49 INFO - 'PWD': '/builds/slave/test', 15:01:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:01:49 INFO - 'RUST_BACKTRACE': '1', 15:01:49 INFO - 'SHELL': '/bin/bash', 15:01:49 INFO - 'SHLVL': '1', 15:01:49 INFO - 'TERM': 'linux', 15:01:49 INFO - 'TMOUT': '86400', 15:01:49 INFO - 'USER': 'cltbld', 15:01:49 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1494280843.277378-2014983101', 15:01:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:49 INFO - '_': '/tools/buildbot/bin/python'} 15:01:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J-SiESv6RQGICOFXUkGBcg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:01:49 INFO - mozversion application_buildid: 20170508204415 15:01:49 INFO - mozversion application_changeset: e0955584782e6eb13bb1e7b197d3064660bb756f 15:01:49 INFO - mozversion application_display_name: Nightly 15:01:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:01:49 INFO - mozversion application_name: Firefox 15:01:49 INFO - mozversion application_remotingname: firefox 15:01:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:01:49 INFO - mozversion application_vendor: Mozilla 15:01:49 INFO - mozversion application_version: 55.0a1 15:01:49 INFO - mozversion platform_buildid: 20170508204415 15:01:49 INFO - mozversion platform_changeset: e0955584782e6eb13bb1e7b197d3064660bb756f 15:01:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:01:49 INFO - mozversion platform_version: 55.0a1 15:01:49 INFO - using testdate: 1494280909 15:01:49 INFO - actual date: 1494280909 15:01:49 INFO - starting webserver on 'localhost:44396' 15:01:49 INFO - SUITE-START | Running 2 tests 15:01:49 INFO - TEST-START | dromaeo_css 15:01:49 INFO - operating with platform_type : linux_ 15:01:49 INFO - Initialising browser for dromaeo_css test... 15:01:49 INFO - TEST-INFO | started process 12886 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8XmeTX/profile http://localhost:44396/getInfo.html) 15:01:53 INFO - PID 12886 | __metrics Screen width/height:1600/1200 15:01:53 INFO - PID 12886 | colorDepth:24 15:01:53 INFO - PID 12886 | Browser inner width/height: 1024/695 15:01:53 INFO - PID 12886 | __metrics 15:01:54 INFO - PID 12886 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:01:54 INFO - PID 12886 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:01:55 INFO - TEST-INFO | 12886: exit 0 15:01:55 INFO - Browser initialized. 15:01:55 INFO - Running cycle 1/1 for dromaeo_css test... 15:01:55 INFO - TEST-INFO | started process 12980 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8XmeTX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:02:06 INFO - PID 12980 | RSS: Main: 149463040 15:02:06 INFO - PID 12980 | 15:05:09 INFO - PID 12980 | Cycle 1(1): loaded http://localhost:44396/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44396/tests/dromaeo/cssquery-ext.html) 15:05:10 INFO - PID 12980 | RSS: Main: 317349888 15:05:10 INFO - PID 12980 | 15:08:12 INFO - PID 12980 | Cycle 1(1): loaded http://localhost:44396/tests/dromaeo/cssquery-ext.html (next: http://localhost:44396/tests/dromaeo/cssquery-jquery.html) 15:08:13 INFO - PID 12980 | RSS: Main: 224948224 15:08:13 INFO - PID 12980 | 15:11:15 INFO - PID 12980 | Cycle 1(1): loaded http://localhost:44396/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44396/tests/dromaeo/cssquery-mootools.html) 15:11:15 INFO - PID 12980 | RSS: Main: 175607808 15:11:15 INFO - PID 12980 | 15:14:17 INFO - PID 12980 | Cycle 1(1): loaded http://localhost:44396/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44396/tests/dromaeo/cssquery-prototype.html) 15:14:18 INFO - PID 12980 | RSS: Main: 175149056 15:14:18 INFO - PID 12980 | 15:17:20 INFO - PID 12980 | Cycle 1(1): loaded http://localhost:44396/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44396/tests/dromaeo/cssquery-yui.html) 15:17:21 INFO - PID 12980 | RSS: Main: 175570944 15:17:21 INFO - PID 12980 | 15:20:23 INFO - PID 12980 | Cycle 1(1): loaded http://localhost:44396/tests/dromaeo/cssquery-yui.html (next: http://localhost:44396/tests/dromaeo/cssquery-dojo.html) 15:20:23 INFO - PID 12980 | RSS: Main: 274714624 15:20:23 INFO - PID 12980 | 15:20:23 INFO - PID 12980 | __start_tp_report 15:20:23 INFO - PID 12980 | _x_x_mozilla_page_load 15:20:23 INFO - PID 12980 | _x_x_mozilla_page_load_details 15:20:23 INFO - PID 12980 | |i|pagename|runs| 15:20:23 INFO - PID 12980 | |0;dojo.html;3294.06119256012;3306.1073510152246;3344.6153692325374;3348.2633820559467;3366.9326613467733;5442.537384322328;5576.052071147905;5678.602497825149;5708.058170401884;5730.997075511785;5670.206171136034;5671.2060311556415;5700.429957004298;5752.626079304852;5765.45228203321;4676;4949.851504454872;5034.647574669774;5077.619178561604;5120.692758434506;5079.2635067915135;5117.539421452068;5118.360204974379;5145.202493613496;5147.6911385317;4955.033768415161;4997.950020499821;5014.147594908838;5081.187010078406;5081.212412076134;5052;5060.645754797166;5062.291279220912;5065.341505604285;5113.948860511422;5037.949620503785;5062.519060689228;5068.113080210986;5070.847874563769;5078.5175408336145;5531.640443371168;5603.327600687903;5618.353889302742;5680.801171958961;5708.686022268774;6163.753449862;6167.198264225667;6180.227471566054;6181.3818618138275;6182.876342473171;6218.720157592874;6220.533459990519;6221.906671399887;6223.937760622381;6224.470919971808;5640.407757185478;5669.518090962232;5714.114312281603;5767.048437007888;5826.388229235911;6192.040233763774;6196.225471816023;6216.564840461215;6271.811845644638;6286.119943207955;5933.762649493972;6006.039033754666;6014.248218972629;6018.849528761729;6136.969315153396;6105.879828540433;6142.542982806824;6154.846128846725;6159.692015399212;6162.075688646739;6130.0732715837075;6130.47890929276;6138.186612859722;6138.554517756338;6139.492138333381;6003.249593800775;6078.878422431615;6084.361142080106;6087.086936959403;6087.147799308101;4658.301254811805;4660.86017419478;4663.160631086369;4663.207254766698;4663.813447462064;4236.68224883135;4239.682023848224;4242.575742425733;4242.703010789215;4244;5703.486686198262;5743.282089738783;5745.913811292834;5747.339056008529;5749.13762935563;6125.418085281891;6127.20346354971;6129.019356902874;6130.080487926757;6130.754769809158;5683.062294721407;5712.914306285409;5802.245708057925;5824.854378640568;5843.3864444233595;5393.7033463159905;5397.136458166675;5397.217403476474;5420.268263784417;5444.673319600836;6442.6778661066755;6470.676466176672;6473.870522589522;6478.902816457757;6482;6097.146399503984;6097.359777223328;6111.014442317695;6166.753329866934;6167.568270221221;6435.549511534335;6441.420272175339;6473.546851720334;6476.5466417350335;6479.125318082187;6012.338642749207;6123.632582045091;6128.662923539248;6129.724162412791;6132.78535251264;6070.271567411763;6110.832160913912;6224.315325314121;6224.751009959551;6236.095766113979;5937.228160339128;6043.3050199227655;6057.818265452043;6067.514598831995;6080.118382834376;6014.789482368096;6028.487578555696;6035.215421995113;6038.4867286279405;6040.184575082308;5886.028805247258;5938.100997283624;5998.070299103646;5999.100134979788;6009.579329447071;6019.4883434908525;6032.758689652364;6074.210352654127;6086.239220097488;6112;5949.315828679757;5977.3424923257535;5979.103134529855;5990.520758339409;5994 15:20:23 INFO - PID 12980 | |1;ext.html;749.6102026945988;811.5090370325953;827.1934863508078;1135.5798354608792;1162.4013632979022;30326.848365758167;38720.225595488075;39337.60662393375;39398.803005985;39471.40792888102;41053;41541;41578.79210603943;41624.79187604058;41625.16749665012;5578.0517312056845;5681;7179.533330333525;7300.780976570712;7303.926960730378;7156.105486814148;7374.446916481258;7375.557466551997;7379.3727533159745;7382.889256661155;7304.926950730504;7357.043584334056;7388.335049845513;7400.925990740077;7402.185759566443;7314.268573142643;7322.524035937674;7333.853322933512;7340.229275926004;7384;7130.215676275606;7163.140423149203;7167.319104685099;7169.283071692841;7181.174164971043;36507.452388214195;36649.81675091634;36681;36736.63263367359;36934.445983310274;3546.113471632092;3559.519464872261;3568.411212149992;3602.891913242581;3604.1710406606626;28244.435111297866;28325.291867703265;28368.716312836816;28375.858120709472;28505.429891402262;3810.5427348718054;3830.367989281765;3848.903777405559;3853.2678791029616;3869.671077958377;190298;190327;191049;191204;191497.04251478793;48899;49073.50926490761;49151.75424122856;49170.26244606334;49266.75366623144;50623.90017597167;50678.74660626673;50710.239346409835;50714.74642626837;50733.47799566019;13252.867471325164;13314.533991310258;13324.467021319233;13347.865431438242;13352.799708004388;9336.813263734688;9471.384360016576;10621.575136994434;10631.574737010587;11033.779324413466;13381.397837097355;13479.797803032963;13494.122882012638;13711.520096796565;13747.793783093262;5345.866353341197;5478.233047373371;5523.917141242885;5543.223948647193;5618.97190514053;1059.4861492176287;1084.4306738962107;1095.1731442760824;1099.444780385916;1114.169943392178;26135.869320653273;26201.606975895378;26377.472450550882;26404;26427.207183784518;1197.694587880085;1200.5077918053555;1201.0631707268344;1203.4825025239231;1226;13011.869881301065;13589.932050339685;13765.242911639956;13818.930905345409;13900.096493727875;227233;227830;227907;228314;229473;53687.73156134194;53701.731491342296;53708.73145634325;53753.462465375625;53796.661517464854;1484.9480268190562;1522.352999974984;1523.4439429608335;1543.3749331520753;1552.4023251048427;24463.38841528976;25560.23319300424;25792;25934.74065259323;26007;39597.2080558393;39623;39637.60362396455;39720.404193936534;39722.40416393814;203498;203957;204273;204350;204674;30022.84988575043;30485.018473799133;35136.64863351334;35151.64848351586;35219.29561408706;40108;42320.788396059055;42464.57535424606;42626.36060459157;42847.785761071;29174.854125729235;30484.542731858597;30542.84728576343;30576.235594110327;32471.18822029468;30664.386712266078;30780.53829192609;31372.68627313789;31667.52498712567;32285.838570806995;36016.27967440689;36101.09747256339;36131.458028130124;36134.27731445304;36666.26667466689;31536.684633153374;31847.68152318447;32437.18907027343;34204;34346.65653343534;24218.75781242165;26151.476970460866;26746.123732160744;26797.866010669823;26849.463010739284 15:20:23 INFO - PID 12980 | |2;jquery.html;435.4883012460359;440.15270604087124;451.6747941482134;462.4843299720811;466.27727023114187;19002.429927102192;19629.214831406745;20257.898710506426;20412.183512659474;20419;21487.24794632188;22202.222922197725;22257.888710556424;22506.77493225067;22721.77278227217;5451.073317536018;5700.401457846929;5705.65766054036;5709.1150871614755;5710;5397.811076612319;5485.561155107602;5493;5531.363893152299;5539.058360078796;5495.230667706524;5498.532624726903;5508.807191748289;5512.669239845602;5513.531349835269;5326.866828329284;5534.944650553483;5579.553635709133;5584.804531841386;5587.636803607753;5042.470540593222;5044.117279476113;5059.392872855281;5063.443021267658;5064.56951159152;25302.74697253022;25777.35556611081;25779.484410311878;25866.482670346675;26070.608940865903;2168.8807115608633;2177.967330490044;2218.4564781628605;2230.3086043326457;2230.721159855018;16406.917965410215;16647.916760416243;17027.48917532476;17134.742978855327;17334.91332543342;2104.305579158874;2203.0416768705504;2225.721784776903;2241.7197850268717;2244.068711484732;109830.90169098366;113936;114508.42745786301;114638.42680786626;114917.85082149155;11939.88060119405;12123.87876121245;12319.753604927851;12488.68778280532;12634.431450584745;17509.474715758548;17595;17625.647487050188;17646.470605881845;17650.5587360317;8411.53736544496;8635;8744.737657870273;8760.430572012927;8771.16673915977;7913.406494512935;7939.166387529342;7967.681292748341;8151.796205094802;8188.7952801180445;7802.921970780333;8000.479968802009;8005.679772809139;8045.839083218303;8055.63749631268;2200.6038912995814;2240.1823334482797;2260.1750361118075;2269.8524595901213;2303.9977609739817;1006.3659894266565;1039.4854546999284;1043.1706793099352;1049.443794788748;1053.510117795229;18709.43871683852;19641.901790490956;19778;19803.900980495295;19811;1064.047472887245;1067.0983019348637;1069.3637285814928;1075.0808059109506;1102.6251074634663;10578;10836.187285953585;10925.945370273257;10994.34033957949;10994.945025274823;479868;500334.48494817823;501325;502234;504685;90164;92025;92380;93835;94502.52748736212;1142.4681455610955;1208.4259976511087;1224.7305592769576;1227.1287385955893;1229.7356068445506;16546.75179872327;16701.91649041747;16987.320507179575;17073.48779536616;17219.569510762332;46353.30470043019;46593;46666.533334666216;46960;48044.27933580929;56649;58001.709991449774;58198;58387.416125839896;61787.38212617816;9607;9704.805903882025;9708.5145742714;9718.562664680248;10123.79752404933;15166.620834478785;15386;15427.454470012322;15470.226488675296;16029.118398488195;13131.868681313064;13314.134581252187;13351.265680387283;13403.128796628189;13614.659633509242;11986.400679966142;12026.939865300617;12114.939425302817;12293.569725059937;12557.497700091893;12649.494020239455;12959.676008099495;13323.733525329633;13647.11293765902;13753.931230343784;9654.131128198496;9697.806043879224;9772;9849.212063034796;9950.55222514974;12882.48470061187;13281.933590332374;13357.465701371837;13862.584122476343;13898.51355202563 15:20:23 INFO - PID 12980 | |3;mootools.html;1196.6290449960518;1323.6889331007212;1400.5938277899409;1418.4822539772983;1421.317767471613;9626.737716636584;11298.661040168798;11687.415629218547;11691;11700.531978720841;11371.260868043591;11471.713207169803;11476.540938362476;11480.770384592302;11486.827697584544;1956.7749708783458;2038.1439795285942;2285.942851428715;2333.3349995251274;2335.194357946514;2133.349328454821;2221.2003678675746;2222.5665995130958;2227.3206671965045;2236.4856083100894;2278.4759505313787;2281.6121259385945;2295.116380193629;2310.6418505131733;2314.259436980167;2282.132789539981;2284.851484653492;2285.428642839282;2286.8513546619415;2290.5533420982915;2169.316665250441;2229.4092065602626;2233.609118404273;2236.3291012696127;2237.530118675064;11271.154663400277;11369.374684392355;11396.71508212293;11413;11423.828642570368;6306.810795676137;6530.869382612369;6530.967345163292;6539.051837483538;6550;3962.207558488285;4006.4991876015497;4126.442930204414;4225.936610950838;4247.299195632717;1383.1078954074667;1441.6952657844668;1473.8894582906219;1502.301429835132;1506.54050514593;18096.095195240316;18118.184681689225;18118.728219076856;18123;18147.183376747947;5585.050541407971;5687.40282270364;5770.278715160605;5801.622894511843;5994.580379373402;14614.123152610877;14649.560513184408;14660.706785864222;14675.559733208021;14679.486217982532;6921.653917304115;6922.7923162305215;6929.341712537301;6933.757318493929;6933.93066069343;5402.702851343135;5598.272224610856;6200.410960958701;6284.245890493079;6304.211973503312;4516.774161291923;4586.816527338936;4587.931181032287;4686.156491831435;4711.528847115261;1436.5115860607443;1438.3671184678917;1446.3346860444312;1451.49197780778;1471.2423102102211;890.7505898348472;912.8585069314267;913.8172365526921;926.8702381666573;935.2985261054209;6540.309930360617;6976;7148.17795953472;7196.352328290374;7226.132864056347;973.445136272318;976.3702411944256;978.4031740638205;983.4492684096929;985.9063388978036;4103.7948102594755;4352;4576.6109880660515;4586.472555656075;4604.953950460519;15216.619584510476;15485.612859678373;15654.33132061943;15825.762613560806;15826.683466330609;15383.615409614626;15427.30577124032;15600;15613.219339033003;15619.453319133776;9676.080772326617;9812;9831.262655300881;9838.852417213748;9846.507674616241;6815.863682726219;6822.11312529368;6828.453723701992;6880.346367095118;6958.3041695832035;13465.326733663082;13529.18824870511;13645.727085458433;13882.583522494342;13931;13673.521426750016;14056.718865622835;14181.14913105217;14189.148651080968;14285.142891426547;8607.784805379915;8857.379983401357;9236.584353703965;9603.615855365708;9672.75818104553;11104.278221915549;11489.138314626603;11507.136964727846;11536.36549989725;11539.769204615694;8977.551122443721;9021.684241051531;9049.366544341832;9084.818303634023;9266.53667316618;8804.207621314112;8834.469931804113;8857.33569982241;8914.420562663407;8968.596413161293;8455.28130108923;8672.436291641023;8746.169113934166;8750.081241469554;8765.211130997986;6047.697615119138;6055.424734650202;6106.297775755845;6348.460380867678;6365.840853978688;6248.750049997949;6373.8725225496155;6390.520710946605;6505.381988711065;6505.51208659343 15:20:23 INFO - PID 12980 | |4;prototype.html;419.8948773817617;420.09888788548557;422.9809658565365;428.44088464553766;428.802750734662;5626.468089359784;5765.7981970631035;5801.245838041054;5819.243498345215;5820.621659592123;5628.296462942132;5706.229658996034;5710.628809127415;5738.8278351649515;5740;4270.252705776492;4368.257396242639;4382.956170438287;4399.340098985146;4401.977990110045;4378.934315985262;4393.802278897458;4394.780260986954;4394.824207031715;4411.09572537629;4350.73895566267;4361.629261512775;4363.280058790296;4376.562343765614;4379.255526560492;4276.401303817453;4329.813444210654;4354.367112332875;4364.148990946766;4371.672124590668;3817.1220619257447;3819.102510909934;3819.579846216914;3832.616738326173;3836.4820749199057;5570.387257401682;5575.132330669231;5578.24693666358;5586.525145362649;5598.748056337475;5063.772130254148;5071.644984851062;5133.589312855;5143.922841157386;5143.948560514385;6036.909446358308;6050.304215015286;6063.727132279058;6074.605150665193;6090.969545152246;4305.698601097924;4307.375430562551;4319.092990471973;4319.978400108011;4324.956750432487;6046.244219472566;6147.569670123094;6238.968805155991;6405.423511883906;6441.484681225491;4244.10873716523;4255.744655320629;4256.2764330063965;4258.212230737324;4714.834980775657;4938.950610493849;4940.827071052496;4953.504649535018;4954.628402869799;4965.8013679452415;5328.600354973315;5382.30030096085;5420.186971954238;5458.863528411742;5460.863478413072;6141.692915354214;6165.198524191826;6188.288346840171;6210.161628180228;6246.6876656167005;1699.3712326439297;1709.2735587375316;1709.6067904382062;1714.2285971312958;1715.8798884078244;1201.6755476021426;1240.2124650846777;1241.3172754984723;1242.7882814256027;1253.5612535612463;5797.507211887037;5802.33273173582;5820.30156381237;5835.328937172279;5842;6106.374259068643;6225.439710426083;6228.781992630236;6265.686715664198;6271.560990730605;5770.451807078321;5783.942160578425;5808.9543882101625;5822.417758224228;5852.063669812809;3254.5118232264876;3270.7546933980047;3278.885239016623;3286.2277364819247;3289.9177520562175;6283.622982621057;6432.4532414744335;6473.838154046187;6479.015405525662;6494.837629059217;6325.683715814191;6344.460720838781;6353.078803573456;6378.936210637834;6392.232932048184;6278.497720182466;6422.389872962154;6445.903311450238;6466.321036291216;6476.611403315722;6191.894755783055;6199.667071579632;6215.9378406215355;6217.601039766017;6224.968875155776;6032.496513946663;6105.664188469499;6136.6011209271255;6139.3553676863285;6159.353267906805;6452.451411661262;6479.546431749733;6480.481561474976;6486.286508483969;6492.837679057872;4850.296706977539;4854.781534831011;4881.8535443936735;4885.462599114166;4889.951100488949;6114.449699527064;6281.434670879643;6314.431701146918;6335.339157553931;6340.968295158495;6107.9389206109145;6111.113888486234;6158.076288556573;6164.352742961924;6169.537284703575;5914.319853216935;6077;6123.938760612336;6133.110698948717;6137.96931015342;6091.969540152448;6116.66358350295;6143.955527560415;6165.876682466415;6166.506679465721;5916.230889984275;6105.694715264308;6177.62934223948;6188.690565471618;6192.380761923771;5984.640921544547;5996.51144774931;5998.4601385875485;5999.760009599567;6021.307549631673 15:20:23 INFO - PID 12980 | |5;yui.html;864.5547493239444;872.5986046418647;878.1174919206197;885.70771645357;897.3942588752592;16694.83305166948;17233.56916077099;17577.121143942783;17585.824141758596;17592.560185995342;15974.52076437706;16241.106739129344;16252;16253.593660158502;16258.593535161626;990.4552496127155;1032.3857304903609;1036.3315661398394;1043.7912417516488;1045.6967479430955;1041.677080105166;1049.8372752223418;1050.6322787024558;1050.847627094071;1051.1695760349314;1108.5288752280248;1109.339942734076;1109.8279766636144;1111.1555218034312;1111.3220935229504;1108.551036830081;1109.1792073865363;1110.0730889707104;1111.0334009411783;1111.1111111111159;810.509641666789;810.8905297784783;811.1969150540981;811.4684881402691;811.8822770698275;15760.975536590086;15987.280572374155;16568.585785355343;16737.748933766004;16927.66144677112;18199;18565.350212742625;18570.585823842815;19156.425307240806;19163.52091197717;13702;13946.790798138036;14071;14089.295535223198;14107.153570785786;3345.3476572068457;3436.3642726095754;3466.6706662866986;3470.1845066409373;3470.340635279314;86878.13121868827;91154.54422727844;91846;92070.53964730134;92249.53875230649;14020.789688154686;14730.484433044792;14907.478238261609;14979.400823967137;15039.774403383957;27041.594376084373;27149.321266968484;27351.452970940867;27775;28239.717602823708;8042.235987581171;8213.835723285501;8281.29608983231;8291.170882911661;8308.584570771438;4103.179364127186;4175;4177.164567086595;4184.4141820145205;4187.895302617459;4457.487388950248;4509.616682582017;4537.115262523776;4538.183127037165;4549.340345649928;878.4158534574564;893.7765558610347;900.0819164452353;907.6913849291141;912.1289168843738;708.4084789201074;736.830528978338;737.1228238396292;746.8356961468468;774.8338750180942;11682.24065435744;12486.75026499465;12586.937065314614;12671.17637353569;12767.808482872764;724.4892350892608;737.977860664181;745.5526683989563;752.5071078443628;757.3070640364116;5403.243545903577;5672.092465205547;5697.4587414195585;5723.599348045597;5811.15738217956;71386.28613713797;71628.28371716216;73321.59267223126;74540.62729686426;87764;65993.34006659967;66668;68185.65907170532;68547.65726171338;69394;54962.72518637381;55014.449855501734;55682;57446.138307925416;62650.37349626537;12121.69695757613;13056.738865222453;13097.279649619362;13134.60596182116;13152.408141633457;32599.511007334433;32852;33609.663903360655;33626.83186584051;35151.64848351484;39394.40908386319;39472.40791388074;40006.1998760029;40655.59344406636;41095;16899.746503802206;16953.491395258163;16963.915180424017;16967.236474358437;16972.06653634062;18865.622687546445;18950.52623684419;19001.389735950124;19084.14121364514;19481.512962175493;17376.91311543434;17491.650166996842;17675.911620441817;17692.52304677372;18014.279428823225;17482.213300401767;17613.559661008578;17685.557861053578;17759.55601109931;18047.458576242734;15809.920950395175;15910.60223494422;16025.519234422985;16039;16210.594735131715;12282.75434491323;12282.87717122853;12283.508659653513;12455.626331210078;12493.18794278369;12545.372731363577;12961;12978.654833031858;13092.607221783363;13093.41079651437 15:20:23 INFO - PID 12980 | __end_tp_report 15:20:23 INFO - PID 12980 | __start_cc_report 15:20:23 INFO - PID 12980 | _x_x_mozilla_cycle_collect,1658 15:20:23 INFO - PID 12980 | __end_cc_report 15:20:23 INFO - PID 12980 | __startTimestamp1494282023361__endTimestamp 15:20:23 INFO - PID 12980 | 15:20:23 INFO - PID 12980 | ------- Summary: start ------- 15:20:23 INFO - PID 12980 | Number of tests: 6 15:20:23 INFO - PID 12980 | 15:20:23 INFO - PID 12980 | [#0] dojo.html Cycles:165 Average:5686.23 Median:5990.52 stddev:675.06 (11.3%) stddev-sans-first:650.52 15:20:23 INFO - PID 12980 | Values: 3294.1 3306.1 3344.6 3348.3 3366.9 5442.5 5576.1 5678.6 5708.1 5731.0 5670.2 5671.2 5700.4 5752.6 5765.5 4676.0 4949.9 5034.6 5077.6 5120.7 5079.3 5117.5 5118.4 5145.2 5147.7 4955.0 4998.0 5014.1 5081.2 5081.2 5052.0 5060.6 5062.3 5065.3 5113.9 5037.9 5062.5 5068.1 5070.8 5078.5 5531.6 5603.3 5618.4 5680.8 5708.7 6163.8 6167.2 6180.2 6181.4 6182.9 6218.7 6220.5 6221.9 6223.9 6224.5 5640.4 5669.5 5714.1 5767.0 5826.4 6192.0 6196.2 6216.6 6271.8 6286.1 5933.8 6006.0 6014.2 6018.8 6137.0 6105.9 6142.5 6154.8 6159.7 6162.1 6130.1 6130.5 6138.2 6138.6 6139.5 6003.2 6078.9 6084.4 6087.1 6087.1 4658.3 4660.9 4663.2 4663.2 4663.8 4236.7 4239.7 4242.6 4242.7 4244.0 5703.5 5743.3 5745.9 5747.3 5749.1 6125.4 6127.2 6129.0 6130.1 6130.8 5683.1 5712.9 5802.2 5824.9 5843.4 5393.7 5397.1 5397.2 5420.3 5444.7 6442.7 6470.7 6473.9 6478.9 6482.0 6097.1 6097.4 6111.0 6166.8 6167.6 6435.5 6441.4 6473.5 6476.5 6479.1 6012.3 6123.6 6128.7 6129.7 6132.8 6070.3 6110.8 6224.3 6224.8 6236.1 5937.2 6043.3 6057.8 6067.5 6080.1 6014.8 6028.5 6035.2 6038.5 6040.2 5886.0 5938.1 5998.1 5999.1 6009.6 6019.5 6032.8 6074.2 6086.2 6112.0 5949.3 5977.3 5979.1 5990.5 5994.0 15:20:23 INFO - PID 12980 | 15:20:23 INFO - PID 12980 | [#1] ext.html Cycles:180 Average:37471.18 Median:19382.70 stddev:54039.89 (278.8%) stddev-sans-first:54121.14 15:20:23 INFO - PID 12980 | Values: 749.6 811.5 827.2 1135.6 1162.4 30326.8 38720.2 39337.6 39398.8 39471.4 41053.0 41541.0 41578.8 41624.8 41625.2 5578.1 5681.0 7179.5 7300.8 7303.9 7156.1 7374.4 7375.6 7379.4 7382.9 7304.9 7357.0 7388.3 7400.9 7402.2 7314.3 7322.5 7333.9 7340.2 7384.0 7130.2 7163.1 7167.3 7169.3 7181.2 36507.5 36649.8 36681.0 36736.6 36934.4 3546.1 3559.5 3568.4 3602.9 3604.2 28244.4 28325.3 28368.7 28375.9 28505.4 3810.5 3830.4 3848.9 3853.3 3869.7 190298.0 190327.0 191049.0 191204.0 191497.0 48899.0 49073.5 49151.8 49170.3 49266.8 50623.9 50678.7 50710.2 50714.7 50733.5 13252.9 13314.5 13324.5 13347.9 13352.8 9336.8 9471.4 10621.6 10631.6 11033.8 13381.4 13479.8 13494.1 13711.5 13747.8 5345.9 5478.2 5523.9 5543.2 5619.0 1059.5 1084.4 1095.2 1099.4 1114.2 26135.9 26201.6 26377.5 26404.0 26427.2 1197.7 1200.5 1201.1 1203.5 1226.0 13011.9 13589.9 13765.2 13818.9 13900.1 227233.0 227830.0 227907.0 228314.0 229473.0 53687.7 53701.7 53708.7 53753.5 53796.7 1484.9 1522.4 1523.4 1543.4 1552.4 24463.4 25560.2 25792.0 25934.7 26007.0 39597.2 39623.0 39637.6 39720.4 39722.4 203498.0 203957.0 204273.0 204350.0 204674.0 30022.8 30485.0 35136.6 35151.6 35219.3 40108.0 42320.8 42464.6 42626.4 42847.8 29174.9 30484.5 30542.8 30576.2 32471.2 30664.4 30780.5 31372.7 31667.5 32285.8 36016.3 36101.1 36131.5 36134.3 36666.3 31536.7 31847.7 32437.2 34204.0 34346.7 24218.8 26151.5 26746.1 26797.9 26849.5 15:20:23 INFO - PID 12980 | 15:20:23 INFO - PID 12980 | [#2] jquery.html Cycles:180 Average:31142.20 Median:12244.10 stddev:82650.38 (675.0%) stddev-sans-first:82850.08 15:20:23 INFO - PID 12980 | Values: 435.5 440.2 451.7 462.5 466.3 19002.4 19629.2 20257.9 20412.2 20419.0 21487.2 22202.2 22257.9 22506.8 22721.8 5451.1 5700.4 5705.7 5709.1 5710.0 5397.8 5485.6 5493.0 5531.4 5539.1 5495.2 5498.5 5508.8 5512.7 5513.5 5326.9 5534.9 5579.6 5584.8 5587.6 5042.5 5044.1 5059.4 5063.4 5064.6 25302.7 25777.4 25779.5 25866.5 26070.6 2168.9 2178.0 2218.5 2230.3 2230.7 16406.9 16647.9 17027.5 17134.7 17334.9 2104.3 2203.0 2225.7 2241.7 2244.1 109830.9 113936.0 114508.4 114638.4 114917.9 11939.9 12123.9 12319.8 12488.7 12634.4 17509.5 17595.0 17625.6 17646.5 17650.6 8411.5 8635.0 8744.7 8760.4 8771.2 7913.4 7939.2 7967.7 8151.8 8188.8 7802.9 8000.5 8005.7 8045.8 8055.6 2200.6 2240.2 2260.2 2269.9 2304.0 1006.4 1039.5 1043.2 1049.4 1053.5 18709.4 19641.9 19778.0 19803.9 19811.0 1064.0 1067.1 1069.4 1075.1 1102.6 10578.0 10836.2 10925.9 10994.3 10994.9 479868.0 500334.5 501325.0 502234.0 504685.0 90164.0 92025.0 92380.0 93835.0 94502.5 1142.5 1208.4 1224.7 1227.1 1229.7 16546.8 16701.9 16987.3 17073.5 17219.6 46353.3 46593.0 46666.5 46960.0 48044.3 56649.0 58001.7 58198.0 58387.4 61787.4 9607.0 9704.8 9708.5 9718.6 10123.8 15166.6 15386.0 15427.5 15470.2 16029.1 13131.9 13314.1 13351.3 13403.1 13614.7 11986.4 12026.9 12114.9 12293.6 12557.5 12649.5 12959.7 13323.7 13647.1 13753.9 9654.1 9697.8 9772.0 9849.2 9950.6 12882.5 13281.9 13357.5 13862.6 13898.5 15:20:23 INFO - PID 12980 | 15:20:23 INFO - PID 12980 | [#3] mootools.html Cycles:180 Average:7358.96 Median:4055.15 stddev:4799.44 (118.4%) stddev-sans-first:4790.56 15:20:23 INFO - PID 12980 | Values: 1196.6 1323.7 1400.6 1418.5 1421.3 9626.7 11298.7 11687.4 11691.0 11700.5 11371.3 11471.7 11476.5 11480.8 11486.8 1956.8 2038.1 2285.9 2333.3 2335.2 2133.3 2221.2 2222.6 2227.3 2236.5 2278.5 2281.6 2295.1 2310.6 2314.3 2282.1 2284.9 2285.4 2286.9 2290.6 2169.3 2229.4 2233.6 2236.3 2237.5 11271.2 11369.4 11396.7 11413.0 11423.8 6306.8 6530.9 6531.0 6539.1 6550.0 3962.2 4006.5 4126.4 4225.9 4247.3 1383.1 1441.7 1473.9 1502.3 1506.5 18096.1 18118.2 18118.7 18123.0 18147.2 5585.1 5687.4 5770.3 5801.6 5994.6 14614.1 14649.6 14660.7 14675.6 14679.5 6921.7 6922.8 6929.3 6933.8 6933.9 5402.7 5598.3 6200.4 6284.2 6304.2 4516.8 4586.8 4587.9 4686.2 4711.5 1436.5 1438.4 1446.3 1451.5 1471.2 890.8 912.9 913.8 926.9 935.3 6540.3 6976.0 7148.2 7196.4 7226.1 973.4 976.4 978.4 983.4 985.9 4103.8 4352.0 4576.6 4586.5 4605.0 15216.6 15485.6 15654.3 15825.8 15826.7 15383.6 15427.3 15600.0 15613.2 15619.5 9676.1 9812.0 9831.3 9838.9 9846.5 6815.9 6822.1 6828.5 6880.3 6958.3 13465.3 13529.2 13645.7 13882.6 13931.0 13673.5 14056.7 14181.1 14189.1 14285.1 8607.8 8857.4 9236.6 9603.6 9672.8 11104.3 11489.1 11507.1 11536.4 11539.8 8977.6 9021.7 9049.4 9084.8 9266.5 8804.2 8834.5 8857.3 8914.4 8968.6 8455.3 8672.4 8746.2 8750.1 8765.2 6047.7 6055.4 6106.3 6348.5 6365.8 6248.8 6373.9 6390.5 6505.4 6505.5 15:20:23 INFO - PID 12980 | 15:20:23 INFO - PID 12980 | [#4] prototype.html Cycles:180 Average:5142.05 Median:5801.79 stddev:1487.20 (25.6%) stddev-sans-first:1448.52 15:20:23 INFO - PID 12980 | Values: 419.9 420.1 423.0 428.4 428.8 5626.5 5765.8 5801.2 5819.2 5820.6 5628.3 5706.2 5710.6 5738.8 5740.0 4270.3 4368.3 4383.0 4399.3 4402.0 4378.9 4393.8 4394.8 4394.8 4411.1 4350.7 4361.6 4363.3 4376.6 4379.3 4276.4 4329.8 4354.4 4364.1 4371.7 3817.1 3819.1 3819.6 3832.6 3836.5 5570.4 5575.1 5578.2 5586.5 5598.7 5063.8 5071.6 5133.6 5143.9 5143.9 6036.9 6050.3 6063.7 6074.6 6091.0 4305.7 4307.4 4319.1 4320.0 4325.0 6046.2 6147.6 6239.0 6405.4 6441.5 4244.1 4255.7 4256.3 4258.2 4714.8 4939.0 4940.8 4953.5 4954.6 4965.8 5328.6 5382.3 5420.2 5458.9 5460.9 6141.7 6165.2 6188.3 6210.2 6246.7 1699.4 1709.3 1709.6 1714.2 1715.9 1201.7 1240.2 1241.3 1242.8 1253.6 5797.5 5802.3 5820.3 5835.3 5842.0 6106.4 6225.4 6228.8 6265.7 6271.6 5770.5 5783.9 5809.0 5822.4 5852.1 3254.5 3270.8 3278.9 3286.2 3289.9 6283.6 6432.5 6473.8 6479.0 6494.8 6325.7 6344.5 6353.1 6378.9 6392.2 6278.5 6422.4 6445.9 6466.3 6476.6 6191.9 6199.7 6215.9 6217.6 6225.0 6032.5 6105.7 6136.6 6139.4 6159.4 6452.5 6479.5 6480.5 6486.3 6492.8 4850.3 4854.8 4881.9 4885.5 4890.0 6114.4 6281.4 6314.4 6335.3 6341.0 6107.9 6111.1 6158.1 6164.4 6169.5 5914.3 6077.0 6123.9 6133.1 6138.0 6092.0 6116.7 6144.0 6165.9 6166.5 5916.2 6105.7 6177.6 6188.7 6192.4 5984.6 5996.5 5998.5 5999.8 6021.3 15:20:23 INFO - PID 12980 | 15:20:23 INFO - PID 12980 | [#5] yui.html Cycles:180 Average:18402.31 Median:19120.28 stddev:21872.73 (114.4%) stddev-sans-first:21894.44 15:20:23 INFO - PID 12980 | Values: 864.6 872.6 878.1 885.7 897.4 16694.8 17233.6 17577.1 17585.8 17592.6 15974.5 16241.1 16252.0 16253.6 16258.6 990.5 1032.4 1036.3 1043.8 1045.7 1041.7 1049.8 1050.6 1050.8 1051.2 1108.5 1109.3 1109.8 1111.2 1111.3 1108.6 1109.2 1110.1 1111.0 1111.1 810.5 810.9 811.2 811.5 811.9 15761.0 15987.3 16568.6 16737.7 16927.7 18199.0 18565.4 18570.6 19156.4 19163.5 13702.0 13946.8 14071.0 14089.3 14107.2 3345.3 3436.4 3466.7 3470.2 3470.3 86878.1 91154.5 91846.0 92070.5 92249.5 14020.8 14730.5 14907.5 14979.4 15039.8 27041.6 27149.3 27351.5 27775.0 28239.7 8042.2 8213.8 8281.3 8291.2 8308.6 4103.2 4175.0 4177.2 4184.4 4187.9 4457.5 4509.6 4537.1 4538.2 4549.3 878.4 893.8 900.1 907.7 912.1 708.4 736.8 737.1 746.8 774.8 11682.2 12486.8 12586.9 12671.2 12767.8 724.5 738.0 745.6 752.5 757.3 5403.2 5672.1 5697.5 5723.6 5811.2 71386.3 71628.3 73321.6 74540.6 87764.0 65993.3 66668.0 68185.7 68547.7 69394.0 54962.7 55014.4 55682.0 57446.1 62650.4 12121.7 13056.7 13097.3 13134.6 13152.4 32599.5 32852.0 33609.7 33626.8 35151.6 39394.4 39472.4 40006.2 40655.6 41095.0 16899.7 16953.5 16963.9 16967.2 16972.1 18865.6 18950.5 19001.4 19084.1 19481.5 17376.9 17491.7 17675.9 17692.5 18014.3 17482.2 17613.6 17685.6 17759.6 18047.5 15809.9 15910.6 16025.5 16039.0 16210.6 12282.8 12282.9 12283.5 12455.6 12493.2 12545.4 12961.0 12978.7 13092.6 13093.4 15:20:23 INFO - PID 12980 | -------- Summary: end -------- 15:20:23 INFO - PID 12980 | 15:20:24 INFO - TEST-INFO | 12980: exit 0 15:20:24 INFO - TEST-OK | dromaeo_css | took 1114513ms 15:20:24 INFO - TEST-START | kraken 15:20:24 INFO - operating with platform_type : linux_ 15:20:24 INFO - Initialising browser for kraken test... 15:20:24 INFO - TEST-INFO | started process 13313 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgdMIjU/profile http://localhost:44396/getInfo.html) 15:20:27 INFO - PID 13313 | __metrics Screen width/height:1600/1200 15:20:27 INFO - PID 13313 | colorDepth:24 15:20:27 INFO - PID 13313 | Browser inner width/height: 1024/695 15:20:27 INFO - PID 13313 | __metrics 15:20:28 INFO - PID 13313 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:20:28 INFO - PID 13313 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:20:29 INFO - TEST-INFO | 13313: exit 0 15:20:29 INFO - Browser initialized. 15:20:29 INFO - Running cycle 1/1 for kraken test... 15:20:29 INFO - TEST-INFO | started process 13408 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgdMIjU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:20:41 INFO - PID 13408 | RSS: Main: 149823488 15:20:41 INFO - PID 13408 | 15:20:43 INFO - PID 13408 | Cycle 1(1): loaded http://localhost:44396/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44396/tests/kraken/driver.html?testName=audio-beat-detection) 15:20:44 INFO - PID 13408 | RSS: Main: 222846976 15:20:44 INFO - PID 13408 | 15:20:47 INFO - PID 13408 | Cycle 1(1): loaded http://localhost:44396/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44396/tests/kraken/driver.html?testName=audio-dft) 15:20:47 INFO - PID 13408 | RSS: Main: 184074240 15:20:47 INFO - PID 13408 | 15:20:50 INFO - PID 13408 | Cycle 1(1): loaded http://localhost:44396/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44396/tests/kraken/driver.html?testName=audio-fft) 15:20:51 INFO - PID 13408 | RSS: Main: 263245824 15:20:51 INFO - PID 13408 | 15:20:53 INFO - PID 13408 | Cycle 1(1): loaded http://localhost:44396/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44396/tests/kraken/driver.html?testName=audio-oscillator) 15:20:53 INFO - PID 13408 | RSS: Main: 176971776 15:20:53 INFO - PID 13408 | 15:20:55 INFO - PID 13408 | Cycle 1(1): loaded http://localhost:44396/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44396/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:20:56 INFO - PID 13408 | RSS: Main: 178667520 15:20:56 INFO - PID 13408 | 15:20:59 INFO - PID 13408 | Cycle 1(1): loaded http://localhost:44396/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44396/tests/kraken/driver.html?testName=imaging-darkroom) 15:21:00 INFO - PID 13408 | RSS: Main: 239362048 15:21:00 INFO - PID 13408 | 15:21:03 INFO - PID 13408 | Cycle 1(1): loaded http://localhost:44396/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44396/tests/kraken/driver.html?testName=imaging-desaturate) 15:21:04 INFO - PID 13408 | RSS: Main: 254799872 15:21:04 INFO - PID 13408 | 15:21:06 INFO - PID 13408 | Cycle 1(1): loaded http://localhost:44396/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44396/tests/kraken/driver.html?testName=json-parse-financial) 15:21:07 INFO - PID 13408 | RSS: Main: 265383936 15:21:07 INFO - PID 13408 | 15:21:08 INFO - PID 13408 | Cycle 1(1): loaded http://localhost:44396/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44396/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:21:09 INFO - PID 13408 | RSS: Main: 203591680 15:21:09 INFO - PID 13408 | 15:21:11 INFO - PID 13408 | Cycle 1(1): loaded http://localhost:44396/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44396/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:21:11 INFO - PID 13408 | RSS: Main: 208650240 15:21:11 INFO - PID 13408 | 15:21:13 INFO - PID 13408 | Cycle 1(1): loaded http://localhost:44396/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44396/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:21:14 INFO - PID 13408 | RSS: Main: 218566656 15:21:14 INFO - PID 13408 | 15:21:16 INFO - PID 13408 | Cycle 1(1): loaded http://localhost:44396/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44396/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:21:17 INFO - PID 13408 | RSS: Main: 227311616 15:21:17 INFO - PID 13408 | 15:21:20 INFO - PID 13408 | Cycle 1(1): loaded http://localhost:44396/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44396/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:21:21 INFO - PID 13408 | RSS: Main: 222523392 15:21:21 INFO - PID 13408 | 15:21:22 INFO - PID 13408 | Cycle 1(1): loaded http://localhost:44396/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44396/tests/kraken/driver.html?testName=ai-astar) 15:21:23 INFO - PID 13408 | RSS: Main: 272719872 15:21:23 INFO - PID 13408 | 15:21:23 INFO - PID 13408 | __start_tp_report 15:21:23 INFO - PID 13408 | _x_x_mozilla_page_load 15:21:23 INFO - PID 13408 | _x_x_mozilla_page_load_details 15:21:23 INFO - PID 13408 | |i|pagename|runs| 15:21:23 INFO - PID 13408 | |0;ai-astar;107;108;106;110;109;108;108;109;108;108 15:21:23 INFO - PID 13408 | |1;audio-beat-detection;152;116;122;163;116;115;114;115;143;116 15:21:23 INFO - PID 13408 | |2;audio-dft;163;161;162;162;162;161;161;160;162;161 15:21:23 INFO - PID 13408 | |3;audio-fft;73;74;73;120;74;76;73;74;96;73 15:21:23 INFO - PID 13408 | |4;audio-oscillator;82;82;104;83;84;83;104;82;82;105 15:21:23 INFO - PID 13408 | |5;imaging-gaussian-blur;113;113;113;113;112;113;113;113;113;113 15:21:23 INFO - PID 13408 | |6;imaging-darkroom;146;146;146;147;146;149;147;147;146;146 15:21:23 INFO - PID 13408 | |7;imaging-desaturate;93;95;93;93;94;94;93;93;94;94 15:21:23 INFO - PID 13408 | |8;json-parse-financial;47;47;47;47;47;50;48;48;49;46 15:21:23 INFO - PID 13408 | |9;json-stringify-tinderbox;58;55;56;54;56;53;54;54;54;55 15:21:23 INFO - PID 13408 | |10;stanford-crypto-aes;81;82;82;81;89;90;81;80;81;80 15:21:23 INFO - PID 13408 | |11;stanford-crypto-ccm;126;134;125;131;122;125;127;125;169;121 15:21:23 INFO - PID 13408 | |12;stanford-crypto-pbkdf2;180;178;178;185;171;177;174;178;189;181 15:21:23 INFO - PID 13408 | |13;stanford-crypto-sha256-iterative;64;65;64;64;66;63;63;65;65;68 15:21:23 INFO - PID 13408 | __end_tp_report 15:21:23 INFO - PID 13408 | __start_cc_report 15:21:23 INFO - PID 13408 | _x_x_mozilla_cycle_collect,1674 15:21:23 INFO - PID 13408 | __end_cc_report 15:21:23 INFO - PID 13408 | __startTimestamp1494282083038__endTimestamp 15:21:23 INFO - PID 13408 | 15:21:23 INFO - PID 13408 | ------- Summary: start ------- 15:21:23 INFO - PID 13408 | Number of tests: 14 15:21:23 INFO - PID 13408 | 15:21:23 INFO - PID 13408 | [#0] ai-astar Cycles:10 Average:108.10 Median:108.00 stddev:1.10 (1.0%) stddev-sans-first:1.09 15:21:23 INFO - PID 13408 | Values: 107.0 108.0 106.0 110.0 109.0 108.0 108.0 109.0 108.0 108.0 15:21:23 INFO - PID 13408 | 15:21:23 INFO - PID 13408 | [#1] audio-beat-detection Cycles:10 Average:127.20 Median:119.00 stddev:18.32 (15.4%) stddev-sans-first:17.10 15:21:23 INFO - PID 13408 | Values: 152.0 116.0 122.0 163.0 116.0 115.0 114.0 115.0 143.0 116.0 15:21:23 INFO - PID 13408 | 15:21:23 INFO - PID 13408 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.85 (0.5%) stddev-sans-first:0.71 15:21:23 INFO - PID 13408 | Values: 163.0 161.0 162.0 162.0 162.0 161.0 161.0 160.0 162.0 161.0 15:21:23 INFO - PID 13408 | 15:21:23 INFO - PID 13408 | [#3] audio-fft Cycles:10 Average:80.60 Median:74.00 stddev:15.54 (21.0%) stddev-sans-first:16.23 15:21:23 INFO - PID 13408 | Values: 73.0 74.0 73.0 120.0 74.0 76.0 73.0 74.0 96.0 73.0 15:21:23 INFO - PID 13408 | 15:21:23 INFO - PID 13408 | [#4] audio-oscillator Cycles:10 Average:89.10 Median:82.00 stddev:10.54 (12.8%) stddev-sans-first:10.86 15:21:23 INFO - PID 13408 | Values: 82.0 82.0 104.0 83.0 84.0 83.0 104.0 82.0 82.0 105.0 15:21:23 INFO - PID 13408 | 15:21:23 INFO - PID 13408 | [#5] imaging-gaussian-blur Cycles:10 Average:112.90 Median:113.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 15:21:23 INFO - PID 13408 | Values: 113.0 113.0 113.0 113.0 112.0 113.0 113.0 113.0 113.0 113.0 15:21:23 INFO - PID 13408 | 15:21:23 INFO - PID 13408 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:146.50 stddev:0.97 (0.7%) stddev-sans-first:1.00 15:21:23 INFO - PID 13408 | Values: 146.0 146.0 146.0 147.0 146.0 149.0 147.0 147.0 146.0 146.0 15:21:23 INFO - PID 13408 | 15:21:23 INFO - PID 13408 | [#7] imaging-desaturate Cycles:10 Average:93.60 Median:94.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 15:21:23 INFO - PID 13408 | Values: 93.0 95.0 93.0 93.0 94.0 94.0 93.0 93.0 94.0 94.0 15:21:23 INFO - PID 13408 | 15:21:23 INFO - PID 13408 | [#8] json-parse-financial Cycles:10 Average:47.60 Median:47.50 stddev:1.17 (2.5%) stddev-sans-first:1.22 15:21:23 INFO - PID 13408 | Values: 47.0 47.0 47.0 47.0 47.0 50.0 48.0 48.0 49.0 46.0 15:21:23 INFO - PID 13408 | 15:21:23 INFO - PID 13408 | [#9] json-stringify-tinderbox Cycles:10 Average:54.90 Median:55.00 stddev:1.45 (2.6%) stddev-sans-first:1.01 15:21:23 INFO - PID 13408 | Values: 58.0 55.0 56.0 54.0 56.0 53.0 54.0 54.0 54.0 55.0 15:21:23 INFO - PID 13408 | 15:21:23 INFO - PID 13408 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:81.50 stddev:3.65 (4.5%) stddev-sans-first:3.82 15:21:23 INFO - PID 13408 | Values: 81.0 82.0 82.0 81.0 89.0 90.0 81.0 80.0 81.0 80.0 15:21:23 INFO - PID 13408 | 15:21:23 INFO - PID 13408 | [#11] stanford-crypto-ccm Cycles:10 Average:130.50 Median:126.50 stddev:14.07 (11.1%) stddev-sans-first:14.82 15:21:23 INFO - PID 13408 | Values: 126.0 134.0 125.0 131.0 122.0 125.0 127.0 125.0 169.0 121.0 15:21:23 INFO - PID 13408 | 15:21:23 INFO - PID 13408 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.10 Median:179.00 stddev:5.13 (2.9%) stddev-sans-first:5.43 15:21:23 INFO - PID 13408 | Values: 180.0 178.0 178.0 185.0 171.0 177.0 174.0 178.0 189.0 181.0 15:21:23 INFO - PID 13408 | 15:21:23 INFO - PID 13408 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:65.00 stddev:1.49 (2.3%) stddev-sans-first:1.56 15:21:23 INFO - PID 13408 | Values: 64.0 65.0 64.0 64.0 66.0 63.0 63.0 65.0 65.0 68.0 15:21:23 INFO - PID 13408 | -------- Summary: end -------- 15:21:23 INFO - PID 13408 | 15:21:24 INFO - TEST-INFO | 13408: exit 0 15:21:24 INFO - TEST-OK | kraken | took 60020ms 15:21:24 INFO - SUITE-END | took 1174s 15:21:24 INFO - Completed test suite (00:19:35) 15:21:24 INFO - javascript benchmark 15:21:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7686.143939447571, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3294.06119256012, 3306.1073510152246, 3344.6153692325374, 3348.2633820559467, 3366.9326613467733, 5442.537384322328, 5576.052071147905, 5678.602497825149, 5708.058170401884, 5730.997075511785, 5670.206171136034, 5671.2060311556415, 5700.429957004298, 5752.626079304852, 5765.45228203321, 4676.0, 4949.851504454872, 5034.647574669774, 5077.619178561604, 5120.692758434506, 5079.2635067915135, 5117.539421452068, 5118.360204974379, 5145.202493613496, 5147.6911385317, 4955.033768415161, 4997.950020499821, 5014.147594908838, 5081.187010078406, 5081.212412076134, 5052.0, 5060.645754797166, 5062.291279220912, 5065.341505604285, 5113.948860511422, 5037.949620503785, 5062.519060689228, 5068.113080210986, 5070.847874563769, 5078.5175408336145, 5531.640443371168, 5603.327600687903, 5618.353889302742, 5680.801171958961, 5708.686022268774, 6163.753449862, 6167.198264225667, 6180.227471566054, 6181.3818618138275, 6182.876342473171, 6218.720157592874, 6220.533459990519, 6221.906671399887, 6223.937760622381, 6224.470919971808, 5640.407757185478, 5669.518090962232, 5714.114312281603, 5767.048437007888, 5826.388229235911, 6192.040233763774, 6196.225471816023, 6216.564840461215, 6271.811845644638, 6286.119943207955, 5933.762649493972, 6006.039033754666, 6014.248218972629, 6018.849528761729, 6136.969315153396, 6105.879828540433, 6142.542982806824, 6154.846128846725, 6159.692015399212, 6162.075688646739, 6130.0732715837075, 6130.47890929276, 6138.186612859722, 6138.554517756338, 6139.492138333381, 6003.249593800775, 6078.878422431615, 6084.361142080106, 6087.086936959403, 6087.147799308101, 4658.301254811805, 4660.86017419478, 4663.160631086369, 4663.207254766698, 4663.813447462064, 4236.68224883135, 4239.682023848224, 4242.575742425733, 4242.703010789215, 4244.0, 5703.486686198262, 5743.282089738783, 5745.913811292834, 5747.339056008529, 5749.13762935563, 6125.418085281891, 6127.20346354971, 6129.019356902874, 6130.080487926757, 6130.754769809158, 5683.062294721407, 5712.914306285409, 5802.245708057925, 5824.854378640568, 5843.3864444233595, 5393.7033463159905, 5397.136458166675, 5397.217403476474, 5420.268263784417, 5444.673319600836, 6442.6778661066755, 6470.676466176672, 6473.870522589522, 6478.902816457757, 6482.0, 6097.146399503984, 6097.359777223328, 6111.014442317695, 6166.753329866934, 6167.568270221221, 6435.549511534335, 6441.420272175339, 6473.546851720334, 6476.5466417350335, 6479.125318082187, 6012.338642749207, 6123.632582045091, 6128.662923539248, 6129.724162412791, 6132.78535251264, 6070.271567411763, 6110.832160913912, 6224.315325314121, 6224.751009959551, 6236.095766113979, 5937.228160339128, 6043.3050199227655, 6057.818265452043, 6067.514598831995, 6080.118382834376, 6014.789482368096, 6028.487578555696, 6035.215421995113, 6038.4867286279405, 6040.184575082308, 5886.028805247258, 5938.100997283624, 5998.070299103646, 5999.100134979788, 6009.579329447071, 6019.4883434908525, 6032.758689652364, 6074.210352654127, 6086.239220097488, 6112.0, 5949.315828679757, 5977.3424923257535, 5979.103134529855, 5990.520758339409, 5994.0], "value": 5639.454530963517, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [749.6102026945988, 811.5090370325953, 827.1934863508078, 1135.5798354608792, 1162.4013632979022, 30326.848365758167, 38720.225595488075, 39337.60662393375, 39398.803005985, 39471.40792888102, 41053.0, 41541.0, 41578.79210603943, 41624.79187604058, 41625.16749665012, 5578.0517312056845, 5681.0, 7179.533330333525, 7300.780976570712, 7303.926960730378, 7156.105486814148, 7374.446916481258, 7375.557466551997, 7379.3727533159745, 7382.889256661155, 7304.926950730504, 7357.043584334056, 7388.335049845513, 7400.925990740077, 7402.185759566443, 7314.268573142643, 7322.524035937674, 7333.853322933512, 7340.229275926004, 7384.0, 7130.215676275606, 7163.140423149203, 7167.319104685099, 7169.283071692841, 7181.174164971043, 36507.452388214195, 36649.81675091634, 36681.0, 36736.63263367359, 36934.445983310274, 3546.113471632092, 3559.519464872261, 3568.411212149992, 3602.891913242581, 3604.1710406606626, 28244.435111297866, 28325.291867703265, 28368.716312836816, 28375.858120709472, 28505.429891402262, 3810.5427348718054, 3830.367989281765, 3848.903777405559, 3853.2678791029616, 3869.671077958377, 190298.0, 190327.0, 191049.0, 191204.0, 191497.04251478793, 48899.0, 49073.50926490761, 49151.75424122856, 49170.26244606334, 49266.75366623144, 50623.90017597167, 50678.74660626673, 50710.239346409835, 50714.74642626837, 50733.47799566019, 13252.867471325164, 13314.533991310258, 13324.467021319233, 13347.865431438242, 13352.799708004388, 9336.813263734688, 9471.384360016576, 10621.575136994434, 10631.574737010587, 11033.779324413466, 13381.397837097355, 13479.797803032963, 13494.122882012638, 13711.520096796565, 13747.793783093262, 5345.866353341197, 5478.233047373371, 5523.917141242885, 5543.223948647193, 5618.97190514053, 1059.4861492176287, 1084.4306738962107, 1095.1731442760824, 1099.444780385916, 1114.169943392178, 26135.869320653273, 26201.606975895378, 26377.472450550882, 26404.0, 26427.207183784518, 1197.694587880085, 1200.5077918053555, 1201.0631707268344, 1203.4825025239231, 1226.0, 13011.869881301065, 13589.932050339685, 13765.242911639956, 13818.930905345409, 13900.096493727875, 227233.0, 227830.0, 227907.0, 228314.0, 229473.0, 53687.73156134194, 53701.731491342296, 53708.73145634325, 53753.462465375625, 53796.661517464854, 1484.9480268190562, 1522.352999974984, 1523.4439429608335, 1543.3749331520753, 1552.4023251048427, 24463.38841528976, 25560.23319300424, 25792.0, 25934.74065259323, 26007.0, 39597.2080558393, 39623.0, 39637.60362396455, 39720.404193936534, 39722.40416393814, 203498.0, 203957.0, 204273.0, 204350.0, 204674.0, 30022.84988575043, 30485.018473799133, 35136.64863351334, 35151.64848351586, 35219.29561408706, 40108.0, 42320.788396059055, 42464.57535424606, 42626.36060459157, 42847.785761071, 29174.854125729235, 30484.542731858597, 30542.84728576343, 30576.235594110327, 32471.18822029468, 30664.386712266078, 30780.53829192609, 31372.68627313789, 31667.52498712567, 32285.838570806995, 36016.27967440689, 36101.09747256339, 36131.458028130124, 36134.27731445304, 36666.26667466689, 31536.684633153374, 31847.68152318447, 32437.18907027343, 34204.0, 34346.65653343534, 24218.75781242165, 26151.476970460866, 26746.123732160744, 26797.866010669823, 26849.463010739284], "value": 16851.764877409445, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [435.4883012460359, 440.15270604087124, 451.6747941482134, 462.4843299720811, 466.27727023114187, 19002.429927102192, 19629.214831406745, 20257.898710506426, 20412.183512659474, 20419.0, 21487.24794632188, 22202.222922197725, 22257.888710556424, 22506.77493225067, 22721.77278227217, 5451.073317536018, 5700.401457846929, 5705.65766054036, 5709.1150871614755, 5710.0, 5397.811076612319, 5485.561155107602, 5493.0, 5531.363893152299, 5539.058360078796, 5495.230667706524, 5498.532624726903, 5508.807191748289, 5512.669239845602, 5513.531349835269, 5326.866828329284, 5534.944650553483, 5579.553635709133, 5584.804531841386, 5587.636803607753, 5042.470540593222, 5044.117279476113, 5059.392872855281, 5063.443021267658, 5064.56951159152, 25302.74697253022, 25777.35556611081, 25779.484410311878, 25866.482670346675, 26070.608940865903, 2168.8807115608633, 2177.967330490044, 2218.4564781628605, 2230.3086043326457, 2230.721159855018, 16406.917965410215, 16647.916760416243, 17027.48917532476, 17134.742978855327, 17334.91332543342, 2104.305579158874, 2203.0416768705504, 2225.721784776903, 2241.7197850268717, 2244.068711484732, 109830.90169098366, 113936.0, 114508.42745786301, 114638.42680786626, 114917.85082149155, 11939.88060119405, 12123.87876121245, 12319.753604927851, 12488.68778280532, 12634.431450584745, 17509.474715758548, 17595.0, 17625.647487050188, 17646.470605881845, 17650.5587360317, 8411.53736544496, 8635.0, 8744.737657870273, 8760.430572012927, 8771.16673915977, 7913.406494512935, 7939.166387529342, 7967.681292748341, 8151.796205094802, 8188.7952801180445, 7802.921970780333, 8000.479968802009, 8005.679772809139, 8045.839083218303, 8055.63749631268, 2200.6038912995814, 2240.1823334482797, 2260.1750361118075, 2269.8524595901213, 2303.9977609739817, 1006.3659894266565, 1039.4854546999284, 1043.1706793099352, 1049.443794788748, 1053.510117795229, 18709.43871683852, 19641.901790490956, 19778.0, 19803.900980495295, 19811.0, 1064.047472887245, 1067.0983019348637, 1069.3637285814928, 1075.0808059109506, 1102.6251074634663, 10578.0, 10836.187285953585, 10925.945370273257, 10994.34033957949, 10994.945025274823, 479868.0, 500334.48494817823, 501325.0, 502234.0, 504685.0, 90164.0, 92025.0, 92380.0, 93835.0, 94502.52748736212, 1142.4681455610955, 1208.4259976511087, 1224.7305592769576, 1227.1287385955893, 1229.7356068445506, 16546.75179872327, 16701.91649041747, 16987.320507179575, 17073.48779536616, 17219.569510762332, 46353.30470043019, 46593.0, 46666.533334666216, 46960.0, 48044.27933580929, 56649.0, 58001.709991449774, 58198.0, 58387.416125839896, 61787.38212617816, 9607.0, 9704.805903882025, 9708.5145742714, 9718.562664680248, 10123.79752404933, 15166.620834478785, 15386.0, 15427.454470012322, 15470.226488675296, 16029.118398488195, 13131.868681313064, 13314.134581252187, 13351.265680387283, 13403.128796628189, 13614.659633509242, 11986.400679966142, 12026.939865300617, 12114.939425302817, 12293.569725059937, 12557.497700091893, 12649.494020239455, 12959.676008099495, 13323.733525329633, 13647.11293765902, 13753.931230343784, 9654.131128198496, 9697.806043879224, 9772.0, 9849.212063034796, 9950.55222514974, 12882.48470061187, 13281.933590332374, 13357.465701371837, 13862.584122476343, 13898.51355202563], "value": 10140.877702778103, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1196.6290449960518, 1323.6889331007212, 1400.5938277899409, 1418.4822539772983, 1421.317767471613, 9626.737716636584, 11298.661040168798, 11687.415629218547, 11691.0, 11700.531978720841, 11371.260868043591, 11471.713207169803, 11476.540938362476, 11480.770384592302, 11486.827697584544, 1956.7749708783458, 2038.1439795285942, 2285.942851428715, 2333.3349995251274, 2335.194357946514, 2133.349328454821, 2221.2003678675746, 2222.5665995130958, 2227.3206671965045, 2236.4856083100894, 2278.4759505313787, 2281.6121259385945, 2295.116380193629, 2310.6418505131733, 2314.259436980167, 2282.132789539981, 2284.851484653492, 2285.428642839282, 2286.8513546619415, 2290.5533420982915, 2169.316665250441, 2229.4092065602626, 2233.609118404273, 2236.3291012696127, 2237.530118675064, 11271.154663400277, 11369.374684392355, 11396.71508212293, 11413.0, 11423.828642570368, 6306.810795676137, 6530.869382612369, 6530.967345163292, 6539.051837483538, 6550.0, 3962.207558488285, 4006.4991876015497, 4126.442930204414, 4225.936610950838, 4247.299195632717, 1383.1078954074667, 1441.6952657844668, 1473.8894582906219, 1502.301429835132, 1506.54050514593, 18096.095195240316, 18118.184681689225, 18118.728219076856, 18123.0, 18147.183376747947, 5585.050541407971, 5687.40282270364, 5770.278715160605, 5801.622894511843, 5994.580379373402, 14614.123152610877, 14649.560513184408, 14660.706785864222, 14675.559733208021, 14679.486217982532, 6921.653917304115, 6922.7923162305215, 6929.341712537301, 6933.757318493929, 6933.93066069343, 5402.702851343135, 5598.272224610856, 6200.410960958701, 6284.245890493079, 6304.211973503312, 4516.774161291923, 4586.816527338936, 4587.931181032287, 4686.156491831435, 4711.528847115261, 1436.5115860607443, 1438.3671184678917, 1446.3346860444312, 1451.49197780778, 1471.2423102102211, 890.7505898348472, 912.8585069314267, 913.8172365526921, 926.8702381666573, 935.2985261054209, 6540.309930360617, 6976.0, 7148.17795953472, 7196.352328290374, 7226.132864056347, 973.445136272318, 976.3702411944256, 978.4031740638205, 983.4492684096929, 985.9063388978036, 4103.7948102594755, 4352.0, 4576.6109880660515, 4586.472555656075, 4604.953950460519, 15216.619584510476, 15485.612859678373, 15654.33132061943, 15825.762613560806, 15826.683466330609, 15383.615409614626, 15427.30577124032, 15600.0, 15613.219339033003, 15619.453319133776, 9676.080772326617, 9812.0, 9831.262655300881, 9838.852417213748, 9846.507674616241, 6815.863682726219, 6822.11312529368, 6828.453723701992, 6880.346367095118, 6958.3041695832035, 13465.326733663082, 13529.18824870511, 13645.727085458433, 13882.583522494342, 13931.0, 13673.521426750016, 14056.718865622835, 14181.14913105217, 14189.148651080968, 14285.142891426547, 8607.784805379915, 8857.379983401357, 9236.584353703965, 9603.615855365708, 9672.75818104553, 11104.278221915549, 11489.138314626603, 11507.136964727846, 11536.36549989725, 11539.769204615694, 8977.551122443721, 9021.684241051531, 9049.366544341832, 9084.818303634023, 9266.53667316618, 8804.207621314112, 8834.469931804113, 8857.33569982241, 8914.420562663407, 8968.596413161293, 8455.28130108923, 8672.436291641023, 8746.169113934166, 8750.081241469554, 8765.211130997986, 6047.697615119138, 6055.424734650202, 6106.297775755845, 6348.460380867678, 6365.840853978688, 6248.750049997949, 6373.8725225496155, 6390.520710946605, 6505.381988711065, 6505.51208659343], "value": 5507.257930160334, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [419.8948773817617, 420.09888788548557, 422.9809658565365, 428.44088464553766, 428.802750734662, 5626.468089359784, 5765.7981970631035, 5801.245838041054, 5819.243498345215, 5820.621659592123, 5628.296462942132, 5706.229658996034, 5710.628809127415, 5738.8278351649515, 5740.0, 4270.252705776492, 4368.257396242639, 4382.956170438287, 4399.340098985146, 4401.977990110045, 4378.934315985262, 4393.802278897458, 4394.780260986954, 4394.824207031715, 4411.09572537629, 4350.73895566267, 4361.629261512775, 4363.280058790296, 4376.562343765614, 4379.255526560492, 4276.401303817453, 4329.813444210654, 4354.367112332875, 4364.148990946766, 4371.672124590668, 3817.1220619257447, 3819.102510909934, 3819.579846216914, 3832.616738326173, 3836.4820749199057, 5570.387257401682, 5575.132330669231, 5578.24693666358, 5586.525145362649, 5598.748056337475, 5063.772130254148, 5071.644984851062, 5133.589312855, 5143.922841157386, 5143.948560514385, 6036.909446358308, 6050.304215015286, 6063.727132279058, 6074.605150665193, 6090.969545152246, 4305.698601097924, 4307.375430562551, 4319.092990471973, 4319.978400108011, 4324.956750432487, 6046.244219472566, 6147.569670123094, 6238.968805155991, 6405.423511883906, 6441.484681225491, 4244.10873716523, 4255.744655320629, 4256.2764330063965, 4258.212230737324, 4714.834980775657, 4938.950610493849, 4940.827071052496, 4953.504649535018, 4954.628402869799, 4965.8013679452415, 5328.600354973315, 5382.30030096085, 5420.186971954238, 5458.863528411742, 5460.863478413072, 6141.692915354214, 6165.198524191826, 6188.288346840171, 6210.161628180228, 6246.6876656167005, 1699.3712326439297, 1709.2735587375316, 1709.6067904382062, 1714.2285971312958, 1715.8798884078244, 1201.6755476021426, 1240.2124650846777, 1241.3172754984723, 1242.7882814256027, 1253.5612535612463, 5797.507211887037, 5802.33273173582, 5820.30156381237, 5835.328937172279, 5842.0, 6106.374259068643, 6225.439710426083, 6228.781992630236, 6265.686715664198, 6271.560990730605, 5770.451807078321, 5783.942160578425, 5808.9543882101625, 5822.417758224228, 5852.063669812809, 3254.5118232264876, 3270.7546933980047, 3278.885239016623, 3286.2277364819247, 3289.9177520562175, 6283.622982621057, 6432.4532414744335, 6473.838154046187, 6479.015405525662, 6494.837629059217, 6325.683715814191, 6344.460720838781, 6353.078803573456, 6378.936210637834, 6392.232932048184, 6278.497720182466, 6422.389872962154, 6445.903311450238, 6466.321036291216, 6476.611403315722, 6191.894755783055, 6199.667071579632, 6215.9378406215355, 6217.601039766017, 6224.968875155776, 6032.496513946663, 6105.664188469499, 6136.6011209271255, 6139.3553676863285, 6159.353267906805, 6452.451411661262, 6479.546431749733, 6480.481561474976, 6486.286508483969, 6492.837679057872, 4850.296706977539, 4854.781534831011, 4881.8535443936735, 4885.462599114166, 4889.951100488949, 6114.449699527064, 6281.434670879643, 6314.431701146918, 6335.339157553931, 6340.968295158495, 6107.9389206109145, 6111.113888486234, 6158.076288556573, 6164.352742961924, 6169.537284703575, 5914.319853216935, 6077.0, 6123.938760612336, 6133.110698948717, 6137.96931015342, 6091.969540152448, 6116.66358350295, 6143.955527560415, 6165.876682466415, 6166.506679465721, 5916.230889984275, 6105.694715264308, 6177.62934223948, 6188.690565471618, 6192.380761923771, 5984.640921544547, 5996.51144774931, 5998.4601385875485, 5999.760009599567, 6021.307549631673], "value": 4700.968617792377, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [864.5547493239444, 872.5986046418647, 878.1174919206197, 885.70771645357, 897.3942588752592, 16694.83305166948, 17233.56916077099, 17577.121143942783, 17585.824141758596, 17592.560185995342, 15974.52076437706, 16241.106739129344, 16252.0, 16253.593660158502, 16258.593535161626, 990.4552496127155, 1032.3857304903609, 1036.3315661398394, 1043.7912417516488, 1045.6967479430955, 1041.677080105166, 1049.8372752223418, 1050.6322787024558, 1050.847627094071, 1051.1695760349314, 1108.5288752280248, 1109.339942734076, 1109.8279766636144, 1111.1555218034312, 1111.3220935229504, 1108.551036830081, 1109.1792073865363, 1110.0730889707104, 1111.0334009411783, 1111.1111111111159, 810.509641666789, 810.8905297784783, 811.1969150540981, 811.4684881402691, 811.8822770698275, 15760.975536590086, 15987.280572374155, 16568.585785355343, 16737.748933766004, 16927.66144677112, 18199.0, 18565.350212742625, 18570.585823842815, 19156.425307240806, 19163.52091197717, 13702.0, 13946.790798138036, 14071.0, 14089.295535223198, 14107.153570785786, 3345.3476572068457, 3436.3642726095754, 3466.6706662866986, 3470.1845066409373, 3470.340635279314, 86878.13121868827, 91154.54422727844, 91846.0, 92070.53964730134, 92249.53875230649, 14020.789688154686, 14730.484433044792, 14907.478238261609, 14979.400823967137, 15039.774403383957, 27041.594376084373, 27149.321266968484, 27351.452970940867, 27775.0, 28239.717602823708, 8042.235987581171, 8213.835723285501, 8281.29608983231, 8291.170882911661, 8308.584570771438, 4103.179364127186, 4175.0, 4177.164567086595, 4184.4141820145205, 4187.895302617459, 4457.487388950248, 4509.616682582017, 4537.115262523776, 4538.183127037165, 4549.340345649928, 878.4158534574564, 893.7765558610347, 900.0819164452353, 907.6913849291141, 912.1289168843738, 708.4084789201074, 736.830528978338, 737.1228238396292, 746.8356961468468, 774.8338750180942, 11682.24065435744, 12486.75026499465, 12586.937065314614, 12671.17637353569, 12767.808482872764, 724.4892350892608, 737.977860664181, 745.5526683989563, 752.5071078443628, 757.3070640364116, 5403.243545903577, 5672.092465205547, 5697.4587414195585, 5723.599348045597, 5811.15738217956, 71386.28613713797, 71628.28371716216, 73321.59267223126, 74540.62729686426, 87764.0, 65993.34006659967, 66668.0, 68185.65907170532, 68547.65726171338, 69394.0, 54962.72518637381, 55014.449855501734, 55682.0, 57446.138307925416, 62650.37349626537, 12121.69695757613, 13056.738865222453, 13097.279649619362, 13134.60596182116, 13152.408141633457, 32599.511007334433, 32852.0, 33609.663903360655, 33626.83186584051, 35151.64848351484, 39394.40908386319, 39472.40791388074, 40006.1998760029, 40655.59344406636, 41095.0, 16899.746503802206, 16953.491395258163, 16963.915180424017, 16967.236474358437, 16972.06653634062, 18865.622687546445, 18950.52623684419, 19001.389735950124, 19084.14121364514, 19481.512962175493, 17376.91311543434, 17491.650166996842, 17675.911620441817, 17692.52304677372, 18014.279428823225, 17482.213300401767, 17613.559661008578, 17685.557861053578, 17759.55601109931, 18047.458576242734, 15809.920950395175, 15910.60223494422, 16025.519234422985, 16039.0, 16210.594735131715, 12282.75434491323, 12282.87717122853, 12283.508659653513, 12455.626331210078, 12493.18794278369, 12545.372731363577, 12961.0, 12978.654833031858, 13092.607221783363, 13093.41079651437], "value": 8263.0407665716, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1479.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 108.0, 106.0, 110.0, 109.0, 108.0, 108.0, 109.0, 108.0, 108.0], "value": 108.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 116.0, 122.0, 163.0, 116.0, 115.0, 114.0, 115.0, 143.0, 116.0], "value": 127.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 162.0, 162.0, 162.0, 161.0, 161.0, 160.0, 162.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 73.0, 120.0, 74.0, 76.0, 73.0, 74.0, 96.0, 73.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 104.0, 83.0, 84.0, 83.0, 104.0, 82.0, 82.0, 105.0], "value": 89.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 112.0, 113.0, 113.0, 113.0, 113.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 146.0, 149.0, 147.0, 147.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 93.0, 93.0, 94.0, 94.0, 93.0, 93.0, 94.0, 94.0], "value": 93.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 47.0, 47.0, 47.0, 47.0, 50.0, 48.0, 48.0, 49.0, 46.0], "value": 47.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 56.0, 54.0, 56.0, 53.0, 54.0, 54.0, 54.0, 55.0], "value": 54.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 82.0, 81.0, 89.0, 90.0, 81.0, 80.0, 81.0, 80.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 134.0, 125.0, 131.0, 122.0, 125.0, 127.0, 125.0, 169.0, 121.0], "value": 130.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 178.0, 178.0, 185.0, 171.0, 177.0, 174.0, 178.0, 189.0, 181.0], "value": 179.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 66.0, 63.0, 63.0, 65.0, 65.0, 68.0], "value": 64.7, "unit": "score"}]}]} 15:21:24 INFO - Return code: 0 15:21:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:21:24 INFO - # TBPL SUCCESS # 15:21:24 INFO - Running post-action listener: _resource_record_post_action 15:21:24 INFO - [mozharness: 2017-05-08 22:21:24.868047Z] Finished run-tests step (success) 15:21:24 INFO - Running post-run listener: _resource_record_post_run 15:21:24 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 378830848; Read time: 0; Write time: 305268 15:21:24 INFO - TinderboxPrint: CPU usage
12.9% 15:21:24 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 15:21:24 INFO - TinderboxPrint: I/O write bytes / time
378,830,848 / 305,268 15:21:24 INFO - TinderboxPrint: CPU idle
8,277.0 (87.1%) 15:21:24 INFO - TinderboxPrint: CPU user
1,186.6 (12.5%) 15:21:24 INFO - TinderboxPrint: Swap in / out
0 / 0 15:21:24 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 119001088; Read time: 0; Write time: 105580 15:21:24 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 254869504; Read time: 0; Write time: 199364 15:21:25 INFO - Running post-run listener: _upload_blobber_files 15:21:25 INFO - Blob upload gear active. 15:21:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:21:25 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:21:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:21:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:21:25 INFO - (blobuploader) - INFO - Open directory for files ... 15:21:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:21:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:21:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:21:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:21:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:21:26 INFO - (blobuploader) - INFO - Done attempting. 15:21:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:21:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:21:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:21:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:21:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:21:27 INFO - (blobuploader) - INFO - Done attempting. 15:21:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:21:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:21:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:21:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:21:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:21:31 INFO - (blobuploader) - INFO - Done attempting. 15:21:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:21:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:21:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:21:32 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:21:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:21:32 INFO - (blobuploader) - INFO - Done attempting. 15:21:32 INFO - (blobuploader) - INFO - Iteration through files over. 15:21:32 INFO - Return code: 0 15:21:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:21:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:21:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9b995cde2c285487dbc5c19fb470192b59e660b22c9354a69e0e99fcfbb629adf2b13842147cafe503c5acd7f9e8c21a2798d8d8183fd77aaf9e06ff3787dfe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91cfbe9400798bd9be29272dbb5bfebc9527636155489f0a509709f767907e9b0fe563e15d038e7d79902d43aebe45cc02ce2c7c99e17540fc321083257b442a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08f7ba5bf9f6bcdea884c8fc276c99ffa614bcd75b89485f5cdd6fd21d2aa92a6da8aca2400a4538f538ff268e8fadd63e5dbb487e11dda6a1a1d16636875b13", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9930c87a6c3d0d6ab5e88c9a2cda96e49b530e313ef8624decbd1727ef5375caa42940c5712a7d80299bda8ead50cca5921aa5315e4e57c79101b80dbae66b0"} 15:21:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:21:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:21:32 INFO - Contents: 15:21:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9b995cde2c285487dbc5c19fb470192b59e660b22c9354a69e0e99fcfbb629adf2b13842147cafe503c5acd7f9e8c21a2798d8d8183fd77aaf9e06ff3787dfe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91cfbe9400798bd9be29272dbb5bfebc9527636155489f0a509709f767907e9b0fe563e15d038e7d79902d43aebe45cc02ce2c7c99e17540fc321083257b442a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08f7ba5bf9f6bcdea884c8fc276c99ffa614bcd75b89485f5cdd6fd21d2aa92a6da8aca2400a4538f538ff268e8fadd63e5dbb487e11dda6a1a1d16636875b13", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9930c87a6c3d0d6ab5e88c9a2cda96e49b530e313ef8624decbd1727ef5375caa42940c5712a7d80299bda8ead50cca5921aa5315e4e57c79101b80dbae66b0"} 15:21:32 INFO - Running post-run listener: copy_logs_to_upload_dir 15:21:32 INFO - Copying logs to upload dir... 15:21:32 INFO - mkdir: /builds/slave/test/build/upload/logs 15:21:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.388928 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-05-08 15:21:32.005642) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-08 15:21:32.008871) ========= 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=62c568580acbfdaac3eec7be000001dc-1494280843.277378-2014983101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9b995cde2c285487dbc5c19fb470192b59e660b22c9354a69e0e99fcfbb629adf2b13842147cafe503c5acd7f9e8c21a2798d8d8183fd77aaf9e06ff3787dfe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91cfbe9400798bd9be29272dbb5bfebc9527636155489f0a509709f767907e9b0fe563e15d038e7d79902d43aebe45cc02ce2c7c99e17540fc321083257b442a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08f7ba5bf9f6bcdea884c8fc276c99ffa614bcd75b89485f5cdd6fd21d2aa92a6da8aca2400a4538f538ff268e8fadd63e5dbb487e11dda6a1a1d16636875b13", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9930c87a6c3d0d6ab5e88c9a2cda96e49b530e313ef8624decbd1727ef5375caa42940c5712a7d80299bda8ead50cca5921aa5315e4e57c79101b80dbae66b0"} build_url:https://queue.taskcluster.net/v1/task/J-SiESv6RQGICOFXUkGBcg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011312 build_url: 'https://queue.taskcluster.net/v1/task/J-SiESv6RQGICOFXUkGBcg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9b995cde2c285487dbc5c19fb470192b59e660b22c9354a69e0e99fcfbb629adf2b13842147cafe503c5acd7f9e8c21a2798d8d8183fd77aaf9e06ff3787dfe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91cfbe9400798bd9be29272dbb5bfebc9527636155489f0a509709f767907e9b0fe563e15d038e7d79902d43aebe45cc02ce2c7c99e17540fc321083257b442a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08f7ba5bf9f6bcdea884c8fc276c99ffa614bcd75b89485f5cdd6fd21d2aa92a6da8aca2400a4538f538ff268e8fadd63e5dbb487e11dda6a1a1d16636875b13", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9930c87a6c3d0d6ab5e88c9a2cda96e49b530e313ef8624decbd1727ef5375caa42940c5712a7d80299bda8ead50cca5921aa5315e4e57c79101b80dbae66b0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-08 15:21:32.035207) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 15:21:32.035575) ========= 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=62c568580acbfdaac3eec7be000001dc-1494280843.277378-2014983101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004437 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 15:21:32.120800) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-08 15:21:32.121166) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-08 15:21:32.121484) ========= ========= Total master_lag: 0.19 =========