builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-079 starttime: 1490190822.87 results: success (0) revision: ee30286771eb83c0878621485009dc2722daa78f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-22 06:53:42.867137) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-22 06:53:42.867611) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-22 06:53:42.867884) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-22 06:53:42.882758) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 06:53:42.883135) ========= 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=1258088b6da462a47ba2cd90000001a2-1490190822.754585-273925063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-22 06:53: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 32.9M=0s 2017-03-22 06:53:43 (32.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.116685 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 06:53:43.015560) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 06:53:43.016160) ========= 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=1258088b6da462a47ba2cd90000001a2-1490190822.754585-273925063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018520 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 06:53:43.066691) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-22 06:53:43.067104) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ee30286771eb83c0878621485009dc2722daa78f --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 ee30286771eb83c0878621485009dc2722daa78f --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=1258088b6da462a47ba2cd90000001a2-1490190822.754585-273925063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-22 06:53:43,664 truncating revision to first 12 chars 2017-03-22 06:53:43,665 Setting DEBUG logging. 2017-03-22 06:53:43,665 attempt 1/10 2017-03-22 06:53:43,665 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ee30286771eb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-22 06:53:44,815 unpacking tar archive at: mozilla-central-ee30286771eb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.527788 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-22 06:53:44.608361) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-22 06:53:44.608696) ========= script_repo_revision: ee30286771eb83c0878621485009dc2722daa78f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-22 06:53:44.609097) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-22 06:53:44.609413) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-22 06:53:44.618287) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-22 06:53:44.618652) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1258088b6da462a47ba2cd90000001a2-1490190822.754585-273925063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:53:45 INFO - MultiFileLogger online at 20170322 06:53:45 in /builds/slave/test 06:53:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 06:53:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:53:45 INFO - {'append_to_log': False, 06:53:45 INFO - 'base_work_dir': '/builds/slave/test', 06:53:45 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 06:53:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:53:45 INFO - 'branch': 'Firefox-Non-PGO', 06:53:45 INFO - 'buildbot_json_path': 'buildprops.json', 06:53:45 INFO - 'config_files': ('talos/linux_config.py',), 06:53:45 INFO - 'default_actions': ('clobber', 06:53:45 INFO - 'read-buildbot-config', 06:53:45 INFO - 'download-and-extract', 06:53:45 INFO - 'populate-webroot', 06:53:45 INFO - 'create-virtualenv', 06:53:45 INFO - 'install', 06:53:45 INFO - 'run-tests'), 06:53:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:53:45 INFO - 'download_minidump_stackwalk': True, 06:53:45 INFO - 'download_symbols': 'ondemand', 06:53:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:53:45 INFO - 'tooltool.py': '/tools/tooltool.py', 06:53:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:53:45 INFO - '/tools/misc-python/virtualenv.py')}, 06:53:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:53:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:53:45 INFO - 'gecko_profile': False, 06:53:45 INFO - 'gecko_profile_interval': 0, 06:53:45 INFO - 'installer_path': 'installer.exe', 06:53:45 INFO - 'log_level': 'info', 06:53:45 INFO - 'log_name': 'talos', 06:53:45 INFO - 'log_to_console': True, 06:53:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:53:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:53:45 INFO - 'opt_config_files': (), 06:53:45 INFO - 'pip_index': False, 06:53:45 INFO - 'suite': 'dromaeojs-e10s', 06:53:45 INFO - 'system_bits': '32', 06:53:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:53:45 INFO - 'title': 'talos-linux64-ix-079', 06:53:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:53:45 INFO - 'use_talos_json': True, 06:53:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:53:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:53:45 INFO - 'work_dir': 'build'} 06:53:45 INFO - [mozharness: 2017-03-22 13:53:45.323303Z] Running clobber step. 06:53:45 INFO - Running pre-action listener: _resource_record_pre_action 06:53:45 INFO - Running main action method: clobber 06:53:45 INFO - rmtree: /builds/slave/test/build 06:53:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:53:46 INFO - Running post-action listener: _resource_record_post_action 06:53:46 INFO - [mozharness: 2017-03-22 13:53:46.260543Z] Finished clobber step (success) 06:53:46 INFO - [mozharness: 2017-03-22 13:53:46.260645Z] Running read-buildbot-config step. 06:53:46 INFO - Running pre-action listener: _resource_record_pre_action 06:53:46 INFO - Running main action method: read_buildbot_config 06:53:46 INFO - Using buildbot properties: 06:53:46 INFO - { 06:53:46 INFO - "project": "", 06:53:46 INFO - "product": "firefox", 06:53:46 INFO - "who": "cbook@mozilla.com", 06:53:46 INFO - "installer_path": "public/build/target.tar.bz2", 06:53:46 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 06:53:46 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 06:53:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 06:53:46 INFO - "stage_platform": "linux64", 06:53:46 INFO - "basedir": "/builds/slave/test", 06:53:46 INFO - "buildnumber": 478, 06:53:46 INFO - "platform": "ubuntu64_hw", 06:53:46 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:53:46 INFO - "slavebuilddir": "test", 06:53:46 INFO - "taskId": "JyIEeACwTy6DNp4_0QehZQ", 06:53:46 INFO - "branch": "mozilla-central", 06:53:46 INFO - "script_repo_revision": "production", 06:53:46 INFO - "revision": "ee30286771eb83c0878621485009dc2722daa78f", 06:53:46 INFO - "slavename": "talos-linux64-ix-079", 06:53:46 INFO - "repo_path": "mozilla-central" 06:53:46 INFO - } 06:53:46 INFO - Finding installer, test and symbols from parent task. 06:53:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JyIEeACwTy6DNp4_0QehZQ'}, attempt #1 06:53:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JyIEeACwTy6DNp4_0QehZQ'}, attempt #1 06:53:47 INFO - Task dependencies: O7Lvd8wLTGWtJkG55dwpKg 06:53:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O7Lvd8wLTGWtJkG55dwpKg'}, attempt #1 06:53:47 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/O7Lvd8wLTGWtJkG55dwpKg/artifacts/public/build/target.tar.bz2 06:53:47 INFO - Set test_url: https://queue.taskcluster.net/v1/task/O7Lvd8wLTGWtJkG55dwpKg/artifacts/public/build/test_packages.json 06:53:47 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/O7Lvd8wLTGWtJkG55dwpKg/artifacts/public/build/target.crashreporter-symbols.zip 06:53:47 INFO - Running post-action listener: _resource_record_post_action 06:53:47 INFO - [mozharness: 2017-03-22 13:53:47.713675Z] Finished read-buildbot-config step (success) 06:53:47 INFO - [mozharness: 2017-03-22 13:53:47.713890Z] Running download-and-extract step. 06:53:47 INFO - Running pre-action listener: _resource_record_pre_action 06:53:47 INFO - Running main action method: download_and_extract 06:53:47 INFO - mkdir: /builds/slave/test/build/tests 06:53:47 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')]} 06:53:47 INFO - trying https://queue.taskcluster.net/v1/task/O7Lvd8wLTGWtJkG55dwpKg/artifacts/public/build/target.test_packages.json 06:53:47 INFO - Downloading https://queue.taskcluster.net/v1/task/O7Lvd8wLTGWtJkG55dwpKg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:53:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O7Lvd8wLTGWtJkG55dwpKg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:53:48 INFO - Downloaded 986 bytes. 06:53:48 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:53:48 INFO - Using the following test package requirements: 06:53:48 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:53:48 INFO - u'common': [u'target.common.tests.zip'], 06:53:48 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:53:48 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:53:48 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:53:48 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:53:48 INFO - u'mozbase': [u'target.common.tests.zip'], 06:53:48 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:53:48 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:53:48 INFO - u'web-platform': [u'target.common.tests.zip', 06:53:48 INFO - u'target.web-platform.tests.zip'], 06:53:48 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:53:48 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:53:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O7Lvd8wLTGWtJkG55dwpKg/artifacts/public/build/target.common.tests.zip 06:53:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O7Lvd8wLTGWtJkG55dwpKg/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:53:48 INFO - Fetch https://queue.taskcluster.net/v1/task/O7Lvd8wLTGWtJkG55dwpKg/artifacts/public/build/target.common.tests.zip into memory 06:53:49 INFO - Expected file size: 58194579 06:53:49 INFO - Obtained file size: 58194579 06:53:59 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:53:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O7Lvd8wLTGWtJkG55dwpKg/artifacts/public/build/target.common.tests.zip 06:53:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O7Lvd8wLTGWtJkG55dwpKg/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:53:59 INFO - Fetch https://queue.taskcluster.net/v1/task/O7Lvd8wLTGWtJkG55dwpKg/artifacts/public/build/target.common.tests.zip into memory 06:54:00 INFO - Expected file size: 58194579 06:54:00 INFO - Obtained file size: 58194579 06:54:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O7Lvd8wLTGWtJkG55dwpKg/artifacts/public/build/target.talos.tests.zip 06:54:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O7Lvd8wLTGWtJkG55dwpKg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:54:11 INFO - Fetch https://queue.taskcluster.net/v1/task/O7Lvd8wLTGWtJkG55dwpKg/artifacts/public/build/target.talos.tests.zip into memory 06:54:11 INFO - Expected file size: 14404171 06:54:11 INFO - Obtained file size: 14404171 06:54:12 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')]} 06:54:12 INFO - trying https://queue.taskcluster.net/v1/task/O7Lvd8wLTGWtJkG55dwpKg/artifacts/public/build/target.tar.bz2 06:54:12 INFO - Downloading https://queue.taskcluster.net/v1/task/O7Lvd8wLTGWtJkG55dwpKg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:54:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O7Lvd8wLTGWtJkG55dwpKg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:54:13 INFO - Downloaded 61745033 bytes. 06:54:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O7Lvd8wLTGWtJkG55dwpKg/artifacts/public/build/target.tar.bz2 06:54:13 INFO - mkdir: /builds/slave/test/properties 06:54:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:54:13 INFO - Writing to file /builds/slave/test/properties/build_url 06:54:13 INFO - Contents: 06:54:13 INFO - build_url:https://queue.taskcluster.net/v1/task/O7Lvd8wLTGWtJkG55dwpKg/artifacts/public/build/target.tar.bz2 06:54:13 INFO - Running post-action listener: _resource_record_post_action 06:54:13 INFO - Running post-action listener: set_extra_try_arguments 06:54:13 INFO - [mozharness: 2017-03-22 13:54:13.295411Z] Finished download-and-extract step (success) 06:54:13 INFO - [mozharness: 2017-03-22 13:54:13.295507Z] Running populate-webroot step. 06:54:13 INFO - Running pre-action listener: _resource_record_pre_action 06:54:13 INFO - Running main action method: populate_webroot 06:54:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:54:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:54:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:54:13 INFO - '--tppagecycles', 06:54:13 INFO - '7'], 06:54:13 INFO - 'tests': ['tsvgm']}}, 06:54:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:54:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:54:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:54:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:54:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:54:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:54:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:54:13 INFO - 'talos_options': ['--disable-e10s'], 06:54:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:54:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:54:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:54:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:54:13 INFO - 'talos_options': ['--disable-e10s'], 06:54:13 INFO - 'tests': ['damp', 'tps']}, 06:54:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:54:13 INFO - 'tests': ['damp', 'tps']}, 06:54:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:54:13 INFO - 'tests': ['dromaeo_dom']}, 06:54:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:54:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:54:13 INFO - 'tests': ['basic_compositor_video']}, 06:54:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:54:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:54:13 INFO - 'tests': ['a11yr', 06:54:13 INFO - 'ts_paint', 06:54:13 INFO - 'tpaint', 06:54:13 INFO - 'sessionrestore', 06:54:13 INFO - 'sessionrestore_no_auto_restore', 06:54:13 INFO - 'tabpaint']}, 06:54:13 INFO - 'other-e10s': {'tests': ['a11yr', 06:54:13 INFO - 'ts_paint', 06:54:13 INFO - 'tpaint', 06:54:13 INFO - 'sessionrestore', 06:54:13 INFO - 'sessionrestore_no_auto_restore', 06:54:13 INFO - 'tabpaint']}, 06:54:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:54:13 INFO - 'ts_paint', 06:54:13 INFO - 'tpaint', 06:54:13 INFO - 'sessionrestore', 06:54:13 INFO - 'sessionrestore_no_auto_restore', 06:54:13 INFO - 'tabpaint']}, 06:54:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:54:13 INFO - 'ts_paint', 06:54:13 INFO - 'tpaint', 06:54:13 INFO - 'sessionrestore', 06:54:13 INFO - 'sessionrestore_no_auto_restore', 06:54:13 INFO - 'tabpaint']}, 06:54:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:54:13 INFO - 'tests': ['a11yr', 06:54:13 INFO - 'ts_paint', 06:54:13 INFO - 'tpaint', 06:54:13 INFO - 'sessionrestore', 06:54:13 INFO - 'sessionrestore_no_auto_restore', 06:54:13 INFO - 'tabpaint']}, 06:54:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:54:13 INFO - 'tests': ['a11yr', 06:54:13 INFO - 'ts_paint', 06:54:13 INFO - 'tpaint', 06:54:13 INFO - 'sessionrestore', 06:54:13 INFO - 'sessionrestore_no_auto_restore', 06:54:13 INFO - 'tabpaint']}, 06:54:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:54:13 INFO - 'tests': ['tsvgx', 06:54:13 INFO - 'tsvgr_opacity', 06:54:13 INFO - 'tart', 06:54:13 INFO - 'tscrollx', 06:54:13 INFO - 'cart', 06:54:13 INFO - 'tsvg_static']}, 06:54:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:54:13 INFO - 'tsvgr_opacity', 06:54:13 INFO - 'tart', 06:54:13 INFO - 'tscrollx', 06:54:13 INFO - 'cart', 06:54:13 INFO - 'tsvg_static']}, 06:54:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:54:13 INFO - 'talos_options': ['--disable-e10s'], 06:54:13 INFO - 'tests': ['tp5o']}, 06:54:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:54:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:54:13 INFO - 'talos_options': ['--disable-e10s', 06:54:13 INFO - '--xperf_path', 06:54:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:54:13 INFO - 'tests': ['tp5n']}, 06:54:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:54:13 INFO - 'talos_options': ['--xperf_path', 06:54:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:54:13 INFO - 'tests': ['tp5n']}}, 06:54:13 INFO - 'talos.zip': {'path': '', 06:54:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:54:13 INFO - Running post-action listener: _resource_record_post_action 06:54:13 INFO - [mozharness: 2017-03-22 13:54:13.308644Z] Finished populate-webroot step (success) 06:54:13 INFO - [mozharness: 2017-03-22 13:54:13.308733Z] Running create-virtualenv step. 06:54:13 INFO - Running pre-action listener: _resource_record_pre_action 06:54:13 INFO - Running main action method: create_virtualenv 06:54:13 INFO - Creating virtualenv /builds/slave/test/build/venv 06:54:13 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 06:54:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:54:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:54:13 INFO - Using real prefix '/usr' 06:54:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:54:13 INFO - Installing distribute.............................................................................................................................................................................................done. 06:54:15 INFO - Installing pip.................done. 06:54:15 INFO - Return code: 0 06:54:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:54:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:54:16 INFO - Reading from file tmpfile_stdout 06:54:16 INFO - Output received: 06:54: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) 06:54:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:54: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')]} 06:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54: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')]} 06:54:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54: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 0x1e0a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a5290>, '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 0x20a5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a6040>, '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': '1258088b6da462a47ba2cd90000001a2-1490190822.754585-273925063', '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 06:54: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 06:54: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 06:54:16 INFO - Using env: {'DISPLAY': ':0', 06:54:16 INFO - 'HOME': '/home/cltbld', 06:54:16 INFO - 'LANG': 'en_US.UTF-8', 06:54:16 INFO - 'LANGUAGE': 'en_US:en', 06:54:16 INFO - 'LOGNAME': 'cltbld', 06:54:16 INFO - 'MAIL': '/var/mail/cltbld', 06:54:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:16 INFO - 'MOZ_NO_REMOTE': '1', 06:54:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:16 INFO - 'NO_EM_RESTART': '1', 06:54:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:16 INFO - 'PWD': '/builds/slave/test', 06:54:16 INFO - 'SHELL': '/bin/bash', 06:54:16 INFO - 'SHLVL': '1', 06:54:16 INFO - 'TERM': 'linux', 06:54:16 INFO - 'TMOUT': '86400', 06:54:16 INFO - 'USER': 'cltbld', 06:54:16 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1490190822.754585-273925063', 06:54:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:16 INFO - '_': '/tools/buildbot/bin/python'} 06:54:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:16 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 06:54:16 INFO - Cleaning up... 06:54:16 INFO - Return code: 0 06:54:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:54: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')]} 06:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54: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')]} 06:54:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54: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', '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 0x1e0a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a5290>, '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 0x20a5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a6040>, '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': '1258088b6da462a47ba2cd90000001a2-1490190822.754585-273925063', '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 06:54: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', 'psutil>=3.1.1'] in /builds/slave/test/build 06:54: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 psutil>=3.1.1 06:54:16 INFO - Using env: {'DISPLAY': ':0', 06:54:16 INFO - 'HOME': '/home/cltbld', 06:54:16 INFO - 'LANG': 'en_US.UTF-8', 06:54:16 INFO - 'LANGUAGE': 'en_US:en', 06:54:16 INFO - 'LOGNAME': 'cltbld', 06:54:16 INFO - 'MAIL': '/var/mail/cltbld', 06:54:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:16 INFO - 'MOZ_NO_REMOTE': '1', 06:54:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:16 INFO - 'NO_EM_RESTART': '1', 06:54:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:16 INFO - 'PWD': '/builds/slave/test', 06:54:16 INFO - 'SHELL': '/bin/bash', 06:54:16 INFO - 'SHLVL': '1', 06:54:16 INFO - 'TERM': 'linux', 06:54:16 INFO - 'TMOUT': '86400', 06:54:16 INFO - 'USER': 'cltbld', 06:54:16 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1490190822.754585-273925063', 06:54:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:16 INFO - '_': '/tools/buildbot/bin/python'} 06:54:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:16 INFO - Downloading/unpacking psutil>=3.1.1 06:54:16 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 06:54:16 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 06:54:16 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 06:54:16 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 06:54:16 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 06:54:16 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 06:54:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:54:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:54:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:54:18 INFO - Installing collected packages: psutil 06:54:18 INFO - Running setup.py install for psutil 06:54:18 INFO - building 'psutil._psutil_linux' extension 06:54: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 06:54: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 06:54:18 INFO - building 'psutil._psutil_posix' extension 06:54: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 06:54: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 06:54:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:54:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:54:19 INFO - Successfully installed psutil 06:54:19 INFO - Cleaning up... 06:54:19 INFO - Return code: 0 06:54:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:54: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')]} 06:54:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54: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')]} 06:54:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54: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 0x1e0a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a5290>, '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 0x20a5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a6040>, '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': '1258088b6da462a47ba2cd90000001a2-1490190822.754585-273925063', '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 06:54: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 06:54: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 06:54:19 INFO - Using env: {'DISPLAY': ':0', 06:54:19 INFO - 'HOME': '/home/cltbld', 06:54:19 INFO - 'LANG': 'en_US.UTF-8', 06:54:19 INFO - 'LANGUAGE': 'en_US:en', 06:54:19 INFO - 'LOGNAME': 'cltbld', 06:54:19 INFO - 'MAIL': '/var/mail/cltbld', 06:54:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:19 INFO - 'MOZ_NO_REMOTE': '1', 06:54:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:19 INFO - 'NO_EM_RESTART': '1', 06:54:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:19 INFO - 'PWD': '/builds/slave/test', 06:54:19 INFO - 'SHELL': '/bin/bash', 06:54:19 INFO - 'SHLVL': '1', 06:54:19 INFO - 'TERM': 'linux', 06:54:19 INFO - 'TMOUT': '86400', 06:54:19 INFO - 'USER': 'cltbld', 06:54:19 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1490190822.754585-273925063', 06:54:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:19 INFO - '_': '/tools/buildbot/bin/python'} 06:54:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:54: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 06:54: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 06:54: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 06:54: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 06:54: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 06:54: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 06:54:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:54:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:54:21 INFO - Installing collected packages: mozsystemmonitor 06:54:21 INFO - Running setup.py install for mozsystemmonitor 06:54:21 INFO - Successfully installed mozsystemmonitor 06:54:21 INFO - Cleaning up... 06:54:21 INFO - Return code: 0 06:54:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:54:21 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')]} 06:54:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:21 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')]} 06:54:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:21 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 0x1e0a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a5290>, '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 0x20a5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a6040>, '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': '1258088b6da462a47ba2cd90000001a2-1490190822.754585-273925063', '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 06:54:21 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 06:54:21 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 06:54:21 INFO - Using env: {'DISPLAY': ':0', 06:54:21 INFO - 'HOME': '/home/cltbld', 06:54:21 INFO - 'LANG': 'en_US.UTF-8', 06:54:21 INFO - 'LANGUAGE': 'en_US:en', 06:54:21 INFO - 'LOGNAME': 'cltbld', 06:54:21 INFO - 'MAIL': '/var/mail/cltbld', 06:54:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:21 INFO - 'MOZ_NO_REMOTE': '1', 06:54:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:21 INFO - 'NO_EM_RESTART': '1', 06:54:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:21 INFO - 'PWD': '/builds/slave/test', 06:54:21 INFO - 'SHELL': '/bin/bash', 06:54:21 INFO - 'SHLVL': '1', 06:54:21 INFO - 'TERM': 'linux', 06:54:21 INFO - 'TMOUT': '86400', 06:54:21 INFO - 'USER': 'cltbld', 06:54:21 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1490190822.754585-273925063', 06:54:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:21 INFO - '_': '/tools/buildbot/bin/python'} 06:54:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:21 INFO - Downloading/unpacking jsonschema==2.5.1 06:54:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:54:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:54: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 06:54: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 06:54: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 06:54: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 06:54: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 06:54: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 06:54:24 INFO - Downloading functools32-3.2.3-2.tar.gz 06:54:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:54:24 INFO - warning: no files found matching '*.txt' 06:54:24 INFO - no previously-included directories found matching 'build' 06:54:24 INFO - no previously-included directories found matching 'dist' 06:54:24 INFO - no previously-included directories found matching '.git*' 06:54:24 INFO - Installing collected packages: jsonschema, functools32 06:54:24 INFO - Running setup.py install for functools32 06:54:24 INFO - warning: no files found matching '*.txt' 06:54:24 INFO - no previously-included directories found matching 'build' 06:54:24 INFO - no previously-included directories found matching 'dist' 06:54:24 INFO - no previously-included directories found matching '.git*' 06:54:24 INFO - Successfully installed jsonschema functools32 06:54:24 INFO - Cleaning up... 06:54:24 INFO - Return code: 0 06:54:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1e0a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a5290>, '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 0x20a5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a6040>, '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': '1258088b6da462a47ba2cd90000001a2-1490190822.754585-273925063', '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 06:54:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:54:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:54:24 INFO - Using env: {'DISPLAY': ':0', 06:54:24 INFO - 'HOME': '/home/cltbld', 06:54:24 INFO - 'LANG': 'en_US.UTF-8', 06:54:24 INFO - 'LANGUAGE': 'en_US:en', 06:54:24 INFO - 'LOGNAME': 'cltbld', 06:54:24 INFO - 'MAIL': '/var/mail/cltbld', 06:54:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:24 INFO - 'MOZ_NO_REMOTE': '1', 06:54:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:24 INFO - 'NO_EM_RESTART': '1', 06:54:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:24 INFO - 'PWD': '/builds/slave/test', 06:54:24 INFO - 'SHELL': '/bin/bash', 06:54:24 INFO - 'SHLVL': '1', 06:54:24 INFO - 'TERM': 'linux', 06:54:24 INFO - 'TMOUT': '86400', 06:54:24 INFO - 'USER': 'cltbld', 06:54:24 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1490190822.754585-273925063', 06:54:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:24 INFO - '_': '/tools/buildbot/bin/python'} 06:54:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:54:24 INFO - Cleaning up... 06:54:24 INFO - Return code: 0 06:54:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1e0a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a5290>, '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 0x20a5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a6040>, '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': '1258088b6da462a47ba2cd90000001a2-1490190822.754585-273925063', '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 06:54:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:54:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:54:24 INFO - Using env: {'DISPLAY': ':0', 06:54:24 INFO - 'HOME': '/home/cltbld', 06:54:24 INFO - 'LANG': 'en_US.UTF-8', 06:54:24 INFO - 'LANGUAGE': 'en_US:en', 06:54:24 INFO - 'LOGNAME': 'cltbld', 06:54:24 INFO - 'MAIL': '/var/mail/cltbld', 06:54:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:24 INFO - 'MOZ_NO_REMOTE': '1', 06:54:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:24 INFO - 'NO_EM_RESTART': '1', 06:54:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:24 INFO - 'PWD': '/builds/slave/test', 06:54:24 INFO - 'SHELL': '/bin/bash', 06:54:24 INFO - 'SHLVL': '1', 06:54:24 INFO - 'TERM': 'linux', 06:54:24 INFO - 'TMOUT': '86400', 06:54:24 INFO - 'USER': 'cltbld', 06:54:24 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1490190822.754585-273925063', 06:54:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:24 INFO - '_': '/tools/buildbot/bin/python'} 06:54:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:24 INFO - Downloading/unpacking blobuploader==1.2.4 06:54:24 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 06:54:24 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 06:54:24 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 06:54:24 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 06:54:24 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 06:54:24 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 06:54:26 INFO - Downloading blobuploader-1.2.4.tar.gz 06:54:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:54:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:54:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:54:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:54:27 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 06:54:27 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 06:54:27 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 06:54:27 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 06:54:27 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 06:54:27 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 06:54:27 INFO - Downloading docopt-0.6.1.tar.gz 06:54:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:54:27 INFO - Installing collected packages: blobuploader, requests, docopt 06:54:27 INFO - Running setup.py install for blobuploader 06:54:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:54:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:54:27 INFO - Running setup.py install for requests 06:54:28 INFO - Running setup.py install for docopt 06:54:28 INFO - Successfully installed blobuploader requests docopt 06:54:28 INFO - Cleaning up... 06:54:28 INFO - Return code: 0 06:54:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:54:28 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')]} 06:54:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:28 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')]} 06:54:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:28 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 0x1e0a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a5290>, '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 0x20a5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a6040>, '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': '1258088b6da462a47ba2cd90000001a2-1490190822.754585-273925063', '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 06:54:28 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 06:54:28 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 06:54:28 INFO - Using env: {'DISPLAY': ':0', 06:54:28 INFO - 'HOME': '/home/cltbld', 06:54:28 INFO - 'LANG': 'en_US.UTF-8', 06:54:28 INFO - 'LANGUAGE': 'en_US:en', 06:54:28 INFO - 'LOGNAME': 'cltbld', 06:54:28 INFO - 'MAIL': '/var/mail/cltbld', 06:54:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:28 INFO - 'MOZ_NO_REMOTE': '1', 06:54:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:28 INFO - 'NO_EM_RESTART': '1', 06:54:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:28 INFO - 'PWD': '/builds/slave/test', 06:54:28 INFO - 'SHELL': '/bin/bash', 06:54:28 INFO - 'SHLVL': '1', 06:54:28 INFO - 'TERM': 'linux', 06:54:28 INFO - 'TMOUT': '86400', 06:54:28 INFO - 'USER': 'cltbld', 06:54:28 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1490190822.754585-273925063', 06:54:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:28 INFO - '_': '/tools/buildbot/bin/python'} 06:54:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:54:28 INFO - Running setup.py (path:/tmp/pip-4rRJQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:54:28 INFO - Running setup.py (path:/tmp/pip-GbNZpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:54:28 INFO - Running setup.py (path:/tmp/pip-ZSXHH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:54:28 INFO - Running setup.py (path:/tmp/pip-gcqjO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:54:28 INFO - Running setup.py (path:/tmp/pip-E3GquV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:54:28 INFO - Running setup.py (path:/tmp/pip-XWvMr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:54:28 INFO - Running setup.py (path:/tmp/pip-t0yqE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:54:28 INFO - Running setup.py (path:/tmp/pip-_qiBF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:54:29 INFO - Running setup.py (path:/tmp/pip-p8redD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:54:29 INFO - Running setup.py (path:/tmp/pip-rFDQ61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:54:29 INFO - Running setup.py (path:/tmp/pip-aU6hc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:54:29 INFO - Running setup.py (path:/tmp/pip-aCOI1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:54:29 INFO - Running setup.py (path:/tmp/pip-O9Kgy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:54:29 INFO - Running setup.py (path:/tmp/pip-XsS6Fu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:54:29 INFO - Running setup.py (path:/tmp/pip-DAxZJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:54:29 INFO - Running setup.py (path:/tmp/pip-VgBzJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:54:29 INFO - Running setup.py (path:/tmp/pip-KR41y6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:54:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:54:29 INFO - Running setup.py install for manifestparser 06:54:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:54:29 INFO - Running setup.py install for mozcrash 06:54:29 INFO - Running setup.py install for mozdebug 06:54:29 INFO - Running setup.py install for mozdevice 06:54:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:54:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:54:30 INFO - Running setup.py install for mozfile 06:54:30 INFO - Running setup.py install for mozhttpd 06:54:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:54:30 INFO - Running setup.py install for mozinfo 06:54:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:54:30 INFO - Running setup.py install for mozInstall 06:54:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:54:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:54:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:54:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:54:30 INFO - Running setup.py install for mozleak 06:54:30 INFO - Running setup.py install for mozlog 06:54:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:54:30 INFO - Running setup.py install for moznetwork 06:54:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:54:30 INFO - Running setup.py install for mozprocess 06:54:30 INFO - Running setup.py install for mozprofile 06:54:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:54:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:54:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:54:31 INFO - Running setup.py install for mozrunner 06:54:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:54:31 INFO - Running setup.py install for mozscreenshot 06:54:31 INFO - Running setup.py install for moztest 06:54:31 INFO - Running setup.py install for mozversion 06:54:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:54:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:54:31 INFO - Cleaning up... 06:54:31 INFO - Return code: 0 06:54:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:54:31 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')]} 06:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:31 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')]} 06:54:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:31 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 0x1e0a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a5290>, '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 0x20a5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a6040>, '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': '1258088b6da462a47ba2cd90000001a2-1490190822.754585-273925063', '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 06:54:31 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 06:54:31 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 06:54:31 INFO - Using env: {'DISPLAY': ':0', 06:54:31 INFO - 'HOME': '/home/cltbld', 06:54:31 INFO - 'LANG': 'en_US.UTF-8', 06:54:31 INFO - 'LANGUAGE': 'en_US:en', 06:54:31 INFO - 'LOGNAME': 'cltbld', 06:54:31 INFO - 'MAIL': '/var/mail/cltbld', 06:54:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:31 INFO - 'MOZ_NO_REMOTE': '1', 06:54:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:31 INFO - 'NO_EM_RESTART': '1', 06:54:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:31 INFO - 'PWD': '/builds/slave/test', 06:54:31 INFO - 'SHELL': '/bin/bash', 06:54:31 INFO - 'SHLVL': '1', 06:54:31 INFO - 'TERM': 'linux', 06:54:31 INFO - 'TMOUT': '86400', 06:54:31 INFO - 'USER': 'cltbld', 06:54:31 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1490190822.754585-273925063', 06:54:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:31 INFO - '_': '/tools/buildbot/bin/python'} 06:54:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:54:31 INFO - Running setup.py (path:/tmp/pip-0m3mzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:54:31 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)) 06:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:54:31 INFO - Running setup.py (path:/tmp/pip-fES89T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:54:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:54:31 INFO - Running setup.py (path:/tmp/pip-IzBRRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:54:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:54:31 INFO - Running setup.py (path:/tmp/pip-jpsbm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:54:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:54:31 INFO - Running setup.py (path:/tmp/pip-_Xcy0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:54:32 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)) 06:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:54:32 INFO - Running setup.py (path:/tmp/pip-uD4bwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:54:32 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)) 06:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:54:32 INFO - Running setup.py (path:/tmp/pip-uw26Dt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:54:32 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)) 06:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:54:32 INFO - Running setup.py (path:/tmp/pip-mqOQ9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:54:32 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)) 06:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:54:32 INFO - Running setup.py (path:/tmp/pip-bEa1KJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:54:32 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)) 06:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:54:32 INFO - Running setup.py (path:/tmp/pip-mthKxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:54:32 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)) 06:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:54:32 INFO - Running setup.py (path:/tmp/pip-aLPm0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:54:32 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)) 06:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:54:32 INFO - Running setup.py (path:/tmp/pip-U6sdua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:54:32 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)) 06:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:54:32 INFO - Running setup.py (path:/tmp/pip-05qSdi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:54:32 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)) 06:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:54:32 INFO - Running setup.py (path:/tmp/pip-YwnWNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:54:32 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)) 06:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:54:32 INFO - Running setup.py (path:/tmp/pip-dNuleo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:54:32 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)) 06:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:54:32 INFO - Running setup.py (path:/tmp/pip-nvV1Fo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:54:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:54:32 INFO - Running setup.py (path:/tmp/pip-CxhrBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:54:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:54:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:54:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:54:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:54:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:54:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:54:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:54:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:34 INFO - Downloading blessings-1.6.tar.gz 06:54:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:54:35 INFO - Installing collected packages: blessings 06:54:35 INFO - Running setup.py install for blessings 06:54:35 INFO - Successfully installed blessings 06:54:35 INFO - Cleaning up... 06:54:35 INFO - Return code: 0 06:54:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:54:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:54:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:54:35 INFO - Reading from file tmpfile_stdout 06:54:35 INFO - Current package versions: 06:54:35 INFO - argparse == 1.2.1 06:54:35 INFO - blessings == 1.6 06:54:35 INFO - blobuploader == 1.2.4 06:54:35 INFO - docopt == 0.6.1 06:54:35 INFO - functools32 == 3.2.3-2 06:54:35 INFO - jsonschema == 2.5.1 06:54:35 INFO - manifestparser == 1.1 06:54:35 INFO - mozInstall == 1.12 06:54:35 INFO - mozcrash == 1.0 06:54:35 INFO - mozdebug == 0.1 06:54:35 INFO - mozdevice == 0.49 06:54:35 INFO - mozfile == 1.2 06:54:35 INFO - mozhttpd == 0.7 06:54:35 INFO - mozinfo == 0.9 06:54:35 INFO - mozleak == 0.1 06:54:35 INFO - mozlog == 3.4 06:54:35 INFO - moznetwork == 0.27 06:54:35 INFO - mozprocess == 0.25 06:54:35 INFO - mozprofile == 0.28 06:54:35 INFO - mozrunner == 6.13 06:54:35 INFO - mozscreenshot == 0.1 06:54:35 INFO - mozsystemmonitor == 0.3 06:54:35 INFO - moztest == 0.8 06:54:35 INFO - mozversion == 1.4 06:54:35 INFO - psutil == 3.1.1 06:54:35 INFO - requests == 1.2.3 06:54:35 INFO - wsgiref == 0.1.2 06:54:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:54:35 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')]} 06:54:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:35 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')]} 06:54:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:35 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 0x1e0a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a5290>, '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 0x20a5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a6040>, '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': '1258088b6da462a47ba2cd90000001a2-1490190822.754585-273925063', '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 06:54:35 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 06:54:35 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 06:54:35 INFO - Using env: {'DISPLAY': ':0', 06:54:35 INFO - 'HOME': '/home/cltbld', 06:54:35 INFO - 'LANG': 'en_US.UTF-8', 06:54:35 INFO - 'LANGUAGE': 'en_US:en', 06:54:35 INFO - 'LOGNAME': 'cltbld', 06:54:35 INFO - 'MAIL': '/var/mail/cltbld', 06:54:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:35 INFO - 'MOZ_NO_REMOTE': '1', 06:54:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:35 INFO - 'NO_EM_RESTART': '1', 06:54:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:35 INFO - 'PWD': '/builds/slave/test', 06:54:35 INFO - 'SHELL': '/bin/bash', 06:54:35 INFO - 'SHLVL': '1', 06:54:35 INFO - 'TERM': 'linux', 06:54:35 INFO - 'TMOUT': '86400', 06:54:35 INFO - 'USER': 'cltbld', 06:54:35 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1490190822.754585-273925063', 06:54:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:35 INFO - '_': '/tools/buildbot/bin/python'} 06:54:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:35 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)) 06:54:35 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)) 06:54:35 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)) 06:54:35 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)) 06:54:35 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)) 06:54:35 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)) 06:54:35 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)) 06:54:35 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)) 06:54:35 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)) 06:54:35 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)) 06:54:35 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)) 06:54:35 INFO - Cleaning up... 06:54:35 INFO - Return code: 0 06:54:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:54:35 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')]} 06:54:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:35 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')]} 06:54:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:35 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 0x1e0a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a5290>, '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 0x20a5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a6040>, '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': '1258088b6da462a47ba2cd90000001a2-1490190822.754585-273925063', '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 06:54:35 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 06:54:35 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 06:54:35 INFO - Using env: {'DISPLAY': ':0', 06:54:35 INFO - 'HOME': '/home/cltbld', 06:54:35 INFO - 'LANG': 'en_US.UTF-8', 06:54:35 INFO - 'LANGUAGE': 'en_US:en', 06:54:35 INFO - 'LOGNAME': 'cltbld', 06:54:35 INFO - 'MAIL': '/var/mail/cltbld', 06:54:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:35 INFO - 'MOZ_NO_REMOTE': '1', 06:54:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:35 INFO - 'NO_EM_RESTART': '1', 06:54:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:35 INFO - 'PWD': '/builds/slave/test', 06:54:35 INFO - 'SHELL': '/bin/bash', 06:54:35 INFO - 'SHLVL': '1', 06:54:35 INFO - 'TERM': 'linux', 06:54:35 INFO - 'TMOUT': '86400', 06:54:35 INFO - 'USER': 'cltbld', 06:54:35 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1490190822.754585-273925063', 06:54:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:35 INFO - '_': '/tools/buildbot/bin/python'} 06:54:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:54:35 INFO - Cleaning up... 06:54:35 INFO - Return code: 0 06:54:35 INFO - Running post-action listener: _resource_record_post_action 06:54:35 INFO - Running post-action listener: _start_resource_monitoring 06:54:35 INFO - Starting resource monitoring. 06:54:35 INFO - [mozharness: 2017-03-22 13:54:35.905209Z] Finished create-virtualenv step (success) 06:54:35 INFO - [mozharness: 2017-03-22 13:54:35.905729Z] Running install step. 06:54:35 INFO - Running pre-action listener: _resource_record_pre_action 06:54:35 INFO - Running main action method: install 06:54:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:54:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:54:36 INFO - Reading from file tmpfile_stdout 06:54:36 INFO - Detecting whether we're running mozinstall >=1.0... 06:54:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:54:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:54:36 INFO - Reading from file tmpfile_stdout 06:54:36 INFO - Output received: 06:54:36 INFO - Usage: mozinstall [options] installer 06:54:36 INFO - Options: 06:54:36 INFO - -h, --help show this help message and exit 06:54:36 INFO - -d DEST, --destination=DEST 06:54:36 INFO - Directory to install application into. [default: 06:54:36 INFO - "/builds/slave/test"] 06:54:36 INFO - --app=APP Application being installed. [default: firefox] 06:54:36 INFO - mkdir: /builds/slave/test/build/application 06:54:36 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'] 06:54:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:54:51 INFO - Reading from file tmpfile_stdout 06:54:51 INFO - Output received: 06:54:51 INFO - /builds/slave/test/build/application/firefox/firefox 06:54:51 INFO - Running post-action listener: _resource_record_post_action 06:54:51 INFO - [mozharness: 2017-03-22 13:54:51.660358Z] Finished install step (success) 06:54:51 INFO - [mozharness: 2017-03-22 13:54:51.660698Z] Running run-tests step. 06:54:51 INFO - Running pre-action listener: _resource_record_pre_action 06:54:51 INFO - Running main action method: run_tests 06:54:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:54:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:54:51 INFO - Python 2.7.3 06:54:51 INFO - Return code: 0 06:54:51 INFO - grabbing minidump binary from tooltool 06:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:51 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a5290>, '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 0x20a5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a6040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:54:51 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:54:51 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:54:51 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:54:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:54:51 INFO - Return code: 0 06:54:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:54:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:54:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:54:51 INFO - ENV: RUST_BACKTRACE is now 1 06:54:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:54:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:54:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O7Lvd8wLTGWtJkG55dwpKg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-079', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:54:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/O7Lvd8wLTGWtJkG55dwpKg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-079 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:54:51 INFO - Using env: {'DISPLAY': ':0', 06:54:51 INFO - 'HOME': '/home/cltbld', 06:54:51 INFO - 'LANG': 'en_US.UTF-8', 06:54:51 INFO - 'LANGUAGE': 'en_US:en', 06:54:51 INFO - 'LOGNAME': 'cltbld', 06:54:51 INFO - 'MAIL': '/var/mail/cltbld', 06:54:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:54:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:54:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:51 INFO - 'MOZ_NO_REMOTE': '1', 06:54:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:54:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:51 INFO - 'NO_EM_RESTART': '1', 06:54:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:51 INFO - 'PWD': '/builds/slave/test', 06:54:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:54:51 INFO - 'RUST_BACKTRACE': '1', 06:54:51 INFO - 'SHELL': '/bin/bash', 06:54:51 INFO - 'SHLVL': '1', 06:54:51 INFO - 'TERM': 'linux', 06:54:51 INFO - 'TMOUT': '86400', 06:54:51 INFO - 'USER': 'cltbld', 06:54:51 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1490190822.754585-273925063', 06:54:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:51 INFO - '_': '/tools/buildbot/bin/python'} 06:54:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O7Lvd8wLTGWtJkG55dwpKg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-079', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:54:51 INFO - mozversion application_buildid: 20170322132507 06:54:51 INFO - mozversion application_changeset: ee30286771eb83c0878621485009dc2722daa78f 06:54:51 INFO - mozversion application_display_name: Nightly 06:54:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:54:51 INFO - mozversion application_name: Firefox 06:54:51 INFO - mozversion application_remotingname: firefox 06:54:51 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:54:51 INFO - mozversion application_vendor: Mozilla 06:54:51 INFO - mozversion application_version: 55.0a1 06:54:51 INFO - mozversion platform_buildid: 20170322132507 06:54:51 INFO - mozversion platform_changeset: ee30286771eb83c0878621485009dc2722daa78f 06:54:51 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:54:51 INFO - mozversion platform_version: 55.0a1 06:54:51 INFO - using testdate: 1490190891 06:54:51 INFO - actual date: 1490190891 06:54:51 INFO - starting webserver on 'localhost:34025' 06:54:51 INFO - SUITE-START | Running 2 tests 06:54:51 INFO - TEST-START | dromaeo_css 06:54:51 INFO - operating with platform_type : linux_ 06:54:51 INFO - Initialising browser for dromaeo_css test... 06:54:51 INFO - TEST-INFO | started process 25541 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMwGQEF/profile http://localhost:34025/getInfo.html) 06:54:56 INFO - PID 25541 | __metrics Screen width/height:1600/1200 06:54:56 INFO - PID 25541 | colorDepth:24 06:54:56 INFO - PID 25541 | Browser inner width/height: 1024/697 06:54:56 INFO - PID 25541 | __metrics 06:54:57 ERROR - PID 25541 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 06:54:58 INFO - TEST-INFO | 25541: exit 0 06:54:58 INFO - Browser initialized. 06:54:58 INFO - Running cycle 1/1 for dromaeo_css test... 06:54:58 INFO - TEST-INFO | started process 25673 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMwGQEF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:55:10 INFO - PID 25673 | RSS: Main: 155082752 06:55:10 INFO - PID 25673 | 06:58:15 INFO - PID 25673 | Cycle 1(1): loaded http://localhost:34025/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34025/tests/dromaeo/cssquery-ext.html) 06:58:17 INFO - PID 25673 | RSS: Main: 166260736 06:58:17 INFO - PID 25673 | 06:59:59 INFO - PID 25673 | ************************* 06:59:59 INFO - PID 25673 | A coding exception was thrown and uncaught in a Task. 06:59:59 INFO - PID 25673 | 06:59:59 ERROR - PID 25673 | Full message: TypeError: NetworkError when attempting to fetch resource. 06:59:59 INFO - PID 25673 | Full stack: 06:59:59 INFO - PID 25673 | ************************* 07:01:19 INFO - PID 25673 | Cycle 1(1): loaded http://localhost:34025/tests/dromaeo/cssquery-ext.html (next: http://localhost:34025/tests/dromaeo/cssquery-jquery.html) 07:01:20 INFO - PID 25673 | RSS: Main: 160186368 07:01:20 INFO - PID 25673 | 07:04:22 INFO - PID 25673 | Cycle 1(1): loaded http://localhost:34025/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34025/tests/dromaeo/cssquery-mootools.html) 07:04:22 INFO - PID 25673 | RSS: Main: 168701952 07:04:22 INFO - PID 25673 | 07:07:24 INFO - PID 25673 | Cycle 1(1): loaded http://localhost:34025/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34025/tests/dromaeo/cssquery-prototype.html) 07:07:25 INFO - PID 25673 | RSS: Main: 160169984 07:07:25 INFO - PID 25673 | 07:10:28 INFO - PID 25673 | Cycle 1(1): loaded http://localhost:34025/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34025/tests/dromaeo/cssquery-yui.html) 07:10:29 INFO - PID 25673 | RSS: Main: 167899136 07:10:29 INFO - PID 25673 | 07:13:32 INFO - PID 25673 | Cycle 1(1): loaded http://localhost:34025/tests/dromaeo/cssquery-yui.html (next: http://localhost:34025/tests/dromaeo/cssquery-dojo.html) 07:13:32 INFO - PID 25673 | RSS: Main: 162168832 07:13:32 INFO - PID 25673 | 07:13:32 INFO - PID 25673 | __start_tp_report 07:13:32 INFO - PID 25673 | _x_x_mozilla_page_load 07:13:32 INFO - PID 25673 | _x_x_mozilla_page_load_details 07:13:32 INFO - PID 25673 | |i|pagename|runs| 07:13:32 INFO - PID 25673 | |0;dojo.html;2713.81003329767;2723.727627237276;2727.318170457386;2751.490974169778;2755.6417665703457;5214.713190774506;5225.477452254778;5258;5289.391719952207;5310.548603368714;5261.710605916673;5278.894422111565;5308.150695888658;5332;5372.328458942632;4776.164171270023;4824.035192961404;4826.734529600871;4850.442199147108;4873.975630121844;4856.732879691615;4883.1698611236;4908.631852611051;4911.778969946361;4950.55445009949;4738.1708201064675;4775.6657034007285;4780.282957556395;4821.54195351441;4837.927431088537;4753.096911586787;4797.2564252540915;4809.78355973982;4841.298011788306;4850.199717046683;4665.906681866344;4732.645051621143;4762.809487620491;4768.880777980544;4776.355192049064;5189.792408303663;5209.1404918188455;5221.321228240343;5238.345206849144;5301.946980530184;5679.432056794288;5680.971595142039;5725.627834190765;5730.856728581819;5737.942620573783;5692.5161361284345;5710.114932185518;5711.485966263015;5719.342275638313;5739.799107031234;5212.139996900469;5279.947200527946;5305.62860599762;5316;5365.490278423544;5683;5767.625104368202;5768.884622307531;5785.30576330843;5787.045137552341;5539.639923405047;5547.889042219133;5585.329760428694;5621.100623900238;5634.267545219177;5630.774769009194;5651.180578816049;5656.519195868315;5664.886702266014;5672.064109421982;5605.1872478491205;5606.523445507178;5607.271054762855;5613.10190369547;5613.971930140323;5510.448955104457;5583.134614134734;5625;5681;5710.371859095496;4729.7398643074275;4730.455997560256;4734.076855013308;4759.809607615726;4781.306710526954;4050.736702114353;4058.2695114879016;4059.188162367538;4094.324436468009;4114.321137012359;4803.303520989437;4859.757012149378;4874.46380898101;4885.755712214375;4907.950920490821;5726.226959360433;5729.369769325371;5765.971170144123;5774.566907481872;5786.218860453869;4831.73425461596;4868.02639472107;4869.537393947569;4878.195097808893;4908.950910490921;4985.90028199434;5036.219385995177;5068.695878247317;5071.163258062378;5082.440931497532;5292.047431462373;5300.390455097713;5302.946970530245;5303.920441193308;5306.097963346318;5660.660360378391;5727.284089488814;5733.0540460823495;5733.598648094593;5739.971300143639;5288.576913846806;5334.386545547157;5370.113931201464;5378.247045413567;5401.648892821954;5546.306711661043;5547.44525547442;5593.804216852391;5597.832065038056;5598.412166722435;5681.772729090955;5686.147077938343;5690.3456102548735;5693.572982026448;5695.430456954271;5441.863953401196;5466.3713672928125;5498.972505137449;5532.529734972572;5596.496315331639;5513.61404701667;5526.696031718294;5530;5541.224228607917;5564.638298510584;5376.596755243294;5416.187571864252;5441.619086663895;5464.316960379952;5497.697626630574;5473.261109750292;5539.41836107219;5559.833205003856;5582.637128586629;5649.745761440828;5419.268398766274;5420.728963551728;5423;5450.182472628979;5472.179173124063 07:13:32 INFO - PID 25673 | |1;ext.html;643.3405759096925;714.2928500784224;735.8675438421084;1011.4487604255685;1032.1536340201037;30707.69292307076;31610.367792644134;31764.523532147035;31777.682223177762;31809.840950795242;31972.68027319726;32238.516422253626;32268.35463290733;32505.187370315754;32565;7254.129504459473;7304.306090921381;7435.479516433852;7443.106827180746;7449.180590135081;7381.88927166093;7391.593462359568;7472.4395670324675;7497.73757918473;7500.962495187544;7428.814279643025;7447.962760186191;7501.699932002741;7666.961665191666;7681.50070245435;7593.506422082547;7604.277593628596;7610.7336243231775;7620.542767433972;7636.503627264266;7479.887801682979;7493.812654683622;7512.835510495882;7529.661165247522;7561.735339263154;34044.659553404395;34262.82868585666;34296.6570334296;34328.48507272393;34499.655003449894;2634.051741373104;2642.3526236072094;2643.6431081803903;2651.469706058777;2697.150397624742;23792.55008023844;24041.27876163718;24113.87943060291;24772.876135619386;24916.626250606256;2397.137030668958;2413.5172965406987;2433.75662433757;2452.141750387368;2476.938076548083;108413;112052.43973780079;148291;158862;159530;41216.1756764863;41254.96862578399;41278;41420;41650.166996660504;42591.7870410646;42794.78602606967;42836.785816071344;42866;43015.924601885206;12364.567240146731;12481.375931203404;12514.81227781584;12544.81182782259;12559.434825432878;10117.089461948313;10151.64469243573;10162.136218421369;10165.593376265015;10182.490875456198;12928.547500837614;13009.349532523336;13036;13053.28206948627;13213.603591892259;5449.972750136224;5455.481729235796;5489.1217405214975;5502.477264659851;5612.494875461228;839.5927974932154;866.7443104284251;870.991290087091;884.7213127864702;885.2077390735255;19655.115519801642;19705.408837734605;20783.58432831335;20843.895780521303;21029;952.2429668413489;952.9190018848476;956.0582825916466;958.2669258017482;993.6770549571273;9913.603455861828;10788.136949044057;10833.133349332034;10896.073833724064;11071.72320691989;221917;222179;223254;223265;224675;43197.56802431998;43206;43395.34906976398;43403;43566.7821660896;1183.5477087103175;1223.4005337384617;1225.4240506961714;1230.975380492385;1239.9938000310121;19234.71147932754;19515.51211219731;19669.901650491654;20473.795262047188;20900;30446;30454.54318185185;30460.84769576138;30461.695383045884;30502.084937451913;217164;219435;219845;220265;221214;27929.441411171258;28018;28559.42881142407;28677.85661071681;28840.711592884643;35235.937149829224;35312.29375412529;35677.64322356847;36117.27765444729;36382.8180859094;29503;31188.844055780482;31424.05727828169;32062.83968580142;32083.197920052186;30718.232044199074;30747.53878691866;30902;31386.372272554876;32268.19329516781;29985;30472;30506;30524.236894077825;30926.53610195894;26500.469990599693;27128.864355678095;28128;28327.575086374134;28386.290342741595;21550.78449215488;21787.891060544596;21888.78111218931;22031.33905982823;22099 07:13:32 INFO - PID 25673 | |2;jquery.html;412.2867439329961;423.21822189566495;431.2883741825988;445.7169697242251;448.2290460408099;16967.915160424196;17304.134793260335;17507.38724144655;18138.183781729822;18417.723734143965;18205.7269140963;18237.7264341035;18514.81485185148;18562.628747425042;18644.813551864478;5599.216109744619;5644.971775141129;5785.797497087603;5822.970885145568;5823.213866128082;5664.065429204197;5753.942460575383;5758.395368486312;5758.510526605243;5775.306963164426;5527.917081243784;5678.630888992223;5737.540996720273;5740.138979153118;5750.7412166452405;5633.549316054706;5655;5655.943440565583;5656.434356564331;5696.3449203341315;4952.281919121743;5029.748512574357;5034.3135049758375;5047.697138171721;5089.854782673906;21256.893715531325;21275.46811329729;21453.249136280156;21484.248051318285;21693.891530542405;1575.669109487009;1592.2198122919801;1592.371013449681;1619.0690353047046;1629.934802607906;12707.555235566802;12977.740445191137;13283.601491955256;13761.449542018307;14003.929980350033;1692.7968643762704;1705.8805883588154;1724.7412888066765;1765.911704414774;1785.3929663914332;85626.14373856244;86265;86891.56554217251;89286.55356723175;89435.55282223548;10685.732856678489;10843.240973131962;10887.83668244977;10946.39794811293;11093.944530277297;15181.240937953058;15328.23358832054;15369.231538423257;15371.846281537266;15412.383504659912;7354.021482319692;7505.812354691067;7507.474476786681;7650.846983060419;7748.186440423674;6919.308069193041;7003;7175.497715159889;7195.424366050704;7200.387967022757;6685.231198412245;6747.392734653905;6858.588484690835;6887;6970.302969702989;1970.7832138464757;2017.3141132015185;2035.1812739355803;2048.6376559588007;2168.8590241634242;809.8582748019073;838.5681374092347;861.6854847980442;880.6565439478609;882.3955590420583;14957.551273461813;15283.617909552127;15524.456644017406;15539.456119036005;15659.217039147998;858.5878778186506;878.8374150782125;887.3699673231948;897.4121950122681;898.6161311580094;8347.248747612744;10419.166466682647;11095.1123910087;11113.777724445466;11160.330380177214;478312.989107706;492126;508246;508290;510657;70999;90017.54991225002;92725.53637231905;92924.0707592929;93930;1082.43172334525;1111.1000089927186;1111.1055600241882;1112.3381587955155;1116.642674344202;17201.56996075108;17237.087430082367;17836.46490605284;17859.28562857471;18027.729584056513;42918.5708142927;43915.56084439243;44526;44823;44961.550384495735;48676.75661621811;50667;50960;56868.43131568631;58431.70784146052;7911.28798408123;7954.125046244792;7967.521948683097;8096.473729207582;8185.959070204611;11128.332300062022;11282.605108821152;11336.659900203007;11701.88298117042;11727.824082638937;9670.75823104428;9693.127618514367;9833.557489913113;10217.284790064625;10242.487875606339;9482.95258523703;9795.902040979785;9859.950700246452;10119.291649584753;10145.08694217524;9501.952490237505;10045.949770251395;10478.266521343432;10516.579336826748;10965.067969222706;10966.232363734462;11241.887581124083;11327.207095503236;11452.82820757706;11792.941035294769;9992.250581206585;10027.548760305657;10044.296899216984;10369.274150809371;10421.06210441064 07:13:32 INFO - PID 25673 | |3;mootools.html;1245.5516014234875;1283.9422225999829;1293.4502836294573;1302.0625149892087;1306.2358520265643;9434.292428067887;9803.117719405262;9810.754731131725;9966.152877005445;10302.33034852736;9851.65519206828;10080.899191008088;10094;10109.848352274721;10112.898871011288;2104.4002459299063;2156.892155392232;2157.5361297321074;2169.078141789741;2169.3275084723787;2090.571432856261;2145.9678104828363;2154.0845140815168;2157.568486302746;2170.197027099975;2089.164334266298;2124.6812978053263;2127.287358734826;2130.147940823675;2146.130817019102;2065.5765568058587;2070.1201989154547;2073.4712648274667;2077.40793873746;2079.4073688998715;1732.2811033421115;1785.2234278089072;2018.1422895269452;2046.1508473983279;2051.8974051297523;9743.756406089833;9775.31572789905;9859.654912078115;9865.704028879145;9874.061964113469;5294.179402192666;5443.401225865152;5455.645383050089;5457.972710136424;5492.862678433031;3185.7769956103084;3233.0785726067957;3241.9351612967844;3248.31785325082;3299.0762586475826;992.811365840488;1003.2876657573132;1014.4420568687266;1031.092638478142;1044.216837371971;14777.778333325008;14802.481913132988;14814.70370592593;14867.628309292355;14970.47603333889;4392.494863090722;4678.204705200124;4746.905061898812;4828.130936431406;4829.879253018703;10838;10863.83704244437;10873.728156796144;10925.399103049409;10930.508127134299;5470;5472;5474.835754927359;5475.67145971243;5488;4776.808927642925;4925.458199598042;4949.034938187091;4959.454460009396;5028.120078986236;3617.186133120027;3738.1962877981364;3751;3785.9242815143543;3786.1670432504807;1116.7659735991774;1129.9265547739535;1132.3319241647469;1143.4106591837353;1146.5585749486509;618.4063299232697;648.3969907985525;650.2684479960045;653.323809856796;654.3750718064238;4650.51169627191;4686.81252749893;4697.647676424282;4756.120117778222;4973.030259099441;516.7080599461292;524.5174439515655;528.5797790756282;530.6975024236149;535.5474623942762;3028.2732144285656;3032.605761251023;3053.114596766957;3101.798383105091;3180.7137357637926;12767.42546585406;13092.149010314299;13295.069345145941;13303.534376296782;13349.532766353132;13184.208947463183;13187.934060329637;13208.273544954927;13214.27321497327;13214.735705286033;9008.099190080939;9228.907710922938;9350.438973661467;9367.250619950388;9376.109269619375;6021;6169.321374648695;6234.846553387638;6337;6373.195793850691;11333.829992550283;11705.239159454948;11761.235519691192;11771.23486973344;11853.822192667289;11281;11578.189526733047;11607.245529040585;11640.068794496588;11817;7849.254320839511;8055.355571554144;8088.595570221583;8097.1497992712275;8117.878231826409;9086.818263634823;9349.48577828226;9353.064693530592;9405.20055795265;9479.952600236955;8045.637946292314;8297.626606802587;8342.457740246864;8392.03491598474;8527.232549070613;7658.770236892902;7782.143964164051;7818.374530037697;7847;7852.528848269122;7203.927960720535;7204;7304.780856574312;7310.926890731024;7312.707491700273;4794.664373493822;4884.902301954012;4922.138625740553;4978.228374601942;5088;4844.273358996038;4956.430010548833;5167.483251674803;5195.558087698775;5201.505856943584 07:13:32 INFO - PID 25673 | |4;prototype.html;384.3446922996292;401.1775859488049;401.4219523885606;407.4967415242177;410.3229671042779;5251.684898906068;5413.323334583177;5463.644863083897;5499.3675727291375;5528.612997090206;5259.894802103956;5374.6237763356585;5434.538064264532;5435.792882199502;5453.427390124039;4358.803853826569;4362.716423432483;4375.474943006843;4385.56144385562;4390;4018.216447792667;4200.768957707325;4366.934495982563;4389.780510974439;4393.406890069848;4142.772147531885;4174.853880114197;4177.2246795112105;4178.582141785828;4184.874453766377;4165.770882601456;4173.895652608694;4176.310908700061;4201.248182440507;4213.0087637777215;3687.815609219555;3693.907652308687;3698.445233215012;3701.1857391373856;3706.8331925063167;5179.099704165642;5289.1801770725215;5306.734663266821;5337.11937530307;5340.305760251182;4824.8311309104365;4838.419389673227;4848.636352273558;4855.417349917997;4856.538628830291;5556.638818476786;5743.684097374643;5744.138379243147;5753.395893431213;5755.798547050875;4054.3513037914086;4067.7559346439307;4072.124493233969;4075.53131389891;4094;5729.942700572982;5865.208196893407;5984.9401505984815;6027.698615069229;6084.695765211722;4093.5292441369625;4109.075458021921;4114.053767633461;4121.361189015707;4127.504699436087;4180.28935081037;4201.159768046403;4203.747775133502;4205.507044999043;4222.831086756557;4581.312803079565;4795.20879054959;4815.277708343777;4843.709377437365;4846.878828029327;5750.654960702372;5771.769129234867;5784.623999440023;5787.7395517200985;5801.158831969341;1440.7694768836936;1455.3523681961638;1460.291758497128;1463.4073200353873;1469.3387975411108;933.0156684697573;986.2061040862175;986.7335819328885;989.351974456732;1000.8740167311774;4958.752062396866;4968.130577148984;4981.750912454363;4989.376327959005;5006.949930500721;5931.347551769302;5955.34491205967;5955.970220148872;5958.880822383615;5959.4934430573885;4860.684055536379;4965.975170124127;4986.950130498722;4991.251312303184;5010.69935803853;3112.50199968004;3146.5594816725675;3157.936841263162;3160.336329370858;3171.4608516552244;5490.258815059996;5509.228707980886;5509.338879334506;5512.80705175317;5527.977324195037;5922.230110085661;6023.427774361428;6056.364081771439;6068.089786531968;6088.969555152285;5485.972570137204;5500.287306068468;5501.532369748536;5514.172874068921;5514.61397702157;5778.335491418373;5902.940970590239;5910.852228694317;5951.583389162717;5952.970235148797;5829.883402332014;5863.384344643921;5880.323762767165;5880.882382352414;5886.529077673861;5237.188235823453;5317.361916570037;5362.678239305654;5457.972710136424;5485.6560142765275;4103.835846566223;4113.424120623175;4122.154958233615;4126.814293356746;4144.44050053239;5703.401142879938;5912.320083190316;5923.940760592512;5948.791792287249;5970.0746384310505;5791.797287094932;5799.739011744566;5807.970960145172;5811.56413268998;5828.504577110993;5731.8853622928145;5758.107493338539;5761.0124507045;5771.624844385102;5790.94209057904;5566.332040155207;5638.2670252866865;5663.207150998781;5723.399043100415;5726.685032323262;5771.826845194651;5807.912881306699;5820.679862607428;5822.359540450462;5838.708064596668;5514.61397702157;5624.521915637217;5665.376808551138;5681.346645135863;5684.317881854204 07:13:32 INFO - PID 25673 | |5;yui.html;577.8353169346738;594.4620118792493;598.6976576828706;605.0863196573173;605.8576234584872;12547.811782823264;12668.366581670914;13017.153884997468;13035.869641303585;13051.73896522069;12080;12194;12245.204061735982;12285.078619103559;12487.937560312186;830.4933990265932;837.0959363887002;844.5650489997656;848.1984524624232;849.2272032450471;853.3685073045964;859.8839156713857;866.514751739025;866.8439680857443;867.652938824469;889.3107841422917;889.8531742262519;891.6121487153109;892.0989800301677;892.9107089291051;874.4054043250587;884.6549845560237;888.1518150166607;889.4707648948865;891.0599317719802;652.4877970792904;653.0628548033587;654.3129713800538;654.8526581519168;655.7442597387023;13481.528146514924;13580.456781728719;13610.59168224955;13616.319184040858;14603;12627.24236545801;13041.543545975941;13184.406701698446;13466.289537652407;13539;9315;9425.905740942571;9633.662821801203;9640;10126.392416455037;2584.2764026072728;2593.118339764489;2600.5189040027653;2694.016683910378;2699.9055033073746;49875.25187122196;50621.24068138944;50877.491225087644;62410.68794655998;67580.66209668921;8952.68665596701;9024.36829421934;9037.41256818318;9210.539473026322;9614.519274036411;18257.908710456362;18496.81503184951;18601.7209741854;18617.627647446974;18632.44102676922;6246.219222597176;6302.905456418157;6336.58812177207;6595.505337099737;6598.439132673777;3170.7780455368365;3270.8528116234825;3300.603927528712;3301.7688761786926;3319.7344212462945;3393.0669066006553;3506.368853606324;3550.6981906537717;3562.679358857715;3587.766795158306;666.2271764752863;669.1167658690482;674.4098913450731;678.4267294136447;689.8137502874196;436.2823155908513;437.3221506664657;442.3033721888039;455.7584480225486;459.0406051352689;7444.702211911463;7504.737334193277;7701;7779.06651201848;7912.920870791334;479.21887323662907;500.22465178973175;504.9419316778544;505.8128492457814;514.8764296568796;3208.406444807718;3210.9197270067966;3245.724113450336;3261.59230096238;3286.8520916558814;46011.53988460072;55832.833433312684;63200.36799632037;65982.34017659762;66151;53486.465135348146;55467.72266138724;55676.44323556794;56184.719076404355;57347.713261433426;38258;48980.51019489759;49260.50739492559;49872.750636247314;50733.492665072874;6361.268454127649;8145.389095817956;8277.710280140167;8398.328133749163;8541.444806087584;23575;24557;24941.501169976862;25245.873770631028;25659.486810264065;32841.50737738888;39215;41793.79103104587;42085.78957105195;42143.57856421397;10255.33340332876;10266.435346056038;10388.792224155324;10451.895481045396;10526.421046842497;11538.07695384384;11643.59247426336;11705;12027.15809893299;12548.24710517372;10491.632792852213;10493.422861742678;10697;10801.351918884891;11171.162162837658;10622.309549879234;10818.350898946088;11274.436278185894;11294.548218071184;11304.434778261219;10158.746031349276;10567.705585474308;10639.361638301727;10740.83888741654;11088.16838737114;7828;8148.126079962017;8191.426600138171;8237.258646721824;8448.83102337962;7330;7734.108303392897;8180.345572354317;8265.504069755834;8604.096569860074 07:13:32 INFO - PID 25673 | __end_tp_report 07:13:32 INFO - PID 25673 | __start_cc_report 07:13:32 INFO - PID 25673 | _x_x_mozilla_cycle_collect,391 07:13:32 INFO - PID 25673 | __end_cc_report 07:13:32 INFO - PID 25673 | __startTimestamp1490192012402__endTimestamp 07:13:32 INFO - PID 25673 | 07:13:32 INFO - PID 25673 | ------- Summary: start ------- 07:13:32 INFO - PID 25673 | Number of tests: 6 07:13:32 INFO - PID 25673 | 07:13:32 INFO - PID 25673 | [#0] dojo.html Cycles:165 Average:5213.61 Median:5372.33 stddev:594.42 (11.1%) stddev-sans-first:562.97 07:13:32 INFO - PID 25673 | Values: 2713.8 2723.7 2727.3 2751.5 2755.6 5214.7 5225.5 5258.0 5289.4 5310.5 5261.7 5278.9 5308.2 5332.0 5372.3 4776.2 4824.0 4826.7 4850.4 4874.0 4856.7 4883.2 4908.6 4911.8 4950.6 4738.2 4775.7 4780.3 4821.5 4837.9 4753.1 4797.3 4809.8 4841.3 4850.2 4665.9 4732.6 4762.8 4768.9 4776.4 5189.8 5209.1 5221.3 5238.3 5301.9 5679.4 5681.0 5725.6 5730.9 5737.9 5692.5 5710.1 5711.5 5719.3 5739.8 5212.1 5279.9 5305.6 5316.0 5365.5 5683.0 5767.6 5768.9 5785.3 5787.0 5539.6 5547.9 5585.3 5621.1 5634.3 5630.8 5651.2 5656.5 5664.9 5672.1 5605.2 5606.5 5607.3 5613.1 5614.0 5510.4 5583.1 5625.0 5681.0 5710.4 4729.7 4730.5 4734.1 4759.8 4781.3 4050.7 4058.3 4059.2 4094.3 4114.3 4803.3 4859.8 4874.5 4885.8 4908.0 5726.2 5729.4 5766.0 5774.6 5786.2 4831.7 4868.0 4869.5 4878.2 4909.0 4985.9 5036.2 5068.7 5071.2 5082.4 5292.0 5300.4 5302.9 5303.9 5306.1 5660.7 5727.3 5733.1 5733.6 5740.0 5288.6 5334.4 5370.1 5378.2 5401.6 5546.3 5547.4 5593.8 5597.8 5598.4 5681.8 5686.1 5690.3 5693.6 5695.4 5441.9 5466.4 5499.0 5532.5 5596.5 5513.6 5526.7 5530.0 5541.2 5564.6 5376.6 5416.2 5441.6 5464.3 5497.7 5473.3 5539.4 5559.8 5582.6 5649.7 5419.3 5420.7 5423.0 5450.2 5472.2 07:13:32 INFO - PID 25673 | 07:13:32 INFO - PID 25673 | [#1] ext.html Cycles:180 Average:33497.78 Median:30615.96 stddev:51522.87 (168.3%) stddev-sans-first:51608.35 07:13:32 INFO - PID 25673 | Values: 643.3 714.3 735.9 1011.4 1032.2 30707.7 31610.4 31764.5 31777.7 31809.8 31972.7 32238.5 32268.4 32505.2 32565.0 7254.1 7304.3 7435.5 7443.1 7449.2 7381.9 7391.6 7472.4 7497.7 7501.0 7428.8 7448.0 7501.7 7667.0 7681.5 7593.5 7604.3 7610.7 7620.5 7636.5 7479.9 7493.8 7512.8 7529.7 7561.7 34044.7 34262.8 34296.7 34328.5 34499.7 2634.1 2642.4 2643.6 2651.5 2697.2 23792.6 24041.3 24113.9 24772.9 24916.6 2397.1 2413.5 2433.8 2452.1 2476.9 108413.0 112052.4 148291.0 158862.0 159530.0 41216.2 41255.0 41278.0 41420.0 41650.2 42591.8 42794.8 42836.8 42866.0 43015.9 12364.6 12481.4 12514.8 12544.8 12559.4 10117.1 10151.6 10162.1 10165.6 10182.5 12928.5 13009.3 13036.0 13053.3 13213.6 5450.0 5455.5 5489.1 5502.5 5612.5 839.6 866.7 871.0 884.7 885.2 19655.1 19705.4 20783.6 20843.9 21029.0 952.2 952.9 956.1 958.3 993.7 9913.6 10788.1 10833.1 10896.1 11071.7 221917.0 222179.0 223254.0 223265.0 224675.0 43197.6 43206.0 43395.3 43403.0 43566.8 1183.5 1223.4 1225.4 1231.0 1240.0 19234.7 19515.5 19669.9 20473.8 20900.0 30446.0 30454.5 30460.8 30461.7 30502.1 217164.0 219435.0 219845.0 220265.0 221214.0 27929.4 28018.0 28559.4 28677.9 28840.7 35235.9 35312.3 35677.6 36117.3 36382.8 29503.0 31188.8 31424.1 32062.8 32083.2 30718.2 30747.5 30902.0 31386.4 32268.2 29985.0 30472.0 30506.0 30524.2 30926.5 26500.5 27128.9 28128.0 28327.6 28386.3 21550.8 21787.9 21888.8 22031.3 22099.0 07:13:32 INFO - PID 25673 | 07:13:32 INFO - PID 25673 | [#2] jquery.html Cycles:180 Average:28948.63 Median:22180.64 stddev:82414.77 (371.6%) stddev-sans-first:82618.11 07:13:32 INFO - PID 25673 | Values: 412.3 423.2 431.3 445.7 448.2 16967.9 17304.1 17507.4 18138.2 18417.7 18205.7 18237.7 18514.8 18562.6 18644.8 5599.2 5645.0 5785.8 5823.0 5823.2 5664.1 5753.9 5758.4 5758.5 5775.3 5527.9 5678.6 5737.5 5740.1 5750.7 5633.5 5655.0 5655.9 5656.4 5696.3 4952.3 5029.7 5034.3 5047.7 5089.9 21256.9 21275.5 21453.2 21484.2 21693.9 1575.7 1592.2 1592.4 1619.1 1629.9 12707.6 12977.7 13283.6 13761.4 14003.9 1692.8 1705.9 1724.7 1765.9 1785.4 85626.1 86265.0 86891.6 89286.6 89435.6 10685.7 10843.2 10887.8 10946.4 11093.9 15181.2 15328.2 15369.2 15371.8 15412.4 7354.0 7505.8 7507.5 7650.8 7748.2 6919.3 7003.0 7175.5 7195.4 7200.4 6685.2 6747.4 6858.6 6887.0 6970.3 1970.8 2017.3 2035.2 2048.6 2168.9 809.9 838.6 861.7 880.7 882.4 14957.6 15283.6 15524.5 15539.5 15659.2 858.6 878.8 887.4 897.4 898.6 8347.2 10419.2 11095.1 11113.8 11160.3 478313.0 492126.0 508246.0 508290.0 510657.0 70999.0 90017.5 92725.5 92924.1 93930.0 1082.4 1111.1 1111.1 1112.3 1116.6 17201.6 17237.1 17836.5 17859.3 18027.7 42918.6 43915.6 44526.0 44823.0 44961.6 48676.8 50667.0 50960.0 56868.4 58431.7 7911.3 7954.1 7967.5 8096.5 8186.0 11128.3 11282.6 11336.7 11701.9 11727.8 9670.8 9693.1 9833.6 10217.3 10242.5 9483.0 9795.9 9860.0 10119.3 10145.1 9502.0 10045.9 10478.3 10516.6 10965.1 10966.2 11241.9 11327.2 11452.8 11792.9 9992.3 10027.5 10044.3 10369.3 10421.1 07:13:32 INFO - PID 25673 | 07:13:32 INFO - PID 25673 | [#3] mootools.html Cycles:180 Average:6159.02 Median:4664.36 stddev:4041.74 (86.7%) stddev-sans-first:4036.21 07:13:32 INFO - PID 25673 | Values: 1245.6 1283.9 1293.5 1302.1 1306.2 9434.3 9803.1 9810.8 9966.2 10302.3 9851.7 10080.9 10094.0 10109.8 10112.9 2104.4 2156.9 2157.5 2169.1 2169.3 2090.6 2146.0 2154.1 2157.6 2170.2 2089.2 2124.7 2127.3 2130.1 2146.1 2065.6 2070.1 2073.5 2077.4 2079.4 1732.3 1785.2 2018.1 2046.2 2051.9 9743.8 9775.3 9859.7 9865.7 9874.1 5294.2 5443.4 5455.6 5458.0 5492.9 3185.8 3233.1 3241.9 3248.3 3299.1 992.8 1003.3 1014.4 1031.1 1044.2 14777.8 14802.5 14814.7 14867.6 14970.5 4392.5 4678.2 4746.9 4828.1 4829.9 10838.0 10863.8 10873.7 10925.4 10930.5 5470.0 5472.0 5474.8 5475.7 5488.0 4776.8 4925.5 4949.0 4959.5 5028.1 3617.2 3738.2 3751.0 3785.9 3786.2 1116.8 1129.9 1132.3 1143.4 1146.6 618.4 648.4 650.3 653.3 654.4 4650.5 4686.8 4697.6 4756.1 4973.0 516.7 524.5 528.6 530.7 535.5 3028.3 3032.6 3053.1 3101.8 3180.7 12767.4 13092.1 13295.1 13303.5 13349.5 13184.2 13187.9 13208.3 13214.3 13214.7 9008.1 9228.9 9350.4 9367.3 9376.1 6021.0 6169.3 6234.8 6337.0 6373.2 11333.8 11705.2 11761.2 11771.2 11853.8 11281.0 11578.2 11607.2 11640.1 11817.0 7849.3 8055.4 8088.6 8097.1 8117.9 9086.8 9349.5 9353.1 9405.2 9480.0 8045.6 8297.6 8342.5 8392.0 8527.2 7658.8 7782.1 7818.4 7847.0 7852.5 7203.9 7204.0 7304.8 7310.9 7312.7 4794.7 4884.9 4922.1 4978.2 5088.0 4844.3 4956.4 5167.5 5195.6 5201.5 07:13:32 INFO - PID 25673 | 07:13:32 INFO - PID 25673 | [#4] prototype.html Cycles:180 Average:4750.52 Median:5368.65 stddev:1382.10 (25.7%) stddev-sans-first:1346.57 07:13:32 INFO - PID 25673 | Values: 384.3 401.2 401.4 407.5 410.3 5251.7 5413.3 5463.6 5499.4 5528.6 5259.9 5374.6 5434.5 5435.8 5453.4 4358.8 4362.7 4375.5 4385.6 4390.0 4018.2 4200.8 4366.9 4389.8 4393.4 4142.8 4174.9 4177.2 4178.6 4184.9 4165.8 4173.9 4176.3 4201.2 4213.0 3687.8 3693.9 3698.4 3701.2 3706.8 5179.1 5289.2 5306.7 5337.1 5340.3 4824.8 4838.4 4848.6 4855.4 4856.5 5556.6 5743.7 5744.1 5753.4 5755.8 4054.4 4067.8 4072.1 4075.5 4094.0 5729.9 5865.2 5984.9 6027.7 6084.7 4093.5 4109.1 4114.1 4121.4 4127.5 4180.3 4201.2 4203.7 4205.5 4222.8 4581.3 4795.2 4815.3 4843.7 4846.9 5750.7 5771.8 5784.6 5787.7 5801.2 1440.8 1455.4 1460.3 1463.4 1469.3 933.0 986.2 986.7 989.4 1000.9 4958.8 4968.1 4981.8 4989.4 5006.9 5931.3 5955.3 5956.0 5958.9 5959.5 4860.7 4966.0 4987.0 4991.3 5010.7 3112.5 3146.6 3157.9 3160.3 3171.5 5490.3 5509.2 5509.3 5512.8 5528.0 5922.2 6023.4 6056.4 6068.1 6089.0 5486.0 5500.3 5501.5 5514.2 5514.6 5778.3 5902.9 5910.9 5951.6 5953.0 5829.9 5863.4 5880.3 5880.9 5886.5 5237.2 5317.4 5362.7 5458.0 5485.7 4103.8 4113.4 4122.2 4126.8 4144.4 5703.4 5912.3 5923.9 5948.8 5970.1 5791.8 5799.7 5808.0 5811.6 5828.5 5731.9 5758.1 5761.0 5771.6 5790.9 5566.3 5638.3 5663.2 5723.4 5726.7 5771.8 5807.9 5820.7 5822.4 5838.7 5514.6 5624.5 5665.4 5681.3 5684.3 07:13:32 INFO - PID 25673 | 07:13:32 INFO - PID 25673 | [#5] yui.html Cycles:180 Average:13458.74 Median:49566.63 stddev:16708.98 (33.7%) stddev-sans-first:16727.86 07:13:32 INFO - PID 25673 | Values: 577.8 594.5 598.7 605.1 605.9 12547.8 12668.4 13017.2 13035.9 13051.7 12080.0 12194.0 12245.2 12285.1 12487.9 830.5 837.1 844.6 848.2 849.2 853.4 859.9 866.5 866.8 867.7 889.3 889.9 891.6 892.1 892.9 874.4 884.7 888.2 889.5 891.1 652.5 653.1 654.3 654.9 655.7 13481.5 13580.5 13610.6 13616.3 14603.0 12627.2 13041.5 13184.4 13466.3 13539.0 9315.0 9425.9 9633.7 9640.0 10126.4 2584.3 2593.1 2600.5 2694.0 2699.9 49875.3 50621.2 50877.5 62410.7 67580.7 8952.7 9024.4 9037.4 9210.5 9614.5 18257.9 18496.8 18601.7 18617.6 18632.4 6246.2 6302.9 6336.6 6595.5 6598.4 3170.8 3270.9 3300.6 3301.8 3319.7 3393.1 3506.4 3550.7 3562.7 3587.8 666.2 669.1 674.4 678.4 689.8 436.3 437.3 442.3 455.8 459.0 7444.7 7504.7 7701.0 7779.1 7912.9 479.2 500.2 504.9 505.8 514.9 3208.4 3210.9 3245.7 3261.6 3286.9 46011.5 55832.8 63200.4 65982.3 66151.0 53486.5 55467.7 55676.4 56184.7 57347.7 38258.0 48980.5 49260.5 49872.8 50733.5 6361.3 8145.4 8277.7 8398.3 8541.4 23575.0 24557.0 24941.5 25245.9 25659.5 32841.5 39215.0 41793.8 42085.8 42143.6 10255.3 10266.4 10388.8 10451.9 10526.4 11538.1 11643.6 11705.0 12027.2 12548.2 10491.6 10493.4 10697.0 10801.4 11171.2 10622.3 10818.4 11274.4 11294.5 11304.4 10158.7 10567.7 10639.4 10740.8 11088.2 7828.0 8148.1 8191.4 8237.3 8448.8 7330.0 7734.1 8180.3 8265.5 8604.1 07:13:32 INFO - PID 25673 | -------- Summary: end -------- 07:13:32 INFO - PID 25673 | 07:13:33 INFO - TEST-INFO | 25673: exit 0 07:13:33 INFO - TEST-OK | dromaeo_css | took 1121340ms 07:13:33 INFO - TEST-START | kraken 07:13:33 INFO - operating with platform_type : linux_ 07:13:33 INFO - Initialising browser for kraken test... 07:13:33 INFO - TEST-INFO | started process 26051 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWzqqDK/profile http://localhost:34025/getInfo.html) 07:13:38 INFO - PID 26051 | __metrics Screen width/height:1600/1200 07:13:38 INFO - PID 26051 | colorDepth:24 07:13:38 INFO - PID 26051 | Browser inner width/height: 1024/697 07:13:38 INFO - PID 26051 | __metrics 07:13:39 ERROR - PID 26051 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 07:13:40 INFO - TEST-INFO | 26051: exit 0 07:13:40 INFO - Browser initialized. 07:13:40 INFO - Running cycle 1/1 for kraken test... 07:13:40 INFO - TEST-INFO | started process 26180 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWzqqDK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:13:52 INFO - PID 26180 | RSS: Main: 154955776 07:13:52 INFO - PID 26180 | 07:13:54 INFO - PID 26180 | Cycle 1(1): loaded http://localhost:34025/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34025/tests/kraken/driver.html?testName=audio-beat-detection) 07:13:55 INFO - PID 26180 | RSS: Main: 161468416 07:13:55 INFO - PID 26180 | 07:13:58 INFO - PID 26180 | Cycle 1(1): loaded http://localhost:34025/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34025/tests/kraken/driver.html?testName=audio-dft) 07:13:59 INFO - PID 26180 | RSS: Main: 160436224 07:13:59 INFO - PID 26180 | 07:14:02 INFO - PID 26180 | Cycle 1(1): loaded http://localhost:34025/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34025/tests/kraken/driver.html?testName=audio-fft) 07:14:02 INFO - PID 26180 | RSS: Main: 156864512 07:14:02 INFO - PID 26180 | 07:14:04 INFO - PID 26180 | Cycle 1(1): loaded http://localhost:34025/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34025/tests/kraken/driver.html?testName=audio-oscillator) 07:14:05 INFO - PID 26180 | RSS: Main: 158179328 07:14:05 INFO - PID 26180 | 07:14:07 INFO - PID 26180 | Cycle 1(1): loaded http://localhost:34025/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34025/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:14:08 INFO - PID 26180 | RSS: Main: 158535680 07:14:08 INFO - PID 26180 | 07:14:11 INFO - PID 26180 | Cycle 1(1): loaded http://localhost:34025/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34025/tests/kraken/driver.html?testName=imaging-darkroom) 07:14:12 INFO - PID 26180 | RSS: Main: 162148352 07:14:12 INFO - PID 26180 | 07:14:15 INFO - PID 26180 | Cycle 1(1): loaded http://localhost:34025/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34025/tests/kraken/driver.html?testName=imaging-desaturate) 07:14:16 INFO - PID 26180 | RSS: Main: 161275904 07:14:16 INFO - PID 26180 | 07:14:19 INFO - PID 26180 | Cycle 1(1): loaded http://localhost:34025/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34025/tests/kraken/driver.html?testName=json-parse-financial) 07:14:19 INFO - PID 26180 | RSS: Main: 162263040 07:14:19 INFO - PID 26180 | 07:14:21 INFO - PID 26180 | Cycle 1(1): loaded http://localhost:34025/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34025/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:14:22 INFO - PID 26180 | RSS: Main: 162689024 07:14:22 INFO - PID 26180 | 07:14:24 INFO - PID 26180 | Cycle 1(1): loaded http://localhost:34025/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34025/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:14:24 INFO - PID 26180 | RSS: Main: 162361344 07:14:24 INFO - PID 26180 | 07:14:26 INFO - PID 26180 | Cycle 1(1): loaded http://localhost:34025/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34025/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:14:27 INFO - PID 26180 | RSS: Main: 162992128 07:14:27 INFO - PID 26180 | 07:14:30 INFO - PID 26180 | Cycle 1(1): loaded http://localhost:34025/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34025/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:14:31 INFO - PID 26180 | RSS: Main: 163102720 07:14:31 INFO - PID 26180 | 07:14:34 INFO - PID 26180 | Cycle 1(1): loaded http://localhost:34025/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34025/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:14:35 INFO - PID 26180 | RSS: Main: 166260736 07:14:35 INFO - PID 26180 | 07:14:36 INFO - PID 26180 | Cycle 1(1): loaded http://localhost:34025/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34025/tests/kraken/driver.html?testName=ai-astar) 07:14:37 INFO - PID 26180 | RSS: Main: 167030784 07:14:37 INFO - PID 26180 | 07:14:37 INFO - PID 26180 | __start_tp_report 07:14:37 INFO - PID 26180 | _x_x_mozilla_page_load 07:14:37 INFO - PID 26180 | _x_x_mozilla_page_load_details 07:14:37 INFO - PID 26180 | |i|pagename|runs| 07:14:37 INFO - PID 26180 | |0;ai-astar;106;114;113;111;115;113;112;112;111;111 07:14:37 INFO - PID 26180 | |1;audio-beat-detection;151;126;125;175;127;126;129;130;148;128 07:14:37 INFO - PID 26180 | |2;audio-dft;164;166;164;168;172;168;168;163;163;164 07:14:37 INFO - PID 26180 | |3;audio-fft;76;76;78;107;84;78;75;76;92;76 07:14:37 INFO - PID 26180 | |4;audio-oscillator;85;84;104;89;84;84;97;84;85;103 07:14:37 INFO - PID 26180 | |5;imaging-gaussian-blur;114;115;113;114;114;114;121;114;114;114 07:14:37 INFO - PID 26180 | |6;imaging-darkroom;151;152;153;151;153;152;152;151;152;150 07:14:37 INFO - PID 26180 | |7;imaging-desaturate;95;96;94;95;95;94;95;94;95;95 07:14:37 INFO - PID 26180 | |8;json-parse-financial;69;70;69;70;70;73;71;70;72;73 07:14:37 INFO - PID 26180 | |9;json-stringify-tinderbox;56;56;55;56;56;57;55;56;55;57 07:14:37 INFO - PID 26180 | |10;stanford-crypto-aes;83;83;83;82;91;90;84;91;84;82 07:14:37 INFO - PID 26180 | |11;stanford-crypto-ccm;140;136;138;146;136;144;140;148;192;139 07:14:37 INFO - PID 26180 | |12;stanford-crypto-pbkdf2;192;195;209;196;198;191;194;193;194;206 07:14:37 INFO - PID 26180 | |13;stanford-crypto-sha256-iterative;72;71;72;73;74;72;70;72;71;78 07:14:37 INFO - PID 26180 | __end_tp_report 07:14:37 INFO - PID 26180 | __start_cc_report 07:14:37 INFO - PID 26180 | _x_x_mozilla_cycle_collect,872 07:14:37 INFO - PID 26180 | __end_cc_report 07:14:37 INFO - PID 26180 | __startTimestamp1490192077122__endTimestamp 07:14:37 INFO - PID 26180 | 07:14:37 INFO - PID 26180 | ------- Summary: start ------- 07:14:37 INFO - PID 26180 | Number of tests: 14 07:14:37 INFO - PID 26180 | 07:14:37 INFO - PID 26180 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.50 stddev:2.44 (2.2%) stddev-sans-first:1.42 07:14:37 INFO - PID 26180 | Values: 106.0 114.0 113.0 111.0 115.0 113.0 112.0 112.0 111.0 111.0 07:14:37 INFO - PID 26180 | 07:14:37 INFO - PID 26180 | [#1] audio-beat-detection Cycles:10 Average:136.50 Median:129.50 stddev:16.46 (12.7%) stddev-sans-first:16.60 07:14:37 INFO - PID 26180 | Values: 151.0 126.0 125.0 175.0 127.0 126.0 129.0 130.0 148.0 128.0 07:14:37 INFO - PID 26180 | 07:14:37 INFO - PID 26180 | [#2] audio-dft Cycles:10 Average:166.00 Median:167.00 stddev:2.94 (1.8%) stddev-sans-first:3.03 07:14:37 INFO - PID 26180 | Values: 164.0 166.0 164.0 168.0 172.0 168.0 168.0 163.0 163.0 164.0 07:14:37 INFO - PID 26180 | 07:14:37 INFO - PID 26180 | [#3] audio-fft Cycles:10 Average:81.80 Median:77.00 stddev:10.29 (13.4%) stddev-sans-first:10.70 07:14:37 INFO - PID 26180 | Values: 76.0 76.0 78.0 107.0 84.0 78.0 75.0 76.0 92.0 76.0 07:14:37 INFO - PID 26180 | 07:14:37 INFO - PID 26180 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:84.50 stddev:8.23 (9.7%) stddev-sans-first:8.53 07:14:37 INFO - PID 26180 | Values: 85.0 84.0 104.0 89.0 84.0 84.0 97.0 84.0 85.0 103.0 07:14:37 INFO - PID 26180 | 07:14:37 INFO - PID 26180 | [#5] imaging-gaussian-blur Cycles:10 Average:114.70 Median:114.00 stddev:2.26 (2.0%) stddev-sans-first:2.39 07:14:37 INFO - PID 26180 | Values: 114.0 115.0 113.0 114.0 114.0 114.0 121.0 114.0 114.0 114.0 07:14:37 INFO - PID 26180 | 07:14:37 INFO - PID 26180 | [#6] imaging-darkroom Cycles:10 Average:151.70 Median:152.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 07:14:37 INFO - PID 26180 | Values: 151.0 152.0 153.0 151.0 153.0 152.0 152.0 151.0 152.0 150.0 07:14:37 INFO - PID 26180 | 07:14:37 INFO - PID 26180 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 07:14:37 INFO - PID 26180 | Values: 95.0 96.0 94.0 95.0 95.0 94.0 95.0 94.0 95.0 95.0 07:14:37 INFO - PID 26180 | 07:14:37 INFO - PID 26180 | [#8] json-parse-financial Cycles:10 Average:70.70 Median:70.50 stddev:1.49 (2.1%) stddev-sans-first:1.45 07:14:37 INFO - PID 26180 | Values: 69.0 70.0 69.0 70.0 70.0 73.0 71.0 70.0 72.0 73.0 07:14:37 INFO - PID 26180 | 07:14:37 INFO - PID 26180 | [#9] json-stringify-tinderbox Cycles:10 Average:55.90 Median:56.00 stddev:0.74 (1.3%) stddev-sans-first:0.78 07:14:37 INFO - PID 26180 | Values: 56.0 56.0 55.0 56.0 56.0 57.0 55.0 56.0 55.0 57.0 07:14:37 INFO - PID 26180 | 07:14:37 INFO - PID 26180 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:84.00 stddev:3.77 (4.5%) stddev-sans-first:3.91 07:14:37 INFO - PID 26180 | Values: 83.0 83.0 83.0 82.0 91.0 90.0 84.0 91.0 84.0 82.0 07:14:37 INFO - PID 26180 | 07:14:37 INFO - PID 26180 | [#11] stanford-crypto-ccm Cycles:10 Average:145.90 Median:142.00 stddev:16.70 (11.8%) stddev-sans-first:17.57 07:14:37 INFO - PID 26180 | Values: 140.0 136.0 138.0 146.0 136.0 144.0 140.0 148.0 192.0 139.0 07:14:37 INFO - PID 26180 | 07:14:37 INFO - PID 26180 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.80 Median:195.50 stddev:6.01 (3.1%) stddev-sans-first:6.12 07:14:37 INFO - PID 26180 | Values: 192.0 195.0 209.0 196.0 198.0 191.0 194.0 193.0 194.0 206.0 07:14:37 INFO - PID 26180 | 07:14:37 INFO - PID 26180 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:72.00 stddev:2.22 (3.1%) stddev-sans-first:2.35 07:14:37 INFO - PID 26180 | Values: 72.0 71.0 72.0 73.0 74.0 72.0 70.0 72.0 71.0 78.0 07:14:37 INFO - PID 26180 | -------- Summary: end -------- 07:14:37 INFO - PID 26180 | 07:14:38 INFO - TEST-INFO | 26180: exit 0 07:14:38 INFO - TEST-OK | kraken | took 65086ms 07:14:38 INFO - SUITE-END | took 1186s 07:14:38 INFO - Completed test suite (00:19:46) 07:14:38 INFO - javascript benchmark 07:14:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6551.811896284966, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2713.81003329767, 2723.727627237276, 2727.318170457386, 2751.490974169778, 2755.6417665703457, 5214.713190774506, 5225.477452254778, 5258.0, 5289.391719952207, 5310.548603368714, 5261.710605916673, 5278.894422111565, 5308.150695888658, 5332.0, 5372.328458942632, 4776.164171270023, 4824.035192961404, 4826.734529600871, 4850.442199147108, 4873.975630121844, 4856.732879691615, 4883.1698611236, 4908.631852611051, 4911.778969946361, 4950.55445009949, 4738.1708201064675, 4775.6657034007285, 4780.282957556395, 4821.54195351441, 4837.927431088537, 4753.096911586787, 4797.2564252540915, 4809.78355973982, 4841.298011788306, 4850.199717046683, 4665.906681866344, 4732.645051621143, 4762.809487620491, 4768.880777980544, 4776.355192049064, 5189.792408303663, 5209.1404918188455, 5221.321228240343, 5238.345206849144, 5301.946980530184, 5679.432056794288, 5680.971595142039, 5725.627834190765, 5730.856728581819, 5737.942620573783, 5692.5161361284345, 5710.114932185518, 5711.485966263015, 5719.342275638313, 5739.799107031234, 5212.139996900469, 5279.947200527946, 5305.62860599762, 5316.0, 5365.490278423544, 5683.0, 5767.625104368202, 5768.884622307531, 5785.30576330843, 5787.045137552341, 5539.639923405047, 5547.889042219133, 5585.329760428694, 5621.100623900238, 5634.267545219177, 5630.774769009194, 5651.180578816049, 5656.519195868315, 5664.886702266014, 5672.064109421982, 5605.1872478491205, 5606.523445507178, 5607.271054762855, 5613.10190369547, 5613.971930140323, 5510.448955104457, 5583.134614134734, 5625.0, 5681.0, 5710.371859095496, 4729.7398643074275, 4730.455997560256, 4734.076855013308, 4759.809607615726, 4781.306710526954, 4050.736702114353, 4058.2695114879016, 4059.188162367538, 4094.324436468009, 4114.321137012359, 4803.303520989437, 4859.757012149378, 4874.46380898101, 4885.755712214375, 4907.950920490821, 5726.226959360433, 5729.369769325371, 5765.971170144123, 5774.566907481872, 5786.218860453869, 4831.73425461596, 4868.02639472107, 4869.537393947569, 4878.195097808893, 4908.950910490921, 4985.90028199434, 5036.219385995177, 5068.695878247317, 5071.163258062378, 5082.440931497532, 5292.047431462373, 5300.390455097713, 5302.946970530245, 5303.920441193308, 5306.097963346318, 5660.660360378391, 5727.284089488814, 5733.0540460823495, 5733.598648094593, 5739.971300143639, 5288.576913846806, 5334.386545547157, 5370.113931201464, 5378.247045413567, 5401.648892821954, 5546.306711661043, 5547.44525547442, 5593.804216852391, 5597.832065038056, 5598.412166722435, 5681.772729090955, 5686.147077938343, 5690.3456102548735, 5693.572982026448, 5695.430456954271, 5441.863953401196, 5466.3713672928125, 5498.972505137449, 5532.529734972572, 5596.496315331639, 5513.61404701667, 5526.696031718294, 5530.0, 5541.224228607917, 5564.638298510584, 5376.596755243294, 5416.187571864252, 5441.619086663895, 5464.316960379952, 5497.697626630574, 5473.261109750292, 5539.41836107219, 5559.833205003856, 5582.637128586629, 5649.745761440828, 5419.268398766274, 5420.728963551728, 5423.0, 5450.182472628979, 5472.179173124063], "value": 5170.837850396646, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [643.3405759096925, 714.2928500784224, 735.8675438421084, 1011.4487604255685, 1032.1536340201037, 30707.69292307076, 31610.367792644134, 31764.523532147035, 31777.682223177762, 31809.840950795242, 31972.68027319726, 32238.516422253626, 32268.35463290733, 32505.187370315754, 32565.0, 7254.129504459473, 7304.306090921381, 7435.479516433852, 7443.106827180746, 7449.180590135081, 7381.88927166093, 7391.593462359568, 7472.4395670324675, 7497.73757918473, 7500.962495187544, 7428.814279643025, 7447.962760186191, 7501.699932002741, 7666.961665191666, 7681.50070245435, 7593.506422082547, 7604.277593628596, 7610.7336243231775, 7620.542767433972, 7636.503627264266, 7479.887801682979, 7493.812654683622, 7512.835510495882, 7529.661165247522, 7561.735339263154, 34044.659553404395, 34262.82868585666, 34296.6570334296, 34328.48507272393, 34499.655003449894, 2634.051741373104, 2642.3526236072094, 2643.6431081803903, 2651.469706058777, 2697.150397624742, 23792.55008023844, 24041.27876163718, 24113.87943060291, 24772.876135619386, 24916.626250606256, 2397.137030668958, 2413.5172965406987, 2433.75662433757, 2452.141750387368, 2476.938076548083, 108413.0, 112052.43973780079, 148291.0, 158862.0, 159530.0, 41216.1756764863, 41254.96862578399, 41278.0, 41420.0, 41650.166996660504, 42591.7870410646, 42794.78602606967, 42836.785816071344, 42866.0, 43015.924601885206, 12364.567240146731, 12481.375931203404, 12514.81227781584, 12544.81182782259, 12559.434825432878, 10117.089461948313, 10151.64469243573, 10162.136218421369, 10165.593376265015, 10182.490875456198, 12928.547500837614, 13009.349532523336, 13036.0, 13053.28206948627, 13213.603591892259, 5449.972750136224, 5455.481729235796, 5489.1217405214975, 5502.477264659851, 5612.494875461228, 839.5927974932154, 866.7443104284251, 870.991290087091, 884.7213127864702, 885.2077390735255, 19655.115519801642, 19705.408837734605, 20783.58432831335, 20843.895780521303, 21029.0, 952.2429668413489, 952.9190018848476, 956.0582825916466, 958.2669258017482, 993.6770549571273, 9913.603455861828, 10788.136949044057, 10833.133349332034, 10896.073833724064, 11071.72320691989, 221917.0, 222179.0, 223254.0, 223265.0, 224675.0, 43197.56802431998, 43206.0, 43395.34906976398, 43403.0, 43566.7821660896, 1183.5477087103175, 1223.4005337384617, 1225.4240506961714, 1230.975380492385, 1239.9938000310121, 19234.71147932754, 19515.51211219731, 19669.901650491654, 20473.795262047188, 20900.0, 30446.0, 30454.54318185185, 30460.84769576138, 30461.695383045884, 30502.084937451913, 217164.0, 219435.0, 219845.0, 220265.0, 221214.0, 27929.441411171258, 28018.0, 28559.42881142407, 28677.85661071681, 28840.711592884643, 35235.937149829224, 35312.29375412529, 35677.64322356847, 36117.27765444729, 36382.8180859094, 29503.0, 31188.844055780482, 31424.05727828169, 32062.83968580142, 32083.197920052186, 30718.232044199074, 30747.53878691866, 30902.0, 31386.372272554876, 32268.19329516781, 29985.0, 30472.0, 30506.0, 30524.236894077825, 30926.53610195894, 26500.469990599693, 27128.864355678095, 28128.0, 28327.575086374134, 28386.290342741595, 21550.78449215488, 21787.891060544596, 21888.78111218931, 22031.33905982823, 22099.0], "value": 14773.764770985532, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.2867439329961, 423.21822189566495, 431.2883741825988, 445.7169697242251, 448.2290460408099, 16967.915160424196, 17304.134793260335, 17507.38724144655, 18138.183781729822, 18417.723734143965, 18205.7269140963, 18237.7264341035, 18514.81485185148, 18562.628747425042, 18644.813551864478, 5599.216109744619, 5644.971775141129, 5785.797497087603, 5822.970885145568, 5823.213866128082, 5664.065429204197, 5753.942460575383, 5758.395368486312, 5758.510526605243, 5775.306963164426, 5527.917081243784, 5678.630888992223, 5737.540996720273, 5740.138979153118, 5750.7412166452405, 5633.549316054706, 5655.0, 5655.943440565583, 5656.434356564331, 5696.3449203341315, 4952.281919121743, 5029.748512574357, 5034.3135049758375, 5047.697138171721, 5089.854782673906, 21256.893715531325, 21275.46811329729, 21453.249136280156, 21484.248051318285, 21693.891530542405, 1575.669109487009, 1592.2198122919801, 1592.371013449681, 1619.0690353047046, 1629.934802607906, 12707.555235566802, 12977.740445191137, 13283.601491955256, 13761.449542018307, 14003.929980350033, 1692.7968643762704, 1705.8805883588154, 1724.7412888066765, 1765.911704414774, 1785.3929663914332, 85626.14373856244, 86265.0, 86891.56554217251, 89286.55356723175, 89435.55282223548, 10685.732856678489, 10843.240973131962, 10887.83668244977, 10946.39794811293, 11093.944530277297, 15181.240937953058, 15328.23358832054, 15369.231538423257, 15371.846281537266, 15412.383504659912, 7354.021482319692, 7505.812354691067, 7507.474476786681, 7650.846983060419, 7748.186440423674, 6919.308069193041, 7003.0, 7175.497715159889, 7195.424366050704, 7200.387967022757, 6685.231198412245, 6747.392734653905, 6858.588484690835, 6887.0, 6970.302969702989, 1970.7832138464757, 2017.3141132015185, 2035.1812739355803, 2048.6376559588007, 2168.8590241634242, 809.8582748019073, 838.5681374092347, 861.6854847980442, 880.6565439478609, 882.3955590420583, 14957.551273461813, 15283.617909552127, 15524.456644017406, 15539.456119036005, 15659.217039147998, 858.5878778186506, 878.8374150782125, 887.3699673231948, 897.4121950122681, 898.6161311580094, 8347.248747612744, 10419.166466682647, 11095.1123910087, 11113.777724445466, 11160.330380177214, 478312.989107706, 492126.0, 508246.0, 508290.0, 510657.0, 70999.0, 90017.54991225002, 92725.53637231905, 92924.0707592929, 93930.0, 1082.43172334525, 1111.1000089927186, 1111.1055600241882, 1112.3381587955155, 1116.642674344202, 17201.56996075108, 17237.087430082367, 17836.46490605284, 17859.28562857471, 18027.729584056513, 42918.5708142927, 43915.56084439243, 44526.0, 44823.0, 44961.550384495735, 48676.75661621811, 50667.0, 50960.0, 56868.43131568631, 58431.70784146052, 7911.28798408123, 7954.125046244792, 7967.521948683097, 8096.473729207582, 8185.959070204611, 11128.332300062022, 11282.605108821152, 11336.659900203007, 11701.88298117042, 11727.824082638937, 9670.75823104428, 9693.127618514367, 9833.557489913113, 10217.284790064625, 10242.487875606339, 9482.95258523703, 9795.902040979785, 9859.950700246452, 10119.291649584753, 10145.08694217524, 9501.952490237505, 10045.949770251395, 10478.266521343432, 10516.579336826748, 10965.067969222706, 10966.232363734462, 11241.887581124083, 11327.207095503236, 11452.82820757706, 11792.941035294769, 9992.250581206585, 10027.548760305657, 10044.296899216984, 10369.274150809371, 10421.06210441064], "value": 8933.424234314576, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1245.5516014234875, 1283.9422225999829, 1293.4502836294573, 1302.0625149892087, 1306.2358520265643, 9434.292428067887, 9803.117719405262, 9810.754731131725, 9966.152877005445, 10302.33034852736, 9851.65519206828, 10080.899191008088, 10094.0, 10109.848352274721, 10112.898871011288, 2104.4002459299063, 2156.892155392232, 2157.5361297321074, 2169.078141789741, 2169.3275084723787, 2090.571432856261, 2145.9678104828363, 2154.0845140815168, 2157.568486302746, 2170.197027099975, 2089.164334266298, 2124.6812978053263, 2127.287358734826, 2130.147940823675, 2146.130817019102, 2065.5765568058587, 2070.1201989154547, 2073.4712648274667, 2077.40793873746, 2079.4073688998715, 1732.2811033421115, 1785.2234278089072, 2018.1422895269452, 2046.1508473983279, 2051.8974051297523, 9743.756406089833, 9775.31572789905, 9859.654912078115, 9865.704028879145, 9874.061964113469, 5294.179402192666, 5443.401225865152, 5455.645383050089, 5457.972710136424, 5492.862678433031, 3185.7769956103084, 3233.0785726067957, 3241.9351612967844, 3248.31785325082, 3299.0762586475826, 992.811365840488, 1003.2876657573132, 1014.4420568687266, 1031.092638478142, 1044.216837371971, 14777.778333325008, 14802.481913132988, 14814.70370592593, 14867.628309292355, 14970.47603333889, 4392.494863090722, 4678.204705200124, 4746.905061898812, 4828.130936431406, 4829.879253018703, 10838.0, 10863.83704244437, 10873.728156796144, 10925.399103049409, 10930.508127134299, 5470.0, 5472.0, 5474.835754927359, 5475.67145971243, 5488.0, 4776.808927642925, 4925.458199598042, 4949.034938187091, 4959.454460009396, 5028.120078986236, 3617.186133120027, 3738.1962877981364, 3751.0, 3785.9242815143543, 3786.1670432504807, 1116.7659735991774, 1129.9265547739535, 1132.3319241647469, 1143.4106591837353, 1146.5585749486509, 618.4063299232697, 648.3969907985525, 650.2684479960045, 653.323809856796, 654.3750718064238, 4650.51169627191, 4686.81252749893, 4697.647676424282, 4756.120117778222, 4973.030259099441, 516.7080599461292, 524.5174439515655, 528.5797790756282, 530.6975024236149, 535.5474623942762, 3028.2732144285656, 3032.605761251023, 3053.114596766957, 3101.798383105091, 3180.7137357637926, 12767.42546585406, 13092.149010314299, 13295.069345145941, 13303.534376296782, 13349.532766353132, 13184.208947463183, 13187.934060329637, 13208.273544954927, 13214.27321497327, 13214.735705286033, 9008.099190080939, 9228.907710922938, 9350.438973661467, 9367.250619950388, 9376.109269619375, 6021.0, 6169.321374648695, 6234.846553387638, 6337.0, 6373.195793850691, 11333.829992550283, 11705.239159454948, 11761.235519691192, 11771.23486973344, 11853.822192667289, 11281.0, 11578.189526733047, 11607.245529040585, 11640.068794496588, 11817.0, 7849.254320839511, 8055.355571554144, 8088.595570221583, 8097.1497992712275, 8117.878231826409, 9086.818263634823, 9349.48577828226, 9353.064693530592, 9405.20055795265, 9479.952600236955, 8045.637946292314, 8297.626606802587, 8342.457740246864, 8392.03491598474, 8527.232549070613, 7658.770236892902, 7782.143964164051, 7818.374530037697, 7847.0, 7852.528848269122, 7203.927960720535, 7204.0, 7304.780856574312, 7310.926890731024, 7312.707491700273, 4794.664373493822, 4884.902301954012, 4922.138625740553, 4978.228374601942, 5088.0, 4844.273358996038, 4956.430010548833, 5167.483251674803, 5195.558087698775, 5201.505856943584], "value": 4541.689418856574, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.3446922996292, 401.1775859488049, 401.4219523885606, 407.4967415242177, 410.3229671042779, 5251.684898906068, 5413.323334583177, 5463.644863083897, 5499.3675727291375, 5528.612997090206, 5259.894802103956, 5374.6237763356585, 5434.538064264532, 5435.792882199502, 5453.427390124039, 4358.803853826569, 4362.716423432483, 4375.474943006843, 4385.56144385562, 4390.0, 4018.216447792667, 4200.768957707325, 4366.934495982563, 4389.780510974439, 4393.406890069848, 4142.772147531885, 4174.853880114197, 4177.2246795112105, 4178.582141785828, 4184.874453766377, 4165.770882601456, 4173.895652608694, 4176.310908700061, 4201.248182440507, 4213.0087637777215, 3687.815609219555, 3693.907652308687, 3698.445233215012, 3701.1857391373856, 3706.8331925063167, 5179.099704165642, 5289.1801770725215, 5306.734663266821, 5337.11937530307, 5340.305760251182, 4824.8311309104365, 4838.419389673227, 4848.636352273558, 4855.417349917997, 4856.538628830291, 5556.638818476786, 5743.684097374643, 5744.138379243147, 5753.395893431213, 5755.798547050875, 4054.3513037914086, 4067.7559346439307, 4072.124493233969, 4075.53131389891, 4094.0, 5729.942700572982, 5865.208196893407, 5984.9401505984815, 6027.698615069229, 6084.695765211722, 4093.5292441369625, 4109.075458021921, 4114.053767633461, 4121.361189015707, 4127.504699436087, 4180.28935081037, 4201.159768046403, 4203.747775133502, 4205.507044999043, 4222.831086756557, 4581.312803079565, 4795.20879054959, 4815.277708343777, 4843.709377437365, 4846.878828029327, 5750.654960702372, 5771.769129234867, 5784.623999440023, 5787.7395517200985, 5801.158831969341, 1440.7694768836936, 1455.3523681961638, 1460.291758497128, 1463.4073200353873, 1469.3387975411108, 933.0156684697573, 986.2061040862175, 986.7335819328885, 989.351974456732, 1000.8740167311774, 4958.752062396866, 4968.130577148984, 4981.750912454363, 4989.376327959005, 5006.949930500721, 5931.347551769302, 5955.34491205967, 5955.970220148872, 5958.880822383615, 5959.4934430573885, 4860.684055536379, 4965.975170124127, 4986.950130498722, 4991.251312303184, 5010.69935803853, 3112.50199968004, 3146.5594816725675, 3157.936841263162, 3160.336329370858, 3171.4608516552244, 5490.258815059996, 5509.228707980886, 5509.338879334506, 5512.80705175317, 5527.977324195037, 5922.230110085661, 6023.427774361428, 6056.364081771439, 6068.089786531968, 6088.969555152285, 5485.972570137204, 5500.287306068468, 5501.532369748536, 5514.172874068921, 5514.61397702157, 5778.335491418373, 5902.940970590239, 5910.852228694317, 5951.583389162717, 5952.970235148797, 5829.883402332014, 5863.384344643921, 5880.323762767165, 5880.882382352414, 5886.529077673861, 5237.188235823453, 5317.361916570037, 5362.678239305654, 5457.972710136424, 5485.6560142765275, 4103.835846566223, 4113.424120623175, 4122.154958233615, 4126.814293356746, 4144.44050053239, 5703.401142879938, 5912.320083190316, 5923.940760592512, 5948.791792287249, 5970.0746384310505, 5791.797287094932, 5799.739011744566, 5807.970960145172, 5811.56413268998, 5828.504577110993, 5731.8853622928145, 5758.107493338539, 5761.0124507045, 5771.624844385102, 5790.94209057904, 5566.332040155207, 5638.2670252866865, 5663.207150998781, 5723.399043100415, 5726.685032323262, 5771.826845194651, 5807.912881306699, 5820.679862607428, 5822.359540450462, 5838.708064596668, 5514.61397702157, 5624.521915637217, 5665.376808551138, 5681.346645135863, 5684.317881854204], "value": 4329.254071349596, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.8353169346738, 594.4620118792493, 598.6976576828706, 605.0863196573173, 605.8576234584872, 12547.811782823264, 12668.366581670914, 13017.153884997468, 13035.869641303585, 13051.73896522069, 12080.0, 12194.0, 12245.204061735982, 12285.078619103559, 12487.937560312186, 830.4933990265932, 837.0959363887002, 844.5650489997656, 848.1984524624232, 849.2272032450471, 853.3685073045964, 859.8839156713857, 866.514751739025, 866.8439680857443, 867.652938824469, 889.3107841422917, 889.8531742262519, 891.6121487153109, 892.0989800301677, 892.9107089291051, 874.4054043250587, 884.6549845560237, 888.1518150166607, 889.4707648948865, 891.0599317719802, 652.4877970792904, 653.0628548033587, 654.3129713800538, 654.8526581519168, 655.7442597387023, 13481.528146514924, 13580.456781728719, 13610.59168224955, 13616.319184040858, 14603.0, 12627.24236545801, 13041.543545975941, 13184.406701698446, 13466.289537652407, 13539.0, 9315.0, 9425.905740942571, 9633.662821801203, 9640.0, 10126.392416455037, 2584.2764026072728, 2593.118339764489, 2600.5189040027653, 2694.016683910378, 2699.9055033073746, 49875.25187122196, 50621.24068138944, 50877.491225087644, 62410.68794655998, 67580.66209668921, 8952.68665596701, 9024.36829421934, 9037.41256818318, 9210.539473026322, 9614.519274036411, 18257.908710456362, 18496.81503184951, 18601.7209741854, 18617.627647446974, 18632.44102676922, 6246.219222597176, 6302.905456418157, 6336.58812177207, 6595.505337099737, 6598.439132673777, 3170.7780455368365, 3270.8528116234825, 3300.603927528712, 3301.7688761786926, 3319.7344212462945, 3393.0669066006553, 3506.368853606324, 3550.6981906537717, 3562.679358857715, 3587.766795158306, 666.2271764752863, 669.1167658690482, 674.4098913450731, 678.4267294136447, 689.8137502874196, 436.2823155908513, 437.3221506664657, 442.3033721888039, 455.7584480225486, 459.0406051352689, 7444.702211911463, 7504.737334193277, 7701.0, 7779.06651201848, 7912.920870791334, 479.21887323662907, 500.22465178973175, 504.9419316778544, 505.8128492457814, 514.8764296568796, 3208.406444807718, 3210.9197270067966, 3245.724113450336, 3261.59230096238, 3286.8520916558814, 46011.53988460072, 55832.833433312684, 63200.36799632037, 65982.34017659762, 66151.0, 53486.465135348146, 55467.72266138724, 55676.44323556794, 56184.719076404355, 57347.713261433426, 38258.0, 48980.51019489759, 49260.50739492559, 49872.750636247314, 50733.492665072874, 6361.268454127649, 8145.389095817956, 8277.710280140167, 8398.328133749163, 8541.444806087584, 23575.0, 24557.0, 24941.501169976862, 25245.873770631028, 25659.486810264065, 32841.50737738888, 39215.0, 41793.79103104587, 42085.78957105195, 42143.57856421397, 10255.33340332876, 10266.435346056038, 10388.792224155324, 10451.895481045396, 10526.421046842497, 11538.07695384384, 11643.59247426336, 11705.0, 12027.15809893299, 12548.24710517372, 10491.632792852213, 10493.422861742678, 10697.0, 10801.351918884891, 11171.162162837658, 10622.309549879234, 10818.350898946088, 11274.436278185894, 11294.548218071184, 11304.434778261219, 10158.746031349276, 10567.705585474308, 10639.361638301727, 10740.83888741654, 11088.16838737114, 7828.0, 8148.126079962017, 8191.426600138171, 8237.258646721824, 8448.83102337962, 7330.0, 7734.108303392897, 8180.345572354317, 8265.504069755834, 8604.096569860074], "value": 5894.324814535424, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1574.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 113.0, 111.0, 115.0, 113.0, 112.0, 112.0, 111.0, 111.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 126.0, 125.0, 175.0, 127.0, 126.0, 129.0, 130.0, 148.0, 128.0], "value": 136.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 164.0, 168.0, 172.0, 168.0, 168.0, 163.0, 163.0, 164.0], "value": 166.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 78.0, 107.0, 84.0, 78.0, 75.0, 76.0, 92.0, 76.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 104.0, 89.0, 84.0, 84.0, 97.0, 84.0, 85.0, 103.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 113.0, 114.0, 114.0, 114.0, 121.0, 114.0, 114.0, 114.0], "value": 114.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 152.0, 153.0, 151.0, 153.0, 152.0, 152.0, 151.0, 152.0, 150.0], "value": 151.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 69.0, 70.0, 70.0, 73.0, 71.0, 70.0, 72.0, 73.0], "value": 70.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 56.0, 56.0, 57.0, 55.0, 56.0, 55.0, 57.0], "value": 55.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 82.0, 91.0, 90.0, 84.0, 91.0, 84.0, 82.0], "value": 85.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 136.0, 138.0, 146.0, 136.0, 144.0, 140.0, 148.0, 192.0, 139.0], "value": 145.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 195.0, 209.0, 196.0, 198.0, 191.0, 194.0, 193.0, 194.0, 206.0], "value": 196.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 72.0, 73.0, 74.0, 72.0, 70.0, 72.0, 71.0, 78.0], "value": 72.5, "unit": "score"}]}]} 07:14:38 INFO - Return code: 0 07:14:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:14:38 ERROR - # TBPL SUCCESS # 07:14:38 INFO - Running post-action listener: _resource_record_post_action 07:14:38 INFO - [mozharness: 2017-03-22 14:14:38.951566Z] Finished run-tests step (success) 07:14:38 INFO - Running post-run listener: _resource_record_post_run 07:14:39 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 0; Write bytes: 368635904; Read time: 0; Write time: 360268 07:14:39 INFO - TinderboxPrint: CPU usage
13.3% 07:14:39 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 07:14:39 INFO - TinderboxPrint: I/O write bytes / time
368,635,904 / 360,268 07:14:39 INFO - TinderboxPrint: CPU idle
8,313.4 (86.7%) 07:14:39 INFO - TinderboxPrint: CPU user
1,219.3 (12.7%) 07:14:39 INFO - TinderboxPrint: Swap in / out
0 / 0 07:14:39 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 112668672; Read time: 0; Write time: 137968 07:14:39 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 255430656; Read time: 0; Write time: 222300 07:14:39 INFO - Running post-run listener: _upload_blobber_files 07:14:39 INFO - Blob upload gear active. 07:14:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:14:39 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:14:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:14:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:14:40 INFO - (blobuploader) - INFO - Open directory for files ... 07:14:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:14:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:14:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:14:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:14:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:14:40 INFO - (blobuploader) - INFO - Done attempting. 07:14:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:14:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:14:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:14:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:14:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:14:42 INFO - (blobuploader) - INFO - Done attempting. 07:14:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:14:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:14:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:14:44 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:14:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:14:44 INFO - (blobuploader) - INFO - Done attempting. 07:14:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:14:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:14:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:14:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:14:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:14:47 INFO - (blobuploader) - INFO - Done attempting. 07:14:47 INFO - (blobuploader) - INFO - Iteration through files over. 07:14:47 INFO - Return code: 0 07:14:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:14:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:14:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/34bfad2b3f4c3190b0257c0707a792268a43d21a88fd10a4d194442000733f4f8c237f52b10903c3a3dcd5e72b298bd9997a4e7914ecf275444350300040efe3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/75c3410983c54e898d0e4eadb6b9decb713599366eaa8c82a23c5b1862d08217dd751e01d464d5a2000bee85bc96743c035602141e524b53d73578ec39647871", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/24598c9162ffd10e1df99d16e7364ece7b21674d160bdae6917833e85ea7f013d93f8554ea91173e7bdf870b7843d7bc290e1c1b490968a235b50e1105fc4c6e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ce905f1fdb73cd3647cc2407c2a1674a00865af5b52896c2b72f7f035d8bed073af9b9a0379f7b26ba68fe08e6698b1c71b1c5ecae20f318718c90fc17176923"} 07:14:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:14:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:14:47 INFO - Contents: 07:14:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/34bfad2b3f4c3190b0257c0707a792268a43d21a88fd10a4d194442000733f4f8c237f52b10903c3a3dcd5e72b298bd9997a4e7914ecf275444350300040efe3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/75c3410983c54e898d0e4eadb6b9decb713599366eaa8c82a23c5b1862d08217dd751e01d464d5a2000bee85bc96743c035602141e524b53d73578ec39647871", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/24598c9162ffd10e1df99d16e7364ece7b21674d160bdae6917833e85ea7f013d93f8554ea91173e7bdf870b7843d7bc290e1c1b490968a235b50e1105fc4c6e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ce905f1fdb73cd3647cc2407c2a1674a00865af5b52896c2b72f7f035d8bed073af9b9a0379f7b26ba68fe08e6698b1c71b1c5ecae20f318718c90fc17176923"} 07:14:47 INFO - Running post-run listener: copy_logs_to_upload_dir 07:14:47 INFO - Copying logs to upload dir... 07:14:47 INFO - mkdir: /builds/slave/test/build/upload/logs 07:14:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.676522 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-22 07:14:47.298110) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-22 07:14:47.301750) ========= 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=1258088b6da462a47ba2cd90000001a2-1490190822.754585-273925063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/34bfad2b3f4c3190b0257c0707a792268a43d21a88fd10a4d194442000733f4f8c237f52b10903c3a3dcd5e72b298bd9997a4e7914ecf275444350300040efe3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/75c3410983c54e898d0e4eadb6b9decb713599366eaa8c82a23c5b1862d08217dd751e01d464d5a2000bee85bc96743c035602141e524b53d73578ec39647871", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/24598c9162ffd10e1df99d16e7364ece7b21674d160bdae6917833e85ea7f013d93f8554ea91173e7bdf870b7843d7bc290e1c1b490968a235b50e1105fc4c6e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ce905f1fdb73cd3647cc2407c2a1674a00865af5b52896c2b72f7f035d8bed073af9b9a0379f7b26ba68fe08e6698b1c71b1c5ecae20f318718c90fc17176923"} build_url:https://queue.taskcluster.net/v1/task/O7Lvd8wLTGWtJkG55dwpKg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011260 build_url: 'https://queue.taskcluster.net/v1/task/O7Lvd8wLTGWtJkG55dwpKg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/34bfad2b3f4c3190b0257c0707a792268a43d21a88fd10a4d194442000733f4f8c237f52b10903c3a3dcd5e72b298bd9997a4e7914ecf275444350300040efe3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/75c3410983c54e898d0e4eadb6b9decb713599366eaa8c82a23c5b1862d08217dd751e01d464d5a2000bee85bc96743c035602141e524b53d73578ec39647871", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/24598c9162ffd10e1df99d16e7364ece7b21674d160bdae6917833e85ea7f013d93f8554ea91173e7bdf870b7843d7bc290e1c1b490968a235b50e1105fc4c6e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ce905f1fdb73cd3647cc2407c2a1674a00865af5b52896c2b72f7f035d8bed073af9b9a0379f7b26ba68fe08e6698b1c71b1c5ecae20f318718c90fc17176923"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-22 07:14:47.327453) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 07:14:47.327834) ========= 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=1258088b6da462a47ba2cd90000001a2-1490190822.754585-273925063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004554 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 07:14:47.415441) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-22 07:14:47.415818) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-22 07:14:47.416228) ========= ========= Total master_lag: 0.16 =========