builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-018 starttime: 1489580886.62 results: success (0) revision: 0cc9dced786cf2a3baeff707b636b4ad02637df0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-15 05:28:06.617182) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-15 05:28:06.617657) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-15 05:28:06.617930) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-15 05:28:06.632846) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 05:28:06.633229) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1489580886.222668-1094734497 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-15 05:28:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.5M=0s 2017-03-15 05:28:06 (37.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.111578 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 05:28:06.758685) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 05:28:06.758990) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1489580886.222668-1094734497 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015037 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 05:28:06.809287) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-15 05:28:06.809637) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0cc9dced786cf2a3baeff707b636b4ad02637df0 --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 0cc9dced786cf2a3baeff707b636b4ad02637df0 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1489580886.222668-1094734497 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-15 05:28:07,087 truncating revision to first 12 chars 2017-03-15 05:28:07,087 Setting DEBUG logging. 2017-03-15 05:28:07,087 attempt 1/10 2017-03-15 05:28:07,087 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0cc9dced786c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-15 05:28:08,331 unpacking tar archive at: mozilla-central-0cc9dced786c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.595733 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-15 05:28:08.418442) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-15 05:28:08.418762) ========= script_repo_revision: 0cc9dced786cf2a3baeff707b636b4ad02637df0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-15 05:28:08.419168) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-15 05:28:08.419445) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-15 05:28:08.428714) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-03-15 05:28:08.429156) ========= /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=62c568580acbfdaac3eec7be000001dc-1489580886.222668-1094734497 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:28:08 INFO - MultiFileLogger online at 20170315 05:28:08 in /builds/slave/test 05:28:08 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 05:28:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:28:08 INFO - {'append_to_log': False, 05:28:08 INFO - 'base_work_dir': '/builds/slave/test', 05:28:08 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:28:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:28:08 INFO - 'branch': 'Firefox-Non-PGO', 05:28:08 INFO - 'buildbot_json_path': 'buildprops.json', 05:28:08 INFO - 'config_files': ('talos/linux_config.py',), 05:28:08 INFO - 'default_actions': ('clobber', 05:28:08 INFO - 'read-buildbot-config', 05:28:08 INFO - 'download-and-extract', 05:28:08 INFO - 'populate-webroot', 05:28:08 INFO - 'create-virtualenv', 05:28:08 INFO - 'install', 05:28:08 INFO - 'run-tests'), 05:28:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:28:08 INFO - 'download_minidump_stackwalk': True, 05:28:08 INFO - 'download_symbols': 'ondemand', 05:28:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:28:08 INFO - 'tooltool.py': '/tools/tooltool.py', 05:28:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:28:08 INFO - '/tools/misc-python/virtualenv.py')}, 05:28:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:28:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:28:08 INFO - 'gecko_profile': False, 05:28:08 INFO - 'gecko_profile_interval': 0, 05:28:08 INFO - 'installer_path': 'installer.exe', 05:28:08 INFO - 'log_level': 'info', 05:28:08 INFO - 'log_name': 'talos', 05:28:08 INFO - 'log_to_console': True, 05:28:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:28:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:28:08 INFO - 'opt_config_files': (), 05:28:08 INFO - 'pip_index': False, 05:28:08 INFO - 'suite': 'dromaeojs-e10s', 05:28:08 INFO - 'system_bits': '32', 05:28:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:28:08 INFO - 'title': 'talos-linux64-ix-018', 05:28:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:28:08 INFO - 'use_talos_json': True, 05:28:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:28:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:28:08 INFO - 'work_dir': 'build'} 05:28:08 INFO - [mozharness: 2017-03-15 12:28:08.811523Z] Running clobber step. 05:28:08 INFO - Running pre-action listener: _resource_record_pre_action 05:28:08 INFO - Running main action method: clobber 05:28:08 INFO - rmtree: /builds/slave/test/build 05:28:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:28:10 INFO - Running post-action listener: _resource_record_post_action 05:28:10 INFO - [mozharness: 2017-03-15 12:28:10.324033Z] Finished clobber step (success) 05:28:10 INFO - [mozharness: 2017-03-15 12:28:10.324130Z] Running read-buildbot-config step. 05:28:10 INFO - Running pre-action listener: _resource_record_pre_action 05:28:10 INFO - Running main action method: read_buildbot_config 05:28:10 INFO - Using buildbot properties: 05:28:10 INFO - { 05:28:10 INFO - "project": "", 05:28:10 INFO - "product": "firefox", 05:28:10 INFO - "who": "cbook@mozilla.com", 05:28:10 INFO - "installer_path": "public/build/target.tar.bz2", 05:28:10 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:28:10 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:28:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 05:28:10 INFO - "stage_platform": "linux64", 05:28:10 INFO - "basedir": "/builds/slave/test", 05:28:10 INFO - "buildnumber": 722, 05:28:10 INFO - "platform": "ubuntu64_hw", 05:28:10 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:28:10 INFO - "slavebuilddir": "test", 05:28:10 INFO - "taskId": "Y53L7lt8QImR_wha2IITRQ", 05:28:10 INFO - "branch": "mozilla-central", 05:28:10 INFO - "script_repo_revision": "production", 05:28:10 INFO - "revision": "0cc9dced786cf2a3baeff707b636b4ad02637df0", 05:28:10 INFO - "slavename": "talos-linux64-ix-018", 05:28:10 INFO - "repo_path": "mozilla-central" 05:28:10 INFO - } 05:28:10 INFO - Finding installer, test and symbols from parent task. 05:28:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y53L7lt8QImR_wha2IITRQ'}, attempt #1 05:28:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y53L7lt8QImR_wha2IITRQ'}, attempt #1 05:28:11 INFO - Task dependencies: CcwqoAPJRTGe2QwjqJGbJQ 05:28:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ'}, attempt #1 05:28:11 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.tar.bz2 05:28:11 INFO - Set test_url: https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/test_packages.json 05:28:11 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.crashreporter-symbols.zip 05:28:11 INFO - Running post-action listener: _resource_record_post_action 05:28:11 INFO - [mozharness: 2017-03-15 12:28:11.712683Z] Finished read-buildbot-config step (success) 05:28:11 INFO - [mozharness: 2017-03-15 12:28:11.712898Z] Running download-and-extract step. 05:28:11 INFO - Running pre-action listener: _resource_record_pre_action 05:28:11 INFO - Running main action method: download_and_extract 05:28:11 INFO - mkdir: /builds/slave/test/build/tests 05:28:11 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')]} 05:28:11 INFO - trying https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.test_packages.json 05:28:11 INFO - Downloading https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:28:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:28:12 INFO - Downloaded 896 bytes. 05:28:12 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:28:12 INFO - Using the following test package requirements: 05:28:12 INFO - {u'common': [u'target.common.tests.zip'], 05:28:12 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:28:12 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:28:12 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:28:12 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:28:12 INFO - u'mozbase': [u'target.common.tests.zip'], 05:28:12 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:28:12 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:28:12 INFO - u'web-platform': [u'target.common.tests.zip', 05:28:12 INFO - u'target.web-platform.tests.zip'], 05:28:12 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:28:12 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:28:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.common.tests.zip 05:28:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:28:12 INFO - Fetch https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.common.tests.zip into memory 05:28:13 INFO - Expected file size: 58185609 05:28:13 INFO - Obtained file size: 58185609 05:28:23 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:28:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.common.tests.zip 05:28:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:28:23 INFO - Fetch https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.common.tests.zip into memory 05:28:24 INFO - Expected file size: 58185609 05:28:24 INFO - Obtained file size: 58185609 05:28:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.talos.tests.zip 05:28:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:28:35 INFO - Fetch https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.talos.tests.zip into memory 05:28:36 INFO - Expected file size: 14404452 05:28:36 INFO - Obtained file size: 14404452 05:28:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:36 INFO - trying https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.tar.bz2 05:28:36 INFO - Downloading https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:28:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:28:37 INFO - Downloaded 61742255 bytes. 05:28:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.tar.bz2 05:28:37 INFO - mkdir: /builds/slave/test/properties 05:28:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:28:37 INFO - Writing to file /builds/slave/test/properties/build_url 05:28:37 INFO - Contents: 05:28:37 INFO - build_url:https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.tar.bz2 05:28:37 INFO - Running post-action listener: _resource_record_post_action 05:28:37 INFO - Running post-action listener: set_extra_try_arguments 05:28:37 INFO - [mozharness: 2017-03-15 12:28:37.544596Z] Finished download-and-extract step (success) 05:28:37 INFO - [mozharness: 2017-03-15 12:28:37.544692Z] Running populate-webroot step. 05:28:37 INFO - Running pre-action listener: _resource_record_pre_action 05:28:37 INFO - Running main action method: populate_webroot 05:28:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:28:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:28:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:28:37 INFO - '--tppagecycles', 05:28:37 INFO - '7'], 05:28:37 INFO - 'tests': ['tsvgm']}}, 05:28:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:28:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:28:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:28:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:28:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:28:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:28:37 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:28:37 INFO - 'talos_options': ['--disable-e10s'], 05:28:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:28:37 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:28:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:28:37 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:28:37 INFO - 'talos_options': ['--disable-e10s'], 05:28:37 INFO - 'tests': ['damp', 'tps']}, 05:28:37 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:28:37 INFO - 'tests': ['damp', 'tps']}, 05:28:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:28:37 INFO - 'tests': ['dromaeo_dom']}, 05:28:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:28:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:28:37 INFO - 'tests': ['basic_compositor_video']}, 05:28:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:28:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:28:37 INFO - 'tests': ['a11yr', 05:28:37 INFO - 'ts_paint', 05:28:37 INFO - 'tpaint', 05:28:37 INFO - 'sessionrestore', 05:28:37 INFO - 'sessionrestore_no_auto_restore', 05:28:37 INFO - 'tabpaint']}, 05:28:37 INFO - 'other-e10s': {'tests': ['a11yr', 05:28:37 INFO - 'ts_paint', 05:28:37 INFO - 'tpaint', 05:28:37 INFO - 'sessionrestore', 05:28:37 INFO - 'sessionrestore_no_auto_restore', 05:28:37 INFO - 'tabpaint']}, 05:28:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:28:37 INFO - 'ts_paint', 05:28:37 INFO - 'tpaint', 05:28:37 INFO - 'sessionrestore', 05:28:37 INFO - 'sessionrestore_no_auto_restore', 05:28:37 INFO - 'tabpaint']}, 05:28:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:28:37 INFO - 'ts_paint', 05:28:37 INFO - 'tpaint', 05:28:37 INFO - 'sessionrestore', 05:28:37 INFO - 'sessionrestore_no_auto_restore', 05:28:37 INFO - 'tabpaint']}, 05:28:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:28:37 INFO - 'tests': ['a11yr', 05:28:37 INFO - 'ts_paint', 05:28:37 INFO - 'tpaint', 05:28:37 INFO - 'sessionrestore', 05:28:37 INFO - 'sessionrestore_no_auto_restore', 05:28:37 INFO - 'tabpaint']}, 05:28:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:28:37 INFO - 'tests': ['a11yr', 05:28:37 INFO - 'ts_paint', 05:28:37 INFO - 'tpaint', 05:28:37 INFO - 'sessionrestore', 05:28:37 INFO - 'sessionrestore_no_auto_restore', 05:28:37 INFO - 'tabpaint']}, 05:28:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:28:37 INFO - 'tests': ['tsvgx', 05:28:37 INFO - 'tsvgr_opacity', 05:28:37 INFO - 'tart', 05:28:37 INFO - 'tscrollx', 05:28:37 INFO - 'cart', 05:28:37 INFO - 'tsvg_static']}, 05:28:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:28:37 INFO - 'tsvgr_opacity', 05:28:37 INFO - 'tart', 05:28:37 INFO - 'tscrollx', 05:28:37 INFO - 'cart', 05:28:37 INFO - 'tsvg_static']}, 05:28:37 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:28:37 INFO - 'talos_options': ['--disable-e10s'], 05:28:37 INFO - 'tests': ['tp5o']}, 05:28:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:28:37 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:28:37 INFO - 'talos_options': ['--disable-e10s', 05:28:37 INFO - '--xperf_path', 05:28:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:28:37 INFO - 'tests': ['tp5n']}, 05:28:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:28:37 INFO - 'talos_options': ['--xperf_path', 05:28:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:28:37 INFO - 'tests': ['tp5n']}}, 05:28:37 INFO - 'talos.zip': {'path': '', 05:28:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:28:37 INFO - Running post-action listener: _resource_record_post_action 05:28:37 INFO - [mozharness: 2017-03-15 12:28:37.557756Z] Finished populate-webroot step (success) 05:28:37 INFO - [mozharness: 2017-03-15 12:28:37.557847Z] Running create-virtualenv step. 05:28:37 INFO - Running pre-action listener: _resource_record_pre_action 05:28:37 INFO - Running main action method: create_virtualenv 05:28:37 INFO - Creating virtualenv /builds/slave/test/build/venv 05:28:37 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 05:28:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:28:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:28:37 INFO - Using real prefix '/usr' 05:28:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:28:38 INFO - Installing distribute.............................................................................................................................................................................................done. 05:28:40 INFO - Installing pip.................done. 05:28:40 INFO - Return code: 0 05:28:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:28:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:28:40 INFO - Reading from file tmpfile_stdout 05:28:40 INFO - Output received: 05:28:40 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) 05:28:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:28:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:40 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 0x16641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1901b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ff290>, '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 0x18ffb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1900040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1489580886.222668-1094734497', '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 05:28:40 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 05:28:40 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 05:28:40 INFO - Using env: {'DISPLAY': ':0', 05:28:40 INFO - 'HOME': '/home/cltbld', 05:28:40 INFO - 'LANG': 'en_US.UTF-8', 05:28:40 INFO - 'LANGUAGE': 'en_US:en', 05:28:40 INFO - 'LOGNAME': 'cltbld', 05:28:40 INFO - 'MAIL': '/var/mail/cltbld', 05:28:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:40 INFO - 'MOZ_NO_REMOTE': '1', 05:28:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:40 INFO - 'NO_EM_RESTART': '1', 05:28:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:40 INFO - 'PWD': '/builds/slave/test', 05:28:40 INFO - 'SHELL': '/bin/bash', 05:28:40 INFO - 'SHLVL': '1', 05:28:40 INFO - 'TERM': 'linux', 05:28:40 INFO - 'TMOUT': '86400', 05:28:40 INFO - 'USER': 'cltbld', 05:28:40 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1489580886.222668-1094734497', 05:28:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:40 INFO - '_': '/tools/buildbot/bin/python'} 05:28:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:40 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 05:28:40 INFO - Cleaning up... 05:28:40 INFO - Return code: 0 05:28:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:28:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:40 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 0x16641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1901b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ff290>, '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 0x18ffb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1900040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1489580886.222668-1094734497', '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 05:28:40 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 05:28:40 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 05:28:40 INFO - Using env: {'DISPLAY': ':0', 05:28:40 INFO - 'HOME': '/home/cltbld', 05:28:40 INFO - 'LANG': 'en_US.UTF-8', 05:28:40 INFO - 'LANGUAGE': 'en_US:en', 05:28:40 INFO - 'LOGNAME': 'cltbld', 05:28:40 INFO - 'MAIL': '/var/mail/cltbld', 05:28:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:40 INFO - 'MOZ_NO_REMOTE': '1', 05:28:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:40 INFO - 'NO_EM_RESTART': '1', 05:28:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:40 INFO - 'PWD': '/builds/slave/test', 05:28:40 INFO - 'SHELL': '/bin/bash', 05:28:40 INFO - 'SHLVL': '1', 05:28:40 INFO - 'TERM': 'linux', 05:28:40 INFO - 'TMOUT': '86400', 05:28:40 INFO - 'USER': 'cltbld', 05:28:40 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1489580886.222668-1094734497', 05:28:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:40 INFO - '_': '/tools/buildbot/bin/python'} 05:28:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:40 INFO - Downloading/unpacking psutil>=3.1.1 05:28:40 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 05:28:40 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 05:28:40 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 05:28:40 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 05:28:40 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 05:28:40 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 05:28:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:28:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:28:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:28:42 INFO - Installing collected packages: psutil 05:28:42 INFO - Running setup.py install for psutil 05:28:42 INFO - building 'psutil._psutil_linux' extension 05:28:42 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 05:28:43 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 05:28:43 INFO - building 'psutil._psutil_posix' extension 05:28:43 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 05:28:43 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 05:28:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:28:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:28:43 INFO - Successfully installed psutil 05:28:43 INFO - Cleaning up... 05:28:43 INFO - Return code: 0 05:28:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:28:43 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')]} 05:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:43 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')]} 05:28:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:43 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 0x16641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1901b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ff290>, '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 0x18ffb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1900040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1489580886.222668-1094734497', '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 05:28:43 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 05:28:43 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 05:28:43 INFO - Using env: {'DISPLAY': ':0', 05:28:43 INFO - 'HOME': '/home/cltbld', 05:28:43 INFO - 'LANG': 'en_US.UTF-8', 05:28:43 INFO - 'LANGUAGE': 'en_US:en', 05:28:43 INFO - 'LOGNAME': 'cltbld', 05:28:43 INFO - 'MAIL': '/var/mail/cltbld', 05:28:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:43 INFO - 'MOZ_NO_REMOTE': '1', 05:28:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:43 INFO - 'NO_EM_RESTART': '1', 05:28:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:43 INFO - 'PWD': '/builds/slave/test', 05:28:43 INFO - 'SHELL': '/bin/bash', 05:28:43 INFO - 'SHLVL': '1', 05:28:43 INFO - 'TERM': 'linux', 05:28:43 INFO - 'TMOUT': '86400', 05:28:43 INFO - 'USER': 'cltbld', 05:28:43 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1489580886.222668-1094734497', 05:28:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:43 INFO - '_': '/tools/buildbot/bin/python'} 05:28:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:28:43 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 05:28:43 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 05:28:43 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 05:28:43 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 05:28:43 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 05:28:43 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 05:28:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:28:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:28:45 INFO - Installing collected packages: mozsystemmonitor 05:28:45 INFO - Running setup.py install for mozsystemmonitor 05:28:45 INFO - Successfully installed mozsystemmonitor 05:28:45 INFO - Cleaning up... 05:28:45 INFO - Return code: 0 05:28:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:45 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 0x16641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1901b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ff290>, '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 0x18ffb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1900040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1489580886.222668-1094734497', '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 05:28:45 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 05:28:45 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 05:28:45 INFO - Using env: {'DISPLAY': ':0', 05:28:45 INFO - 'HOME': '/home/cltbld', 05:28:45 INFO - 'LANG': 'en_US.UTF-8', 05:28:45 INFO - 'LANGUAGE': 'en_US:en', 05:28:45 INFO - 'LOGNAME': 'cltbld', 05:28:45 INFO - 'MAIL': '/var/mail/cltbld', 05:28:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:45 INFO - 'MOZ_NO_REMOTE': '1', 05:28:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:45 INFO - 'NO_EM_RESTART': '1', 05:28:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:45 INFO - 'PWD': '/builds/slave/test', 05:28:45 INFO - 'SHELL': '/bin/bash', 05:28:45 INFO - 'SHLVL': '1', 05:28:45 INFO - 'TERM': 'linux', 05:28:45 INFO - 'TMOUT': '86400', 05:28:45 INFO - 'USER': 'cltbld', 05:28:45 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1489580886.222668-1094734497', 05:28:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:45 INFO - '_': '/tools/buildbot/bin/python'} 05:28:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:46 INFO - Downloading/unpacking jsonschema==2.5.1 05:28:46 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 05:28:46 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 05:28:46 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 05:28:46 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 05:28:46 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 05:28:46 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 05:28:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:28:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:28:48 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 05:28:48 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 05:28:48 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 05:28:48 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 05:28:48 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 05:28:48 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 05:28:48 INFO - Downloading functools32-3.2.3-2.tar.gz 05:28:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:28:48 INFO - warning: no files found matching '*.txt' 05:28:48 INFO - no previously-included directories found matching 'build' 05:28:48 INFO - no previously-included directories found matching 'dist' 05:28:48 INFO - no previously-included directories found matching '.git*' 05:28:48 INFO - Installing collected packages: jsonschema, functools32 05:28:48 INFO - Running setup.py install for functools32 05:28:48 INFO - warning: no files found matching '*.txt' 05:28:48 INFO - no previously-included directories found matching 'build' 05:28:48 INFO - no previously-included directories found matching 'dist' 05:28:48 INFO - no previously-included directories found matching '.git*' 05:28:48 INFO - Successfully installed jsonschema functools32 05:28:48 INFO - Cleaning up... 05:28:48 INFO - Return code: 0 05:28:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:28:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:48 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 0x16641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1901b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ff290>, '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 0x18ffb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1900040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1489580886.222668-1094734497', '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 05:28:48 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 05:28:48 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 05:28:48 INFO - Using env: {'DISPLAY': ':0', 05:28:48 INFO - 'HOME': '/home/cltbld', 05:28:48 INFO - 'LANG': 'en_US.UTF-8', 05:28:48 INFO - 'LANGUAGE': 'en_US:en', 05:28:48 INFO - 'LOGNAME': 'cltbld', 05:28:48 INFO - 'MAIL': '/var/mail/cltbld', 05:28:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:48 INFO - 'MOZ_NO_REMOTE': '1', 05:28:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:48 INFO - 'NO_EM_RESTART': '1', 05:28:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:48 INFO - 'PWD': '/builds/slave/test', 05:28:48 INFO - 'SHELL': '/bin/bash', 05:28:48 INFO - 'SHLVL': '1', 05:28:48 INFO - 'TERM': 'linux', 05:28:48 INFO - 'TMOUT': '86400', 05:28:48 INFO - 'USER': 'cltbld', 05:28:48 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1489580886.222668-1094734497', 05:28:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:48 INFO - '_': '/tools/buildbot/bin/python'} 05:28:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:28:48 INFO - Cleaning up... 05:28:48 INFO - Return code: 0 05:28:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:28:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:48 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 0x16641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1901b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ff290>, '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 0x18ffb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1900040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1489580886.222668-1094734497', '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 05:28:48 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 05:28:48 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 05:28:48 INFO - Using env: {'DISPLAY': ':0', 05:28:48 INFO - 'HOME': '/home/cltbld', 05:28:48 INFO - 'LANG': 'en_US.UTF-8', 05:28:48 INFO - 'LANGUAGE': 'en_US:en', 05:28:48 INFO - 'LOGNAME': 'cltbld', 05:28:48 INFO - 'MAIL': '/var/mail/cltbld', 05:28:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:48 INFO - 'MOZ_NO_REMOTE': '1', 05:28:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:48 INFO - 'NO_EM_RESTART': '1', 05:28:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:48 INFO - 'PWD': '/builds/slave/test', 05:28:48 INFO - 'SHELL': '/bin/bash', 05:28:48 INFO - 'SHLVL': '1', 05:28:48 INFO - 'TERM': 'linux', 05:28:48 INFO - 'TMOUT': '86400', 05:28:48 INFO - 'USER': 'cltbld', 05:28:48 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1489580886.222668-1094734497', 05:28:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:48 INFO - '_': '/tools/buildbot/bin/python'} 05:28:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:49 INFO - Downloading/unpacking blobuploader==1.2.4 05:28:49 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 05:28:49 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 05:28:49 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 05:28:49 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 05:28:49 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 05:28:49 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 05:28:51 INFO - Downloading blobuploader-1.2.4.tar.gz 05:28:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:28:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:28:51 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 05:28:51 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 05:28:51 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 05:28:51 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 05:28:51 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 05:28:51 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 05:28:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:28:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:28:51 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 05:28:51 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 05:28:51 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 05:28:51 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 05:28:51 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 05:28:51 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 05:28:51 INFO - Downloading docopt-0.6.1.tar.gz 05:28:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:28:51 INFO - Installing collected packages: blobuploader, requests, docopt 05:28:51 INFO - Running setup.py install for blobuploader 05:28:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:28:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:28:51 INFO - Running setup.py install for requests 05:28:52 INFO - Running setup.py install for docopt 05:28:52 INFO - Successfully installed blobuploader requests docopt 05:28:52 INFO - Cleaning up... 05:28:52 INFO - Return code: 0 05:28:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:28:52 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')]} 05:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:52 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')]} 05:28:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:52 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 0x16641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1901b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ff290>, '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 0x18ffb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1900040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1489580886.222668-1094734497', '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 05:28:52 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 05:28:52 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 05:28:52 INFO - Using env: {'DISPLAY': ':0', 05:28:52 INFO - 'HOME': '/home/cltbld', 05:28:52 INFO - 'LANG': 'en_US.UTF-8', 05:28:52 INFO - 'LANGUAGE': 'en_US:en', 05:28:52 INFO - 'LOGNAME': 'cltbld', 05:28:52 INFO - 'MAIL': '/var/mail/cltbld', 05:28:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:52 INFO - 'MOZ_NO_REMOTE': '1', 05:28:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:52 INFO - 'NO_EM_RESTART': '1', 05:28:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:52 INFO - 'PWD': '/builds/slave/test', 05:28:52 INFO - 'SHELL': '/bin/bash', 05:28:52 INFO - 'SHLVL': '1', 05:28:52 INFO - 'TERM': 'linux', 05:28:52 INFO - 'TMOUT': '86400', 05:28:52 INFO - 'USER': 'cltbld', 05:28:52 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1489580886.222668-1094734497', 05:28:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:52 INFO - '_': '/tools/buildbot/bin/python'} 05:28:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:28:52 INFO - Running setup.py (path:/tmp/pip-EKlqG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:28:52 INFO - Running setup.py (path:/tmp/pip-najTF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:28:52 INFO - Running setup.py (path:/tmp/pip-3FIGuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:28:52 INFO - Running setup.py (path:/tmp/pip-_X4g_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:28:52 INFO - Running setup.py (path:/tmp/pip-WhcsM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:28:53 INFO - Running setup.py (path:/tmp/pip-pwj8rq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:28:53 INFO - Running setup.py (path:/tmp/pip-U7jFYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:28:53 INFO - Running setup.py (path:/tmp/pip-Czqeqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:28:53 INFO - Running setup.py (path:/tmp/pip-0W59_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:28:53 INFO - Running setup.py (path:/tmp/pip-UaVHia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:28:53 INFO - Running setup.py (path:/tmp/pip-SH9ZNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:28:53 INFO - Running setup.py (path:/tmp/pip-gsfece-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:28:53 INFO - Running setup.py (path:/tmp/pip-_nMqrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:28:53 INFO - Running setup.py (path:/tmp/pip-UpS7Rr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:28:53 INFO - Running setup.py (path:/tmp/pip-RgFX_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:28:53 INFO - Running setup.py (path:/tmp/pip-FczyHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:28:53 INFO - Running setup.py (path:/tmp/pip-QLwOvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:28:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:28:53 INFO - Running setup.py install for manifestparser 05:28:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:28:54 INFO - Running setup.py install for mozcrash 05:28:54 INFO - Running setup.py install for mozdebug 05:28:54 INFO - Running setup.py install for mozdevice 05:28:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:28:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:28:54 INFO - Running setup.py install for mozfile 05:28:54 INFO - Running setup.py install for mozhttpd 05:28:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:28:54 INFO - Running setup.py install for mozinfo 05:28:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:28:54 INFO - Running setup.py install for mozInstall 05:28:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:28:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:28:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:28:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:28:54 INFO - Running setup.py install for mozleak 05:28:54 INFO - Running setup.py install for mozlog 05:28:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:28:54 INFO - Running setup.py install for moznetwork 05:28:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:28:55 INFO - Running setup.py install for mozprocess 05:28:55 INFO - Running setup.py install for mozprofile 05:28:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:28:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:28:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:28:55 INFO - Running setup.py install for mozrunner 05:28:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:28:55 INFO - Running setup.py install for mozscreenshot 05:28:55 INFO - Running setup.py install for moztest 05:28:55 INFO - Running setup.py install for mozversion 05:28:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:28:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:28:55 INFO - Cleaning up... 05:28:55 INFO - Return code: 0 05:28:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:28:55 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')]} 05:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:55 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')]} 05:28:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:55 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 0x16641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1901b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ff290>, '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 0x18ffb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1900040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1489580886.222668-1094734497', '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 05:28:55 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 05:28:55 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 05:28:55 INFO - Using env: {'DISPLAY': ':0', 05:28:55 INFO - 'HOME': '/home/cltbld', 05:28:55 INFO - 'LANG': 'en_US.UTF-8', 05:28:55 INFO - 'LANGUAGE': 'en_US:en', 05:28:55 INFO - 'LOGNAME': 'cltbld', 05:28:55 INFO - 'MAIL': '/var/mail/cltbld', 05:28:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:55 INFO - 'MOZ_NO_REMOTE': '1', 05:28:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:55 INFO - 'NO_EM_RESTART': '1', 05:28:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:55 INFO - 'PWD': '/builds/slave/test', 05:28:55 INFO - 'SHELL': '/bin/bash', 05:28:55 INFO - 'SHLVL': '1', 05:28:55 INFO - 'TERM': 'linux', 05:28:55 INFO - 'TMOUT': '86400', 05:28:55 INFO - 'USER': 'cltbld', 05:28:55 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1489580886.222668-1094734497', 05:28:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:55 INFO - '_': '/tools/buildbot/bin/python'} 05:28:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:28:55 INFO - Running setup.py (path:/tmp/pip-3RKCGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:28:56 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)) 05:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:28:56 INFO - Running setup.py (path:/tmp/pip-M5MBSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:28:56 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)) 05:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:28:56 INFO - Running setup.py (path:/tmp/pip-8tpRuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:28:56 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)) 05:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:28:56 INFO - Running setup.py (path:/tmp/pip-qCcM6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:28:56 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)) 05:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:28:56 INFO - Running setup.py (path:/tmp/pip-JiHJgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:28:56 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)) 05:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:28:56 INFO - Running setup.py (path:/tmp/pip-kV71CT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:28:56 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)) 05:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:28:56 INFO - Running setup.py (path:/tmp/pip-oqLVdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:28:56 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)) 05:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:28:56 INFO - Running setup.py (path:/tmp/pip-_uXTsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:28:56 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)) 05:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:28:56 INFO - Running setup.py (path:/tmp/pip-tAFEZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:28:56 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)) 05:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:28:56 INFO - Running setup.py (path:/tmp/pip-hqhhQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:28:56 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)) 05:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:28:56 INFO - Running setup.py (path:/tmp/pip-NOl0nm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:28:56 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)) 05:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:28:56 INFO - Running setup.py (path:/tmp/pip-m_pI8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:28:56 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)) 05:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:28:56 INFO - Running setup.py (path:/tmp/pip-12e6LJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:28:56 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)) 05:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:28:56 INFO - Running setup.py (path:/tmp/pip-CprYEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:28:57 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)) 05:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:28:57 INFO - Running setup.py (path:/tmp/pip-gA_C6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:28:57 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)) 05:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:28:57 INFO - Running setup.py (path:/tmp/pip-euGMzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:28:57 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)) 05:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:28:57 INFO - Running setup.py (path:/tmp/pip-ql9gWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:28:57 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)) 05:28:57 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)) 05:28:57 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)) 05:28:57 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)) 05:28:57 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)) 05:28:57 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)) 05:28:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:59 INFO - Downloading blessings-1.6.tar.gz 05:28:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:28:59 INFO - Installing collected packages: blessings 05:28:59 INFO - Running setup.py install for blessings 05:28:59 INFO - Successfully installed blessings 05:28:59 INFO - Cleaning up... 05:28:59 INFO - Return code: 0 05:28:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:28:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:28:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:28:59 INFO - Reading from file tmpfile_stdout 05:28:59 INFO - Current package versions: 05:28:59 INFO - argparse == 1.2.1 05:28:59 INFO - blessings == 1.6 05:28:59 INFO - blobuploader == 1.2.4 05:28:59 INFO - docopt == 0.6.1 05:28:59 INFO - functools32 == 3.2.3-2 05:28:59 INFO - jsonschema == 2.5.1 05:28:59 INFO - manifestparser == 1.1 05:28:59 INFO - mozInstall == 1.12 05:28:59 INFO - mozcrash == 1.0 05:28:59 INFO - mozdebug == 0.1 05:28:59 INFO - mozdevice == 0.49 05:28:59 INFO - mozfile == 1.2 05:28:59 INFO - mozhttpd == 0.7 05:28:59 INFO - mozinfo == 0.9 05:28:59 INFO - mozleak == 0.1 05:28:59 INFO - mozlog == 3.4 05:28:59 INFO - moznetwork == 0.27 05:28:59 INFO - mozprocess == 0.25 05:28:59 INFO - mozprofile == 0.28 05:28:59 INFO - mozrunner == 6.13 05:28:59 INFO - mozscreenshot == 0.1 05:28:59 INFO - mozsystemmonitor == 0.3 05:28:59 INFO - moztest == 0.8 05:28:59 INFO - mozversion == 1.4 05:28:59 INFO - psutil == 3.1.1 05:28:59 INFO - requests == 1.2.3 05:28:59 INFO - wsgiref == 0.1.2 05:28:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:28:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:59 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 0x16641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1901b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ff290>, '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 0x18ffb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1900040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1489580886.222668-1094734497', '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 05:28:59 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 05:28:59 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 05:28:59 INFO - Using env: {'DISPLAY': ':0', 05:28:59 INFO - 'HOME': '/home/cltbld', 05:28:59 INFO - 'LANG': 'en_US.UTF-8', 05:28:59 INFO - 'LANGUAGE': 'en_US:en', 05:28:59 INFO - 'LOGNAME': 'cltbld', 05:28:59 INFO - 'MAIL': '/var/mail/cltbld', 05:28:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:59 INFO - 'MOZ_NO_REMOTE': '1', 05:28:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:59 INFO - 'NO_EM_RESTART': '1', 05:28:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:59 INFO - 'PWD': '/builds/slave/test', 05:28:59 INFO - 'SHELL': '/bin/bash', 05:28:59 INFO - 'SHLVL': '1', 05:28:59 INFO - 'TERM': 'linux', 05:28:59 INFO - 'TMOUT': '86400', 05:28:59 INFO - 'USER': 'cltbld', 05:28:59 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1489580886.222668-1094734497', 05:28:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:59 INFO - '_': '/tools/buildbot/bin/python'} 05:28:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:59 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)) 05:28:59 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)) 05:28:59 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)) 05:28:59 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)) 05:28:59 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)) 05:28:59 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)) 05:28:59 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)) 05:28:59 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)) 05:28:59 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)) 05:28:59 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)) 05:28:59 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)) 05:28:59 INFO - Cleaning up... 05:28:59 INFO - Return code: 0 05:28:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:28:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1901b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18ff290>, '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 0x18ffb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1900040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1489580886.222668-1094734497', '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 05:28:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:28:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:28:59 INFO - Using env: {'DISPLAY': ':0', 05:28:59 INFO - 'HOME': '/home/cltbld', 05:28:59 INFO - 'LANG': 'en_US.UTF-8', 05:28:59 INFO - 'LANGUAGE': 'en_US:en', 05:28:59 INFO - 'LOGNAME': 'cltbld', 05:28:59 INFO - 'MAIL': '/var/mail/cltbld', 05:28:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:59 INFO - 'MOZ_NO_REMOTE': '1', 05:28:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:59 INFO - 'NO_EM_RESTART': '1', 05:28:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:59 INFO - 'PWD': '/builds/slave/test', 05:28:59 INFO - 'SHELL': '/bin/bash', 05:28:59 INFO - 'SHLVL': '1', 05:28:59 INFO - 'TERM': 'linux', 05:28:59 INFO - 'TMOUT': '86400', 05:28:59 INFO - 'USER': 'cltbld', 05:28:59 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1489580886.222668-1094734497', 05:28:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:59 INFO - '_': '/tools/buildbot/bin/python'} 05:29:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:29:00 INFO - Cleaning up... 05:29:00 INFO - Return code: 0 05:29:00 INFO - Running post-action listener: _resource_record_post_action 05:29:00 INFO - Running post-action listener: _start_resource_monitoring 05:29:00 INFO - Starting resource monitoring. 05:29:00 INFO - [mozharness: 2017-03-15 12:29:00.193863Z] Finished create-virtualenv step (success) 05:29:00 INFO - [mozharness: 2017-03-15 12:29:00.194349Z] Running install step. 05:29:00 INFO - Running pre-action listener: _resource_record_pre_action 05:29:00 INFO - Running main action method: install 05:29:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:29:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:29:00 INFO - Reading from file tmpfile_stdout 05:29:00 INFO - Detecting whether we're running mozinstall >=1.0... 05:29:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:29:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:29:00 INFO - Reading from file tmpfile_stdout 05:29:00 INFO - Output received: 05:29:00 INFO - Usage: mozinstall [options] installer 05:29:00 INFO - Options: 05:29:00 INFO - -h, --help show this help message and exit 05:29:00 INFO - -d DEST, --destination=DEST 05:29:00 INFO - Directory to install application into. [default: 05:29:00 INFO - "/builds/slave/test"] 05:29:00 INFO - --app=APP Application being installed. [default: firefox] 05:29:00 INFO - mkdir: /builds/slave/test/build/application 05:29:00 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'] 05:29:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:29:15 INFO - Reading from file tmpfile_stdout 05:29:15 INFO - Output received: 05:29:15 INFO - /builds/slave/test/build/application/firefox/firefox 05:29:15 INFO - Running post-action listener: _resource_record_post_action 05:29:15 INFO - [mozharness: 2017-03-15 12:29:15.913772Z] Finished install step (success) 05:29:15 INFO - [mozharness: 2017-03-15 12:29:15.914049Z] Running run-tests step. 05:29:15 INFO - Running pre-action listener: _resource_record_pre_action 05:29:15 INFO - Running main action method: run_tests 05:29:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:29:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:29:15 INFO - Python 2.7.3 05:29:15 INFO - Return code: 0 05:29:15 INFO - grabbing minidump binary from tooltool 05:29:15 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')]} 05:29:15 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 0x18ff290>, '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 0x18ffb90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1900040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:29:15 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 05:29:15 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 05:29:15 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 05:29:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:29:15 INFO - Return code: 0 05:29:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:29:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:29:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:29:15 INFO - ENV: RUST_BACKTRACE is now 1 05:29:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:29:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:29:15 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/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:29:15 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/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:29:15 INFO - Using env: {'DISPLAY': ':0', 05:29:15 INFO - 'HOME': '/home/cltbld', 05:29:15 INFO - 'LANG': 'en_US.UTF-8', 05:29:15 INFO - 'LANGUAGE': 'en_US:en', 05:29:15 INFO - 'LOGNAME': 'cltbld', 05:29:15 INFO - 'MAIL': '/var/mail/cltbld', 05:29:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:29:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:29:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:15 INFO - 'MOZ_NO_REMOTE': '1', 05:29:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:29:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:29:15 INFO - 'NO_EM_RESTART': '1', 05:29:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:29:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:16 INFO - 'PWD': '/builds/slave/test', 05:29:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:29:16 INFO - 'RUST_BACKTRACE': '1', 05:29:16 INFO - 'SHELL': '/bin/bash', 05:29:16 INFO - 'SHLVL': '1', 05:29:16 INFO - 'TERM': 'linux', 05:29:16 INFO - 'TMOUT': '86400', 05:29:16 INFO - 'USER': 'cltbld', 05:29:16 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1489580886.222668-1094734497', 05:29:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:16 INFO - '_': '/tools/buildbot/bin/python'} 05:29:16 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/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:29:16 INFO - mozversion application_buildid: 20170315120105 05:29:16 INFO - mozversion application_changeset: 0cc9dced786cf2a3baeff707b636b4ad02637df0 05:29:16 INFO - mozversion application_display_name: Nightly 05:29:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:29:16 INFO - mozversion application_name: Firefox 05:29:16 INFO - mozversion application_remotingname: firefox 05:29:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:29:16 INFO - mozversion application_vendor: Mozilla 05:29:16 INFO - mozversion application_version: 55.0a1 05:29:16 INFO - mozversion platform_buildid: 20170315120105 05:29:16 INFO - mozversion platform_changeset: 0cc9dced786cf2a3baeff707b636b4ad02637df0 05:29:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:29:16 INFO - mozversion platform_version: 55.0a1 05:29:16 INFO - using testdate: 1489580956 05:29:16 INFO - actual date: 1489580956 05:29:16 INFO - starting webserver on 'localhost:44358' 05:29:16 INFO - SUITE-START | Running 2 tests 05:29:16 INFO - TEST-START | dromaeo_css 05:29:16 INFO - operating with platform_type : linux_ 05:29:16 INFO - Initialising browser for dromaeo_css test... 05:29:16 INFO - TEST-INFO | started process 4071 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiuKF0r/profile http://localhost:44358/getInfo.html) 05:29:20 INFO - PID 4071 | __metrics Screen width/height:1600/1200 05:29:20 INFO - PID 4071 | colorDepth:24 05:29:20 INFO - PID 4071 | Browser inner width/height: 1024/697 05:29:20 INFO - PID 4071 | __metrics 05:29:21 ERROR - PID 4071 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 05:29:22 INFO - TEST-INFO | 4071: exit 0 05:29:22 INFO - Browser initialized. 05:29:22 INFO - Running cycle 1/1 for dromaeo_css test... 05:29:22 INFO - TEST-INFO | started process 4203 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiuKF0r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:29:34 INFO - PID 4203 | RSS: Main: 155680768 05:29:34 INFO - PID 4203 | 05:32:38 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:44358/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44358/tests/dromaeo/cssquery-ext.html) 05:32:40 INFO - PID 4203 | RSS: Main: 164868096 05:32:40 INFO - PID 4203 | 05:34:22 INFO - PID 4203 | ************************* 05:34:22 INFO - PID 4203 | A coding exception was thrown and uncaught in a Task. 05:34:22 INFO - PID 4203 | 05:34:22 ERROR - PID 4203 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:34:22 INFO - PID 4203 | Full stack: 05:34:22 INFO - PID 4203 | ************************* 05:35:43 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:44358/tests/dromaeo/cssquery-ext.html (next: http://localhost:44358/tests/dromaeo/cssquery-jquery.html) 05:35:43 INFO - PID 4203 | RSS: Main: 161607680 05:35:43 INFO - PID 4203 | 05:38:45 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:44358/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44358/tests/dromaeo/cssquery-mootools.html) 05:38:46 INFO - PID 4203 | RSS: Main: 168509440 05:38:46 INFO - PID 4203 | 05:41:48 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:44358/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44358/tests/dromaeo/cssquery-prototype.html) 05:41:49 INFO - PID 4203 | RSS: Main: 161644544 05:41:49 INFO - PID 4203 | 05:44:52 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:44358/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44358/tests/dromaeo/cssquery-yui.html) 05:44:52 INFO - PID 4203 | RSS: Main: 170184704 05:44:52 INFO - PID 4203 | 05:47:55 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:44358/tests/dromaeo/cssquery-yui.html (next: http://localhost:44358/tests/dromaeo/cssquery-dojo.html) 05:47:56 INFO - PID 4203 | RSS: Main: 161406976 05:47:56 INFO - PID 4203 | 05:47:56 INFO - PID 4203 | __start_tp_report 05:47:56 INFO - PID 4203 | _x_x_mozilla_page_load 05:47:56 INFO - PID 4203 | _x_x_mozilla_page_load_details 05:47:56 INFO - PID 4203 | |i|pagename|runs| 05:47:56 INFO - PID 4203 | |0;dojo.html;2672.85299308538;2692.5288074586942;2708.796840236983;2723.0741547873718;2731.399092199715;4883.413990321157;5009.273655319977;5061.721605311711;5086.872828179288;5118.436971933089;5019.32239147715;5030.37120359955;5044.949550504494;5057.595392368611;5104.668196567221;4616.515265897083;4670.883227919295;4674.439067311927;4687.250039993602;4698.765061746916;4702.365180700596;4712.340272361872;4734.076855013273;4736.313234580984;4773.618110551165;4608.7004344717825;4646.233371493699;4653.697509661861;4655.767211639404;4665.346851440801;4604.286335617984;4615.8153673853;4620.768961551909;4656.650751193674;4672.602828759559;4543.40935678363;4582.816687332503;4589.908201835945;4599.632029437637;4639.489656137822;4921.286413470062;4960.23116416956;4980.726060066695;5022.121128802445;5036.697798132123;5449.700266485342;5454.4545545445135;5456.61803673743;5474.124140137559;5511.255980442629;5472.91790623141;5479.2602998595075;5483.122700367922;5488.9725551371985;5490.203920431515;4953.554180123806;5005.549500544968;5012.298278240976;5091.3126727892;5128.102582048126;5463.262459567987;5479.397266300703;5488.204210389471;5500.752466138953;5507.834764957058;5205.03706814233;5306.257124002643;5321.281626980308;5326.174442961347;5327.706976116273;5374.220737992969;5407.107827208467;5415.1335786274;5424.294841670558;5424.620276580601;5356.892862142735;5373.650712703662;5376.973115134399;5397.325334333208;5434.076207044812;5256.973715131477;5257.421683614799;5288.603354748409;5310.787568497217;5323;4562.1560011398;4562.1788078146255;4564.748938808331;4585.770711464414;4606.424196975378;3932.8820135395986;3940.6650434712797;3957.3470377387985;3969.1069509360163;3990.68074554035;4542.5911667949385;4603.286490593963;4630.073985202973;4653.371794807726;4674.976625116853;5426.810061647823;5440.6735595864375;5454.699991500426;5473.726313684379;5487.6981766002455;4671.299305104194;4682.765861706901;4684.320773487825;4691.9530804692195;4728.267118596623;4703;4783.1868582341085;4793;4853.39332583427;4896.36347274852;5056.494350564914;5060.974695126501;5061.16490779032;5062.063518249136;5064.215046667772;5354.759035843318;5405;5405.378381486179;5408.37803652585;5414.648047876875;5036.874078147929;5046.9747651261505;5050.368703912011;5051.19180931064;5054.7978080876355;5354.3842458117815;5392;5395.055865223649;5401.3248343957;5402.864928376822;5462.535684466865;5468.01575716359;5469.453054694499;5469.480399362054;5475.616706830643;5234.816781412632;5242.423333433243;5281.075811733008;5284.656497327662;5292.576593872558;5266.289050978069;5279.868003299948;5289.41816400188;5298.15229563268;5304.310439642822;5062.316587260672;5149.48505149482;5211.374635043819;5213.6350455467755;5234.2933703949475;5179.093658609803;5316.229146773773;5368.087425137658;5374.596905232202;5387.86530336729;5145.819896303611;5146.948530514647;5160.922586161136;5165;5167.948320516747 05:47:56 INFO - PID 4203 | |1;ext.html;662.5891946992864;765.1545042727784;781.2851241114381;819.6229734322208;828.1759649149097;32431.189220269476;32975.175620609494;33080.66919330806;33096.33807323852;36216.2756744865;31498.527522087188;31805.204869878264;31821.36357272859;31879.362412751732;31884.521732174035;6163.322034576204;8642.43824151428;8697.304215662763;8750;8767.210951014407;8660.783480413009;8781.034086250507;8795.560221988906;8796.604152813139;8801;8950;8983.95508022459;9004.279657627374;9005.14451127142;9006.774830629221;8883.689070882489;8884.73345799627;8916.687915922945;8937.19565239125;8946.686865959726;8657.653693852239;8817.382783205177;8819.29445644347;8836.160564746338;8868.822623547492;28840.855795720887;29452.116436506938;29470.26324341887;29532;29546;2891.3928075104045;2919.737223649882;2921.1528656689534;2951.734343909037;2966.243607879977;23907.64138537906;24030.399240018964;24137.637935430983;24325.391865203335;24909.87545062281;3121.859516321771;3137.6705445928305;3193.7285330746913;3195.5206718992335;3207.294395233045;158862;158999;159449.20275398548;159860;159955.2002239993;32070.839645802087;32100.518492222636;40742.59257407388;40796.38805417921;40890.79554602208;42644.360334595;42918.35622465666;42924.57075429268;42978.57021429808;43001.56998429976;11565.884341156481;11566.074714023027;11626.418679066013;11668.94165529184;11683.707907302216;9043.638254469879;9052.954735226282;9075.092490750872;9145.222656074307;9177.724668259963;13109.082364234411;13186.868131318755;13245;13275.20348779057;13307.933460332637;5451.890962180813;5513.724313784295;5532.225488431623;5539.141433077799;5547.472990065938;847.7033038436498;886.6940905387631;990.9108180263811;1002.9097381235724;1044.4777611194402;21078.578428431345;21362.78637213639;21399.358019259445;21736.24652765651;21794.891025545086;1064.5528877871313;1072.7532667486366;1073.259450978822;1082.3181395720803;1102.388174563109;11120.499577519031;11773.646790596296;11811.822822657667;11981.221220620806;12180.57367992116;193086;197470;197564;197666;231814;46736.7663161682;47448.28827567589;47468;47468;47472.28791568129;1195.635331223985;1231.8398608180878;1237.7338872142532;1237.9814302785464;1371.0060206350315;24650.753492464846;24816;25310.620340695274;25874.094406695676;25939.22182334533;32364;32509;32566.511502327958;32604.836975814967;32654.836725816218;242873;243881;244832;245032;245063;21777.34667959964;22156.1137554496;24836.751632484167;25926.35184120412;28873.56689649699;32581.34837303288;32636.510452343708;32917.17707057343;33575.1606209837;33692.49461258034;28148;28411.857940710164;28438;28748.137555873356;29627.703722963357;28202.435951280448;28212.85893570519;28350.716492834807;28673.569896451154;28820.567691485063;27826;28424.57363139596;28639.284017898884;28705;28860;24003.15988940379;25317.240482785546;25588.104416345337;25739.871300643375;26156.73843261543;20337.59324813525;20367.69448458304;20757.688634670794;20766;20793.480162996046 05:47:56 INFO - PID 4203 | |2;jquery.html;408.7424922298951;409.61291579457406;411.38497945571373;413.0973822198496;438.5395334898356;13975.930120349383;17427.651446971053;17972.550686232833;18070.10263922289;18075.186616602252;15822.129782861937;16318.510444686648;16333.265003074861;16425.67148657026;16613.08628025461;5568.9443105569035;5724;5755.338136114337;5845.09401042839;5875.471207591316;5756.625819321752;5872.765089396419;5877.265341832271;5884.176215329857;5890.263717035371;3927;4114.033202197496;6701.329867013308;6978.0230767692565;6989.965050174767;6758.22280437751;7000.894986575206;7118.216996130395;7130.108736407949;7132.2867713228525;6954.3393377629045;6958.304169583002;6960.79117626472;6960.825979350506;6969.721211151548;21448.89275553628;21631.783682163135;22104.00531976065;22301.665475017886;22337.441563960867;2220.433789383697;2258.3337915315024;2290.6678531612824;2334.7781960713705;2340.368100612825;13477.932610336886;13873.167609943335;14125.223112728796;14197.148171109766;14647.560573182822;1876.8217019383137;1949.580840119381;1963.3520938090396;1980.6830907054946;1996.5008747813047;87772.56113719454;87854.5607271966;87858.12141878564;89008;89396;16099.436519721754;16525.83474165243;16535.586610334838;16537.91731041337;16750.581235468966;26043.348916277246;28578;28581.14256572306;28631.713682863323;28942.710572894;7800.102988156321;7856.214378562098;7864.095629002738;8016.23439913229;8086.474379165335;6212.254529456403;6213.596116252429;6378.107065010902;6380.266269378988;6395.624940637786;8475.666475349866;9251.398659087137;9268.25853931684;9291.396059256127;9421.717348479557;3670.302642497917;3688.7233457490797;3879.728419010642;3925.862594809225;4069.7151199415757;977.7604486900613;985.6550207427487;989.5942663508071;994.5027486256871;1002.5939494504737;19356.516087097654;19423.902880485508;19477.707834382494;19509.414717558495;19606.70589941152;984.522506584306;985.4875464758286;1009.3237530854345;1012.7265638277623;1017.9134773544332;10175.827910556784;10710.785784284271;10717.785644287227;10801.83797243042;10885.891141088488;420910;469974;477227;481874;481957;81459.59270203611;82149;84727;88551.55724221467;88727;947.9052094790466;1097.5006372100675;1154.0709728668335;1160.843286156375;1171.841801356823;16487.505374838773;17229.655406891543;18170.90914545419;18260.634787304447;18267.725984110515;42454.78772606117;43117.784411077744;43405.56594434015;43681;43966.56033439752;55343.44656553544;56523.43476565346;57172.71413642905;57768.71115644395;58807.70596146992;9693.757656058655;10066.094051535398;10388.844167337345;10479.580816767244;10627.787444251226;11108.777824443627;11252.156088293574;11289.887101128883;11487.13846461502;11812.17314787991;10525.210609204187;10573.418461984356;10586.523606437575;10592.597010178251;10646.095081918123;9837.557309921214;10134.037266459674;10220.233482488991;10228.28402011852;10524.842127368249;10623.840642390216;10663.680089597325;10692.251542391958;10715.089217416295;10836.295640783324;10424;10504.26470147113;10565.894341056492;10641.255112142077;10660.978680040736;10728.570857165938;10803.513841876977;10865.750438699652;11043.779124417306;11154.498047587716 05:47:56 INFO - PID 4203 | |3;mootools.html;1415.702702432489;1433.141649807154;1454.9490767823129;1477.9039362441445;1538.553819392376;7877.487963282397;8133.674653013887;8870.733877983663;9169.908300916988;9213.58538865751;8580.313574914007;8935.865962010559;8967.730968070951;8979.640814367434;9009.594568244429;2027.918883244672;2081.261152290938;2082.094288984297;2084.9687254691194;2095.8952052397394;2014.0533949044;2029.5332073623076;2060.7836177201402;2068.48287928018;2072.585482903418;1986.0764744393855;1993.3421970749691;2006.3980805758288;2006.5384961458874;2009;1926.3450426854797;1929.1800984581566;1930.4594713480249;1934.0909772406947;1936.2351871011012;1876.7841698204745;1891.3002189190088;1896.2699360746212;1993.7109119177783;1997.2510308634262;9092.136247056518;9135.497547634877;9152.450852948845;9222.44665320083;9234.538273086318;4339.327404252346;4519.909601807978;4524.68327217095;4529.230030894756;4535.387722657432;2502.174282486775;2621.5805471124527;2667.83992960423;2710.6205131281636;2730.0889377435874;980.2011360741045;1042.7810159866438;1056.2289528644133;1068.7702144038992;1075.800976819291;13145.145565538209;13158.407871645799;13199.538016169485;13268.86731132686;13281.203127812361;3850.4801851749653;4016.779077150726;4150.688698347636;4154.086101057763;4181.080162364275;10860.511276992554;10877.129829613612;10970;10989.945050274857;11000.504977276041;4596.770161491912;4615.492295847454;4623.052274283764;4668.626509879202;4679.578837904605;3442.1738782692473;3497.7157673786887;3911.471951286597;4212.283911735012;4242.5121111072;3340.799552026886;3374.6287908330064;3475.4960530722906;3484.3553942520716;3499.0027842064887;961.3606951377395;987.2891518106951;996.7209181429212;998.3111652959435;1006.5269323417982;694.711694646716;708.4721882197796;718.5042320798632;728.6793810723265;743.7062360367732;5361.731913404315;5468.304825504027;5570.860728481739;5573.136163894603;5635.633683810539;836.3058661311097;855.8202777416687;857.100044952797;859.2438653984578;871.2333146830748;3544.8404821783083;3655.4882316475714;3666.211764470652;3683.244934788362;3828.559715632738;10370.481475926324;10806.945965270123;10904;11039.83440248397;11159.665210043711;10988.945055274673;11023.44882755875;11058.723531911766;11176.161787865942;11179.273347232403;8263.876041859377;8460.534670593053;8490.617922193516;8491.448055876348;8508.829823403621;4925.827596034122;5016.974915125401;5091.567216786615;6159.5688301818445;6160.10678451631;9842.11420972116;10011.749706257402;10083.697489075339;10094.14199793026;10164.949175254076;10581.788364232518;10593.470326483799;10637.095846853104;10798;10832.783344333227;6990.26602206761;7146.178189508273;7146.749863754743;7181.605011724405;7271.309225623558;8069.314108300626;8102.068262149693;8118.2693557580105;8126.75619731409;8154.388420868578;6950.54821436605;7074.080369551925;7113.822154445973;7129.287071292829;7265.200827909031;7007.229204787367;7065.682044307916;7118.572885626879;7132.072830531998;7166.426685865223;6537.313582073813;6537.738490460519;6543.214814222324;6575.210974683068;6601.801945941629;4953.975230123826;5139.588832893434;5139.6145289102715;5141.25451809493;5146.150885103916;5003.899922001612;5015.673981191211;5131.538161565477;5139.383274006994;5196.246544251138 05:47:56 INFO - PID 4203 | |4;prototype.html;363.7999100494729;374.7564083345825;376.7739356386167;377.5299751808998;388.3359455331384;5225.529702326789;5384.703841288732;5407.107827208516;5410.242566040757;5420.1327787554;5194.844154675357;5257.36911570612;5262.236975638531;5264.947350526493;5300.178472336785;4416.867493975186;4419.955800441995;4428.468583769952;4463.776811159445;4464.620507256887;4208.6111583177635;4408.515063343029;4433.600975912167;4452.465704115511;4457.952381190417;4375.781210939456;4386.407834942273;4390.846320378788;4390.948290937799;4401.60385565299;4394.582514661102;4410.845620403286;4431.069475410168;4433.534478879704;4434.49003364614;3943.7830919299427;4073.9388909166387;4093.5906409359122;4093.9181216375805;4121.567235440266;5131.664418128209;5144.794208231704;5162.174052151638;5172.7155006475;5176.327077479941;5048.368953880765;5067.8986420271385;5075.492450754932;5085.872853178663;5089.643724939256;5510.194909287027;5522.006038912994;5580.330360356743;5598.412166722517;5609.551235901118;4463.843765468226;4474.731516109011;4482.439695038121;4495.213337665896;4512.729236245836;5606.327240731098;5696.458836410493;5782.392848750863;5851.941480585182;5891.351951285355;4605.263157894721;4606;4613.308003799457;4613.607843333354;4620.260758278727;4710.764461776897;4712.811487540528;4723.409573803275;4724.984128412408;4731.526847315241;4818.301346304836;5001.824936127218;5035.77339019745;5074.771635276347;5081.644284900021;5482.13607373495;5506.256655351476;5548.306461692288;5563.721813909288;5572.192032155314;1617.2075682915288;1626.3738460692482;1652.5951141970295;1652.7190377635832;1655.8840881138447;1230.083587727149;1233.2415564427813;1251.9499220031096;1257.390165769601;1264.930428826405;4847;4858.514148585114;4860.031687166703;4861.343718598015;4886.828960986349;5687.289088863892;5731.742071606787;5753.683547404849;5761.423857614289;5773.162891380726;4727.7399743013775;4833.3958255218095;4858.5384388483035;4858.611311095104;4869.902601947942;3045.2234680156416;3049.283418396675;3051.5575241589845;3054.4501989642076;3073.661897191307;5241.868953276198;5338.97330513345;5348.277982472394;5360.222767698662;5396.109641909041;5802.709864506758;5872.882542349214;5886.970565147232;5888.116782482662;5891;5376.731163441812;5378.97310513445;5381.892362152735;5385.596080293915;5403.243545903577;5559.221708960829;5714.20001199824;5727.4535875312595;5738.540916726568;5768.884622307614;5310.601704872227;5643.858903527444;5662.716864156858;5683.77264909399;5689.431056894277;5203.777112378512;5267.157254839208;5377.166539186433;5407.891842163213;5411.675299482044;4602.677812553089;4635.142498637762;4635.791389387418;4656.743879086683;4657.953420465752;5546.306711661043;5764;5766.942330576809;5770.6249093808765;5817.5345972321265;5590.86022849432;5592.3009623797025;5613.438656134354;5642.915356269741;5645.447501937;5621.128725047624;5634.943650563442;5651.491365777099;5656.971715141398;5666.716664166857;5309.150535914235;5544.140658197985;5556.777728890799;5579.9163012555655;5582.190582365453;5656.218291238247;5658.179563963285;5667.404922483245;5682.488576028178;5688.971555142198;5190.429052804113;5453.972730136324;5522.696251706034;5528.889422211614;5539.667619942817 05:47:56 INFO - PID 4203 | |5;yui.html;593.9732712027958;617.3394467919328;620.1349117980418;650.2327253840468;650.7201903181633;11589.65231043069;12169.209001414902;12366.196197247173;12370.938145309261;12416.81374779379;11714.121440891946;11952.402379880992;12002.75994480112;12219.633410997661;12716.109872308942;833.2251006563893;843.026304618167;864.1142828600672;865.3423398217337;865.3726048614735;859.8495263328892;873.1225118755642;873.7902903303193;874.0865795243985;875.0112373018512;895.4090300401704;900.8918929728409;900.9279257659372;901.0538934119148;901.4951627088818;896.6771962093641;899.4378513429107;899.5052721003422;900.3652425040331;901.7249738829654;655.0796131435293;655.1188651264042;656.4453037183572;657.7369052379039;660.7291010685644;13174.27541485218;13282.867171328357;13518.256495892721;13648.181109133484;13663.18020918748;13467.326633668376;13618.931905340509;14147.575572732834;14325.35535900887;14447.566573002827;9919.454430006346;10036.94981525095;10119.747006324827;10371.636992705218;10531.94734026325;3151.3854798314337;3151.862464183373;3208.197950512372;3211.5022171563446;3215.4212241796467;66838.99999999952;67024;67143.66428167876;67243.66378168078;68287;10312.329698569569;10336.5348559315;10351.567381665303;10444.21668374875;10983.066439352584;20402.795972040385;20432.387028389174;20482.89758551198;20536.281230156874;20581.794182057987;6332.556721029576;6417.614943103429;6535.346465353522;6559.967200163968;6723.966380168165;3279.0982479817762;3360.277540328841;3389.220479289728;3396.524486571882;3402.28552004077;2567.9358016049373;2665.6934452537816;2677.5849743289823;2684.3825920038503;2693.3670587411943;434.89127718070483;436.78573565487994;437.1737416283227;438.6008732053879;445;554.2849723856181;560.9411011843779;565.5532129617555;569.3253494608902;586.2320360327984;8313.41806073569;8672.56637168139;8733.257673097858;9019.233365163904;9148.451092934445;548.8243761996202;579.1746760865749;583.5681595619211;588.1648059755158;588.4380416702039;4135.255653982252;4221.91556168881;4475.440569928759;4491.371208030879;4784.139429199273;43518.34722479165;43966.70249731283;54993.72503137539;64040.35959640437;64250.35749642444;47395.5260447398;47897.76051119792;48070.278945815844;49017.754911225216;49600;44102.55897441113;44658.776706116914;45141.87145321327;45760.313595296764;46198.30702539464;8431.873521897054;9095.226905713089;9220.769480763034;9323;9327.489588969012;30389.240268993453;31310.530342045342;31449.842750787015;31856;31915.840420798675;37849.4322585156;38076.61923380731;38602.42096368501;39062.804685976385;39493.80253098716;11097.500612472297;11105.38920359388;11150.163737719866;11188;11222.38276894746;12065.879341206475;12910.40123687696;12981.221126732426;13408.597742067754;13686.589402317946;11492.655220343404;11513.194076414571;11608;11644.126690498417;11698;10425;10646.103912266479;10940.179486538382;11164.888351116384;11352.886471135183;11683.415829208336;11954.641360759191;11980.46087926028;12223.93888030554;12608.87391126077;10268.743281418025;10486.737831554272;10545.789084218426;10710.683355113077;10726.088282496075;10043.940992096748;10366;10390.584376625153;10455.424951627734;10769 05:47:56 INFO - PID 4203 | __end_tp_report 05:47:56 INFO - PID 4203 | __start_cc_report 05:47:56 INFO - PID 4203 | _x_x_mozilla_cycle_collect,385 05:47:56 INFO - PID 4203 | __end_cc_report 05:47:56 INFO - PID 4203 | __startTimestamp1489582076003__endTimestamp 05:47:56 INFO - PID 4203 | 05:47:56 INFO - PID 4203 | ------- Summary: start ------- 05:47:56 INFO - PID 4203 | Number of tests: 6 05:47:56 INFO - PID 4203 | 05:47:56 INFO - PID 4203 | [#0] dojo.html Cycles:165 Average:4987.61 Median:5091.31 stddev:543.64 (10.7%) stddev-sans-first:514.09 05:47:56 INFO - PID 4203 | Values: 2672.9 2692.5 2708.8 2723.1 2731.4 4883.4 5009.3 5061.7 5086.9 5118.4 5019.3 5030.4 5044.9 5057.6 5104.7 4616.5 4670.9 4674.4 4687.3 4698.8 4702.4 4712.3 4734.1 4736.3 4773.6 4608.7 4646.2 4653.7 4655.8 4665.3 4604.3 4615.8 4620.8 4656.7 4672.6 4543.4 4582.8 4589.9 4599.6 4639.5 4921.3 4960.2 4980.7 5022.1 5036.7 5449.7 5454.5 5456.6 5474.1 5511.3 5472.9 5479.3 5483.1 5489.0 5490.2 4953.6 5005.5 5012.3 5091.3 5128.1 5463.3 5479.4 5488.2 5500.8 5507.8 5205.0 5306.3 5321.3 5326.2 5327.7 5374.2 5407.1 5415.1 5424.3 5424.6 5356.9 5373.7 5377.0 5397.3 5434.1 5257.0 5257.4 5288.6 5310.8 5323.0 4562.2 4562.2 4564.7 4585.8 4606.4 3932.9 3940.7 3957.3 3969.1 3990.7 4542.6 4603.3 4630.1 4653.4 4675.0 5426.8 5440.7 5454.7 5473.7 5487.7 4671.3 4682.8 4684.3 4692.0 4728.3 4703.0 4783.2 4793.0 4853.4 4896.4 5056.5 5061.0 5061.2 5062.1 5064.2 5354.8 5405.0 5405.4 5408.4 5414.6 5036.9 5047.0 5050.4 5051.2 5054.8 5354.4 5392.0 5395.1 5401.3 5402.9 5462.5 5468.0 5469.5 5469.5 5475.6 5234.8 5242.4 5281.1 5284.7 5292.6 5266.3 5279.9 5289.4 5298.2 5304.3 5062.3 5149.5 5211.4 5213.6 5234.3 5179.1 5316.2 5368.1 5374.6 5387.9 5145.8 5146.9 5160.9 5165.0 5167.9 05:47:56 INFO - PID 4203 | 05:47:56 INFO - PID 4203 | [#1] ext.html Cycles:180 Average:34099.01 Median:29461.19 stddev:53459.94 (181.5%) stddev-sans-first:53550.96 05:47:56 INFO - PID 4203 | Values: 662.6 765.2 781.3 819.6 828.2 32431.2 32975.2 33080.7 33096.3 36216.3 31498.5 31805.2 31821.4 31879.4 31884.5 6163.3 8642.4 8697.3 8750.0 8767.2 8660.8 8781.0 8795.6 8796.6 8801.0 8950.0 8984.0 9004.3 9005.1 9006.8 8883.7 8884.7 8916.7 8937.2 8946.7 8657.7 8817.4 8819.3 8836.2 8868.8 28840.9 29452.1 29470.3 29532.0 29546.0 2891.4 2919.7 2921.2 2951.7 2966.2 23907.6 24030.4 24137.6 24325.4 24909.9 3121.9 3137.7 3193.7 3195.5 3207.3 158862.0 158999.0 159449.2 159860.0 159955.2 32070.8 32100.5 40742.6 40796.4 40890.8 42644.4 42918.4 42924.6 42978.6 43001.6 11565.9 11566.1 11626.4 11668.9 11683.7 9043.6 9053.0 9075.1 9145.2 9177.7 13109.1 13186.9 13245.0 13275.2 13307.9 5451.9 5513.7 5532.2 5539.1 5547.5 847.7 886.7 990.9 1002.9 1044.5 21078.6 21362.8 21399.4 21736.2 21794.9 1064.6 1072.8 1073.3 1082.3 1102.4 11120.5 11773.6 11811.8 11981.2 12180.6 193086.0 197470.0 197564.0 197666.0 231814.0 46736.8 47448.3 47468.0 47468.0 47472.3 1195.6 1231.8 1237.7 1238.0 1371.0 24650.8 24816.0 25310.6 25874.1 25939.2 32364.0 32509.0 32566.5 32604.8 32654.8 242873.0 243881.0 244832.0 245032.0 245063.0 21777.3 22156.1 24836.8 25926.4 28873.6 32581.3 32636.5 32917.2 33575.2 33692.5 28148.0 28411.9 28438.0 28748.1 29627.7 28202.4 28212.9 28350.7 28673.6 28820.6 27826.0 28424.6 28639.3 28705.0 28860.0 24003.2 25317.2 25588.1 25739.9 26156.7 20337.6 20367.7 20757.7 20766.0 20793.5 05:47:56 INFO - PID 4203 | 05:47:56 INFO - PID 4203 | [#2] jquery.html Cycles:180 Average:28976.71 Median:14191.86 stddev:77018.22 (542.7%) stddev-sans-first:77204.41 05:47:56 INFO - PID 4203 | Values: 408.7 409.6 411.4 413.1 438.5 13975.9 17427.7 17972.6 18070.1 18075.2 15822.1 16318.5 16333.3 16425.7 16613.1 5568.9 5724.0 5755.3 5845.1 5875.5 5756.6 5872.8 5877.3 5884.2 5890.3 3927.0 4114.0 6701.3 6978.0 6990.0 6758.2 7000.9 7118.2 7130.1 7132.3 6954.3 6958.3 6960.8 6960.8 6969.7 21448.9 21631.8 22104.0 22301.7 22337.4 2220.4 2258.3 2290.7 2334.8 2340.4 13477.9 13873.2 14125.2 14197.1 14647.6 1876.8 1949.6 1963.4 1980.7 1996.5 87772.6 87854.6 87858.1 89008.0 89396.0 16099.4 16525.8 16535.6 16537.9 16750.6 26043.3 28578.0 28581.1 28631.7 28942.7 7800.1 7856.2 7864.1 8016.2 8086.5 6212.3 6213.6 6378.1 6380.3 6395.6 8475.7 9251.4 9268.3 9291.4 9421.7 3670.3 3688.7 3879.7 3925.9 4069.7 977.8 985.7 989.6 994.5 1002.6 19356.5 19423.9 19477.7 19509.4 19606.7 984.5 985.5 1009.3 1012.7 1017.9 10175.8 10710.8 10717.8 10801.8 10885.9 420910.0 469974.0 477227.0 481874.0 481957.0 81459.6 82149.0 84727.0 88551.6 88727.0 947.9 1097.5 1154.1 1160.8 1171.8 16487.5 17229.7 18170.9 18260.6 18267.7 42454.8 43117.8 43405.6 43681.0 43966.6 55343.4 56523.4 57172.7 57768.7 58807.7 9693.8 10066.1 10388.8 10479.6 10627.8 11108.8 11252.2 11289.9 11487.1 11812.2 10525.2 10573.4 10586.5 10592.6 10646.1 9837.6 10134.0 10220.2 10228.3 10524.8 10623.8 10663.7 10692.3 10715.1 10836.3 10424.0 10504.3 10565.9 10641.3 10661.0 10728.6 10803.5 10865.8 11043.8 11154.5 05:47:56 INFO - PID 4203 | 05:47:56 INFO - PID 4203 | [#3] mootools.html Cycles:180 Average:5585.34 Median:4522.30 stddev:3511.22 (77.6%) stddev-sans-first:3507.09 05:47:56 INFO - PID 4203 | Values: 1415.7 1433.1 1454.9 1477.9 1538.6 7877.5 8133.7 8870.7 9169.9 9213.6 8580.3 8935.9 8967.7 8979.6 9009.6 2027.9 2081.3 2082.1 2085.0 2095.9 2014.1 2029.5 2060.8 2068.5 2072.6 1986.1 1993.3 2006.4 2006.5 2009.0 1926.3 1929.2 1930.5 1934.1 1936.2 1876.8 1891.3 1896.3 1993.7 1997.3 9092.1 9135.5 9152.5 9222.4 9234.5 4339.3 4519.9 4524.7 4529.2 4535.4 2502.2 2621.6 2667.8 2710.6 2730.1 980.2 1042.8 1056.2 1068.8 1075.8 13145.1 13158.4 13199.5 13268.9 13281.2 3850.5 4016.8 4150.7 4154.1 4181.1 10860.5 10877.1 10970.0 10989.9 11000.5 4596.8 4615.5 4623.1 4668.6 4679.6 3442.2 3497.7 3911.5 4212.3 4242.5 3340.8 3374.6 3475.5 3484.4 3499.0 961.4 987.3 996.7 998.3 1006.5 694.7 708.5 718.5 728.7 743.7 5361.7 5468.3 5570.9 5573.1 5635.6 836.3 855.8 857.1 859.2 871.2 3544.8 3655.5 3666.2 3683.2 3828.6 10370.5 10806.9 10904.0 11039.8 11159.7 10988.9 11023.4 11058.7 11176.2 11179.3 8263.9 8460.5 8490.6 8491.4 8508.8 4925.8 5017.0 5091.6 6159.6 6160.1 9842.1 10011.7 10083.7 10094.1 10164.9 10581.8 10593.5 10637.1 10798.0 10832.8 6990.3 7146.2 7146.7 7181.6 7271.3 8069.3 8102.1 8118.3 8126.8 8154.4 6950.5 7074.1 7113.8 7129.3 7265.2 7007.2 7065.7 7118.6 7132.1 7166.4 6537.3 6537.7 6543.2 6575.2 6601.8 4954.0 5139.6 5139.6 5141.3 5146.2 5003.9 5015.7 5131.5 5139.4 5196.2 05:47:56 INFO - PID 4203 | 05:47:56 INFO - PID 4203 | [#4] prototype.html Cycles:180 Average:4763.65 Median:5192.64 stddev:1270.40 (24.5%) stddev-sans-first:1230.29 05:47:56 INFO - PID 4203 | Values: 363.8 374.8 376.8 377.5 388.3 5225.5 5384.7 5407.1 5410.2 5420.1 5194.8 5257.4 5262.2 5264.9 5300.2 4416.9 4420.0 4428.5 4463.8 4464.6 4208.6 4408.5 4433.6 4452.5 4458.0 4375.8 4386.4 4390.8 4390.9 4401.6 4394.6 4410.8 4431.1 4433.5 4434.5 3943.8 4073.9 4093.6 4093.9 4121.6 5131.7 5144.8 5162.2 5172.7 5176.3 5048.4 5067.9 5075.5 5085.9 5089.6 5510.2 5522.0 5580.3 5598.4 5609.6 4463.8 4474.7 4482.4 4495.2 4512.7 5606.3 5696.5 5782.4 5851.9 5891.4 4605.3 4606.0 4613.3 4613.6 4620.3 4710.8 4712.8 4723.4 4725.0 4731.5 4818.3 5001.8 5035.8 5074.8 5081.6 5482.1 5506.3 5548.3 5563.7 5572.2 1617.2 1626.4 1652.6 1652.7 1655.9 1230.1 1233.2 1251.9 1257.4 1264.9 4847.0 4858.5 4860.0 4861.3 4886.8 5687.3 5731.7 5753.7 5761.4 5773.2 4727.7 4833.4 4858.5 4858.6 4869.9 3045.2 3049.3 3051.6 3054.5 3073.7 5241.9 5339.0 5348.3 5360.2 5396.1 5802.7 5872.9 5887.0 5888.1 5891.0 5376.7 5379.0 5381.9 5385.6 5403.2 5559.2 5714.2 5727.5 5738.5 5768.9 5310.6 5643.9 5662.7 5683.8 5689.4 5203.8 5267.2 5377.2 5407.9 5411.7 4602.7 4635.1 4635.8 4656.7 4658.0 5546.3 5764.0 5766.9 5770.6 5817.5 5590.9 5592.3 5613.4 5642.9 5645.4 5621.1 5634.9 5651.5 5657.0 5666.7 5309.2 5544.1 5556.8 5579.9 5582.2 5656.2 5658.2 5667.4 5682.5 5689.0 5190.4 5454.0 5522.7 5528.9 5539.7 05:47:56 INFO - PID 4203 | 05:47:56 INFO - PID 4203 | [#5] yui.html Cycles:180 Average:13946.13 Median:38339.52 stddev:16613.11 (43.3%) stddev-sans-first:16629.46 05:47:56 INFO - PID 4203 | Values: 594.0 617.3 620.1 650.2 650.7 11589.7 12169.2 12366.2 12370.9 12416.8 11714.1 11952.4 12002.8 12219.6 12716.1 833.2 843.0 864.1 865.3 865.4 859.8 873.1 873.8 874.1 875.0 895.4 900.9 900.9 901.1 901.5 896.7 899.4 899.5 900.4 901.7 655.1 655.1 656.4 657.7 660.7 13174.3 13282.9 13518.3 13648.2 13663.2 13467.3 13618.9 14147.6 14325.4 14447.6 9919.5 10036.9 10119.7 10371.6 10531.9 3151.4 3151.9 3208.2 3211.5 3215.4 66839.0 67024.0 67143.7 67243.7 68287.0 10312.3 10336.5 10351.6 10444.2 10983.1 20402.8 20432.4 20482.9 20536.3 20581.8 6332.6 6417.6 6535.3 6560.0 6724.0 3279.1 3360.3 3389.2 3396.5 3402.3 2567.9 2665.7 2677.6 2684.4 2693.4 434.9 436.8 437.2 438.6 445.0 554.3 560.9 565.6 569.3 586.2 8313.4 8672.6 8733.3 9019.2 9148.5 548.8 579.2 583.6 588.2 588.4 4135.3 4221.9 4475.4 4491.4 4784.1 43518.3 43966.7 54993.7 64040.4 64250.4 47395.5 47897.8 48070.3 49017.8 49600.0 44102.6 44658.8 45141.9 45760.3 46198.3 8431.9 9095.2 9220.8 9323.0 9327.5 30389.2 31310.5 31449.8 31856.0 31915.8 37849.4 38076.6 38602.4 39062.8 39493.8 11097.5 11105.4 11150.2 11188.0 11222.4 12065.9 12910.4 12981.2 13408.6 13686.6 11492.7 11513.2 11608.0 11644.1 11698.0 10425.0 10646.1 10940.2 11164.9 11352.9 11683.4 11954.6 11980.5 12223.9 12608.9 10268.7 10486.7 10545.8 10710.7 10726.1 10043.9 10366.0 10390.6 10455.4 10769.0 05:47:56 INFO - PID 4203 | -------- Summary: end -------- 05:47:56 INFO - PID 4203 | 05:47:56 INFO - TEST-INFO | 4203: exit 0 05:47:56 INFO - TEST-OK | dromaeo_css | took 1120664ms 05:47:56 INFO - TEST-START | kraken 05:47:56 INFO - operating with platform_type : linux_ 05:47:56 INFO - Initialising browser for kraken test... 05:47:56 INFO - TEST-INFO | started process 4583 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppk907T/profile http://localhost:44358/getInfo.html) 05:48:01 INFO - PID 4583 | __metrics Screen width/height:1600/1200 05:48:01 INFO - PID 4583 | colorDepth:24 05:48:01 INFO - PID 4583 | Browser inner width/height: 1024/697 05:48:01 INFO - PID 4583 | __metrics 05:48:02 ERROR - PID 4583 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 05:48:03 INFO - TEST-INFO | 4583: exit 0 05:48:03 INFO - Browser initialized. 05:48:03 INFO - Running cycle 1/1 for kraken test... 05:48:03 INFO - TEST-INFO | started process 4716 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppk907T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:48:15 INFO - PID 4716 | RSS: Main: 155688960 05:48:15 INFO - PID 4716 | 05:48:18 INFO - PID 4716 | Cycle 1(1): loaded http://localhost:44358/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44358/tests/kraken/driver.html?testName=audio-beat-detection) 05:48:19 INFO - PID 4716 | RSS: Main: 161583104 05:48:19 INFO - PID 4716 | 05:48:21 INFO - PID 4716 | Cycle 1(1): loaded http://localhost:44358/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44358/tests/kraken/driver.html?testName=audio-dft) 05:48:22 INFO - PID 4716 | RSS: Main: 160940032 05:48:22 INFO - PID 4716 | 05:48:25 INFO - PID 4716 | Cycle 1(1): loaded http://localhost:44358/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44358/tests/kraken/driver.html?testName=audio-fft) 05:48:26 INFO - PID 4716 | RSS: Main: 157126656 05:48:26 INFO - PID 4716 | 05:48:28 INFO - PID 4716 | Cycle 1(1): loaded http://localhost:44358/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44358/tests/kraken/driver.html?testName=audio-oscillator) 05:48:28 INFO - PID 4716 | RSS: Main: 157741056 05:48:28 INFO - PID 4716 | 05:48:31 INFO - PID 4716 | Cycle 1(1): loaded http://localhost:44358/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44358/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:48:31 INFO - PID 4716 | RSS: Main: 158130176 05:48:31 INFO - PID 4716 | 05:48:34 INFO - PID 4716 | Cycle 1(1): loaded http://localhost:44358/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44358/tests/kraken/driver.html?testName=imaging-darkroom) 05:48:35 INFO - PID 4716 | RSS: Main: 163409920 05:48:35 INFO - PID 4716 | 05:48:39 INFO - PID 4716 | Cycle 1(1): loaded http://localhost:44358/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44358/tests/kraken/driver.html?testName=imaging-desaturate) 05:48:39 INFO - PID 4716 | RSS: Main: 160690176 05:48:39 INFO - PID 4716 | 05:48:42 INFO - PID 4716 | Cycle 1(1): loaded http://localhost:44358/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44358/tests/kraken/driver.html?testName=json-parse-financial) 05:48:43 INFO - PID 4716 | RSS: Main: 162201600 05:48:43 INFO - PID 4716 | 05:48:45 INFO - PID 4716 | Cycle 1(1): loaded http://localhost:44358/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44358/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:48:45 INFO - PID 4716 | RSS: Main: 162811904 05:48:45 INFO - PID 4716 | 05:48:47 INFO - PID 4716 | Cycle 1(1): loaded http://localhost:44358/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44358/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:48:48 INFO - PID 4716 | RSS: Main: 163147776 05:48:48 INFO - PID 4716 | 05:48:50 INFO - PID 4716 | Cycle 1(1): loaded http://localhost:44358/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44358/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:48:51 INFO - PID 4716 | RSS: Main: 163155968 05:48:51 INFO - PID 4716 | 05:48:53 INFO - PID 4716 | Cycle 1(1): loaded http://localhost:44358/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44358/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:48:54 INFO - PID 4716 | RSS: Main: 163635200 05:48:54 INFO - PID 4716 | 05:48:57 INFO - PID 4716 | Cycle 1(1): loaded http://localhost:44358/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44358/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:48:58 INFO - PID 4716 | RSS: Main: 166445056 05:48:58 INFO - PID 4716 | 05:49:00 INFO - PID 4716 | Cycle 1(1): loaded http://localhost:44358/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44358/tests/kraken/driver.html?testName=ai-astar) 05:49:00 INFO - PID 4716 | RSS: Main: 166969344 05:49:00 INFO - PID 4716 | 05:49:00 INFO - PID 4716 | __start_tp_report 05:49:00 INFO - PID 4716 | _x_x_mozilla_page_load 05:49:00 INFO - PID 4716 | _x_x_mozilla_page_load_details 05:49:00 INFO - PID 4716 | |i|pagename|runs| 05:49:00 INFO - PID 4716 | |0;ai-astar;115;121;122;123;124;122;123;121;121;123 05:49:00 INFO - PID 4716 | |1;audio-beat-detection;150;127;127;181;127;132;133;127;160;128 05:49:00 INFO - PID 4716 | |2;audio-dft;166;165;168;167;180;163;164;163;166;164 05:49:00 INFO - PID 4716 | |3;audio-fft;78;75;77;113;75;76;75;76;92;77 05:49:00 INFO - PID 4716 | |4;audio-oscillator;84;84;110;85;86;86;108;86;87;113 05:49:00 INFO - PID 4716 | |5;imaging-gaussian-blur;114;114;114;114;114;115;113;114;115;114 05:49:00 INFO - PID 4716 | |6;imaging-darkroom;151;151;150;151;150;151;152;152;151;151 05:49:00 INFO - PID 4716 | |7;imaging-desaturate;95;96;94;95;94;95;97;95;96;97 05:49:00 INFO - PID 4716 | |8;json-parse-financial;71;70;70;72;72;71;72;74;72;72 05:49:00 INFO - PID 4716 | |9;json-stringify-tinderbox;56;57;55;55;56;56;56;56;56;56 05:49:00 INFO - PID 4716 | |10;stanford-crypto-aes;92;82;85;86;82;82;82;89;81;82 05:49:00 INFO - PID 4716 | |11;stanford-crypto-ccm;143;131;141;137;138;139;134;137;221;141 05:49:00 INFO - PID 4716 | |12;stanford-crypto-pbkdf2;190;197;194;185;198;196;194;195;195;199 05:49:00 INFO - PID 4716 | |13;stanford-crypto-sha256-iterative;77;77;70;70;71;73;71;70;71;71 05:49:00 INFO - PID 4716 | __end_tp_report 05:49:00 INFO - PID 4716 | __start_cc_report 05:49:00 INFO - PID 4716 | _x_x_mozilla_cycle_collect,889 05:49:00 INFO - PID 4716 | __end_cc_report 05:49:00 INFO - PID 4716 | __startTimestamp1489582140582__endTimestamp 05:49:00 INFO - PID 4716 | 05:49:00 INFO - PID 4716 | ------- Summary: start ------- 05:49:00 INFO - PID 4716 | Number of tests: 14 05:49:00 INFO - PID 4716 | 05:49:00 INFO - PID 4716 | [#0] ai-astar Cycles:10 Average:121.50 Median:122.50 stddev:2.51 (2.0%) stddev-sans-first:1.09 05:49:00 INFO - PID 4716 | Values: 115.0 121.0 122.0 123.0 124.0 122.0 123.0 121.0 121.0 123.0 05:49:00 INFO - PID 4716 | 05:49:00 INFO - PID 4716 | [#1] audio-beat-detection Cycles:10 Average:139.20 Median:132.50 stddev:18.58 (14.0%) stddev-sans-first:19.29 05:49:00 INFO - PID 4716 | Values: 150.0 127.0 127.0 181.0 127.0 132.0 133.0 127.0 160.0 128.0 05:49:00 INFO - PID 4716 | 05:49:00 INFO - PID 4716 | [#2] audio-dft Cycles:10 Average:166.60 Median:166.00 stddev:4.99 (3.0%) stddev-sans-first:5.29 05:49:00 INFO - PID 4716 | Values: 166.0 165.0 168.0 167.0 180.0 163.0 164.0 163.0 166.0 164.0 05:49:00 INFO - PID 4716 | 05:49:00 INFO - PID 4716 | [#3] audio-fft Cycles:10 Average:81.40 Median:76.50 stddev:12.21 (16.0%) stddev-sans-first:12.89 05:49:00 INFO - PID 4716 | Values: 78.0 75.0 77.0 113.0 75.0 76.0 75.0 76.0 92.0 77.0 05:49:00 INFO - PID 4716 | 05:49:00 INFO - PID 4716 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:85.50 stddev:12.12 (14.2%) stddev-sans-first:12.42 05:49:00 INFO - PID 4716 | Values: 84.0 84.0 110.0 85.0 86.0 86.0 108.0 86.0 87.0 113.0 05:49:00 INFO - PID 4716 | 05:49:00 INFO - PID 4716 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 05:49:00 INFO - PID 4716 | Values: 114.0 114.0 114.0 114.0 114.0 115.0 113.0 114.0 115.0 114.0 05:49:00 INFO - PID 4716 | 05:49:00 INFO - PID 4716 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:151.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 05:49:00 INFO - PID 4716 | Values: 151.0 151.0 150.0 151.0 150.0 151.0 152.0 152.0 151.0 151.0 05:49:00 INFO - PID 4716 | 05:49:00 INFO - PID 4716 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:1.07 (1.1%) stddev-sans-first:1.13 05:49:00 INFO - PID 4716 | Values: 95.0 96.0 94.0 95.0 94.0 95.0 97.0 95.0 96.0 97.0 05:49:00 INFO - PID 4716 | 05:49:00 INFO - PID 4716 | [#8] json-parse-financial Cycles:10 Average:71.60 Median:72.00 stddev:1.17 (1.6%) stddev-sans-first:1.22 05:49:00 INFO - PID 4716 | Values: 71.0 70.0 70.0 72.0 72.0 71.0 72.0 74.0 72.0 72.0 05:49:00 INFO - PID 4716 | 05:49:00 INFO - PID 4716 | [#9] json-stringify-tinderbox Cycles:10 Average:55.90 Median:56.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 05:49:00 INFO - PID 4716 | Values: 56.0 57.0 55.0 55.0 56.0 56.0 56.0 56.0 56.0 56.0 05:49:00 INFO - PID 4716 | 05:49:00 INFO - PID 4716 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:83.50 stddev:3.68 (4.4%) stddev-sans-first:2.65 05:49:00 INFO - PID 4716 | Values: 92.0 82.0 85.0 86.0 82.0 82.0 82.0 89.0 81.0 82.0 05:49:00 INFO - PID 4716 | 05:49:00 INFO - PID 4716 | [#11] stanford-crypto-ccm Cycles:10 Average:146.20 Median:140.00 stddev:26.52 (18.9%) stddev-sans-first:28.10 05:49:00 INFO - PID 4716 | Values: 143.0 131.0 141.0 137.0 138.0 139.0 134.0 137.0 221.0 141.0 05:49:00 INFO - PID 4716 | 05:49:00 INFO - PID 4716 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.30 Median:195.50 stddev:4.11 (2.1%) stddev-sans-first:4.06 05:49:00 INFO - PID 4716 | Values: 190.0 197.0 194.0 185.0 198.0 196.0 194.0 195.0 195.0 199.0 05:49:00 INFO - PID 4716 | 05:49:00 INFO - PID 4716 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:71.00 stddev:2.73 (3.8%) stddev-sans-first:2.24 05:49:00 INFO - PID 4716 | Values: 77.0 77.0 70.0 70.0 71.0 73.0 71.0 70.0 71.0 71.0 05:49:00 INFO - PID 4716 | -------- Summary: end -------- 05:49:00 INFO - PID 4716 | 05:49:01 INFO - TEST-INFO | 4716: exit 0 05:49:01 INFO - TEST-OK | kraken | took 64926ms 05:49:01 INFO - SUITE-END | took 1185s 05:49:02 INFO - Completed test suite (00:19:46) 05:49:02 INFO - javascript benchmark 05:49:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6651.552771218288, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2672.85299308538, 2692.5288074586942, 2708.796840236983, 2723.0741547873718, 2731.399092199715, 4883.413990321157, 5009.273655319977, 5061.721605311711, 5086.872828179288, 5118.436971933089, 5019.32239147715, 5030.37120359955, 5044.949550504494, 5057.595392368611, 5104.668196567221, 4616.515265897083, 4670.883227919295, 4674.439067311927, 4687.250039993602, 4698.765061746916, 4702.365180700596, 4712.340272361872, 4734.076855013273, 4736.313234580984, 4773.618110551165, 4608.7004344717825, 4646.233371493699, 4653.697509661861, 4655.767211639404, 4665.346851440801, 4604.286335617984, 4615.8153673853, 4620.768961551909, 4656.650751193674, 4672.602828759559, 4543.40935678363, 4582.816687332503, 4589.908201835945, 4599.632029437637, 4639.489656137822, 4921.286413470062, 4960.23116416956, 4980.726060066695, 5022.121128802445, 5036.697798132123, 5449.700266485342, 5454.4545545445135, 5456.61803673743, 5474.124140137559, 5511.255980442629, 5472.91790623141, 5479.2602998595075, 5483.122700367922, 5488.9725551371985, 5490.203920431515, 4953.554180123806, 5005.549500544968, 5012.298278240976, 5091.3126727892, 5128.102582048126, 5463.262459567987, 5479.397266300703, 5488.204210389471, 5500.752466138953, 5507.834764957058, 5205.03706814233, 5306.257124002643, 5321.281626980308, 5326.174442961347, 5327.706976116273, 5374.220737992969, 5407.107827208467, 5415.1335786274, 5424.294841670558, 5424.620276580601, 5356.892862142735, 5373.650712703662, 5376.973115134399, 5397.325334333208, 5434.076207044812, 5256.973715131477, 5257.421683614799, 5288.603354748409, 5310.787568497217, 5323.0, 4562.1560011398, 4562.1788078146255, 4564.748938808331, 4585.770711464414, 4606.424196975378, 3932.8820135395986, 3940.6650434712797, 3957.3470377387985, 3969.1069509360163, 3990.68074554035, 4542.5911667949385, 4603.286490593963, 4630.073985202973, 4653.371794807726, 4674.976625116853, 5426.810061647823, 5440.6735595864375, 5454.699991500426, 5473.726313684379, 5487.6981766002455, 4671.299305104194, 4682.765861706901, 4684.320773487825, 4691.9530804692195, 4728.267118596623, 4703.0, 4783.1868582341085, 4793.0, 4853.39332583427, 4896.36347274852, 5056.494350564914, 5060.974695126501, 5061.16490779032, 5062.063518249136, 5064.215046667772, 5354.759035843318, 5405.0, 5405.378381486179, 5408.37803652585, 5414.648047876875, 5036.874078147929, 5046.9747651261505, 5050.368703912011, 5051.19180931064, 5054.7978080876355, 5354.3842458117815, 5392.0, 5395.055865223649, 5401.3248343957, 5402.864928376822, 5462.535684466865, 5468.01575716359, 5469.453054694499, 5469.480399362054, 5475.616706830643, 5234.816781412632, 5242.423333433243, 5281.075811733008, 5284.656497327662, 5292.576593872558, 5266.289050978069, 5279.868003299948, 5289.41816400188, 5298.15229563268, 5304.310439642822, 5062.316587260672, 5149.48505149482, 5211.374635043819, 5213.6350455467755, 5234.2933703949475, 5179.093658609803, 5316.229146773773, 5368.087425137658, 5374.596905232202, 5387.86530336729, 5145.819896303611, 5146.948530514647, 5160.922586161136, 5165.0, 5167.948320516747], "value": 4950.671107450308, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [662.5891946992864, 765.1545042727784, 781.2851241114381, 819.6229734322208, 828.1759649149097, 32431.189220269476, 32975.175620609494, 33080.66919330806, 33096.33807323852, 36216.2756744865, 31498.527522087188, 31805.204869878264, 31821.36357272859, 31879.362412751732, 31884.521732174035, 6163.322034576204, 8642.43824151428, 8697.304215662763, 8750.0, 8767.210951014407, 8660.783480413009, 8781.034086250507, 8795.560221988906, 8796.604152813139, 8801.0, 8950.0, 8983.95508022459, 9004.279657627374, 9005.14451127142, 9006.774830629221, 8883.689070882489, 8884.73345799627, 8916.687915922945, 8937.19565239125, 8946.686865959726, 8657.653693852239, 8817.382783205177, 8819.29445644347, 8836.160564746338, 8868.822623547492, 28840.855795720887, 29452.116436506938, 29470.26324341887, 29532.0, 29546.0, 2891.3928075104045, 2919.737223649882, 2921.1528656689534, 2951.734343909037, 2966.243607879977, 23907.64138537906, 24030.399240018964, 24137.637935430983, 24325.391865203335, 24909.87545062281, 3121.859516321771, 3137.6705445928305, 3193.7285330746913, 3195.5206718992335, 3207.294395233045, 158862.0, 158999.0, 159449.20275398548, 159860.0, 159955.2002239993, 32070.839645802087, 32100.518492222636, 40742.59257407388, 40796.38805417921, 40890.79554602208, 42644.360334595, 42918.35622465666, 42924.57075429268, 42978.57021429808, 43001.56998429976, 11565.884341156481, 11566.074714023027, 11626.418679066013, 11668.94165529184, 11683.707907302216, 9043.638254469879, 9052.954735226282, 9075.092490750872, 9145.222656074307, 9177.724668259963, 13109.082364234411, 13186.868131318755, 13245.0, 13275.20348779057, 13307.933460332637, 5451.890962180813, 5513.724313784295, 5532.225488431623, 5539.141433077799, 5547.472990065938, 847.7033038436498, 886.6940905387631, 990.9108180263811, 1002.9097381235724, 1044.4777611194402, 21078.578428431345, 21362.78637213639, 21399.358019259445, 21736.24652765651, 21794.891025545086, 1064.5528877871313, 1072.7532667486366, 1073.259450978822, 1082.3181395720803, 1102.388174563109, 11120.499577519031, 11773.646790596296, 11811.822822657667, 11981.221220620806, 12180.57367992116, 193086.0, 197470.0, 197564.0, 197666.0, 231814.0, 46736.7663161682, 47448.28827567589, 47468.0, 47468.0, 47472.28791568129, 1195.635331223985, 1231.8398608180878, 1237.7338872142532, 1237.9814302785464, 1371.0060206350315, 24650.753492464846, 24816.0, 25310.620340695274, 25874.094406695676, 25939.22182334533, 32364.0, 32509.0, 32566.511502327958, 32604.836975814967, 32654.836725816218, 242873.0, 243881.0, 244832.0, 245032.0, 245063.0, 21777.34667959964, 22156.1137554496, 24836.751632484167, 25926.35184120412, 28873.56689649699, 32581.34837303288, 32636.510452343708, 32917.17707057343, 33575.1606209837, 33692.49461258034, 28148.0, 28411.857940710164, 28438.0, 28748.137555873356, 29627.703722963357, 28202.435951280448, 28212.85893570519, 28350.716492834807, 28673.569896451154, 28820.567691485063, 27826.0, 28424.57363139596, 28639.284017898884, 28705.0, 28860.0, 24003.15988940379, 25317.240482785546, 25588.104416345337, 25739.871300643375, 26156.73843261543, 20337.59324813525, 20367.69448458304, 20757.688634670794, 20766.0, 20793.480162996046], "value": 15189.929176764288, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.7424922298951, 409.61291579457406, 411.38497945571373, 413.0973822198496, 438.5395334898356, 13975.930120349383, 17427.651446971053, 17972.550686232833, 18070.10263922289, 18075.186616602252, 15822.129782861937, 16318.510444686648, 16333.265003074861, 16425.67148657026, 16613.08628025461, 5568.9443105569035, 5724.0, 5755.338136114337, 5845.09401042839, 5875.471207591316, 5756.625819321752, 5872.765089396419, 5877.265341832271, 5884.176215329857, 5890.263717035371, 3927.0, 4114.033202197496, 6701.329867013308, 6978.0230767692565, 6989.965050174767, 6758.22280437751, 7000.894986575206, 7118.216996130395, 7130.108736407949, 7132.2867713228525, 6954.3393377629045, 6958.304169583002, 6960.79117626472, 6960.825979350506, 6969.721211151548, 21448.89275553628, 21631.783682163135, 22104.00531976065, 22301.665475017886, 22337.441563960867, 2220.433789383697, 2258.3337915315024, 2290.6678531612824, 2334.7781960713705, 2340.368100612825, 13477.932610336886, 13873.167609943335, 14125.223112728796, 14197.148171109766, 14647.560573182822, 1876.8217019383137, 1949.580840119381, 1963.3520938090396, 1980.6830907054946, 1996.5008747813047, 87772.56113719454, 87854.5607271966, 87858.12141878564, 89008.0, 89396.0, 16099.436519721754, 16525.83474165243, 16535.586610334838, 16537.91731041337, 16750.581235468966, 26043.348916277246, 28578.0, 28581.14256572306, 28631.713682863323, 28942.710572894, 7800.102988156321, 7856.214378562098, 7864.095629002738, 8016.23439913229, 8086.474379165335, 6212.254529456403, 6213.596116252429, 6378.107065010902, 6380.266269378988, 6395.624940637786, 8475.666475349866, 9251.398659087137, 9268.25853931684, 9291.396059256127, 9421.717348479557, 3670.302642497917, 3688.7233457490797, 3879.728419010642, 3925.862594809225, 4069.7151199415757, 977.7604486900613, 985.6550207427487, 989.5942663508071, 994.5027486256871, 1002.5939494504737, 19356.516087097654, 19423.902880485508, 19477.707834382494, 19509.414717558495, 19606.70589941152, 984.522506584306, 985.4875464758286, 1009.3237530854345, 1012.7265638277623, 1017.9134773544332, 10175.827910556784, 10710.785784284271, 10717.785644287227, 10801.83797243042, 10885.891141088488, 420910.0, 469974.0, 477227.0, 481874.0, 481957.0, 81459.59270203611, 82149.0, 84727.0, 88551.55724221467, 88727.0, 947.9052094790466, 1097.5006372100675, 1154.0709728668335, 1160.843286156375, 1171.841801356823, 16487.505374838773, 17229.655406891543, 18170.90914545419, 18260.634787304447, 18267.725984110515, 42454.78772606117, 43117.784411077744, 43405.56594434015, 43681.0, 43966.56033439752, 55343.44656553544, 56523.43476565346, 57172.71413642905, 57768.71115644395, 58807.70596146992, 9693.757656058655, 10066.094051535398, 10388.844167337345, 10479.580816767244, 10627.787444251226, 11108.777824443627, 11252.156088293574, 11289.887101128883, 11487.13846461502, 11812.17314787991, 10525.210609204187, 10573.418461984356, 10586.523606437575, 10592.597010178251, 10646.095081918123, 9837.557309921214, 10134.037266459674, 10220.233482488991, 10228.28402011852, 10524.842127368249, 10623.840642390216, 10663.680089597325, 10692.251542391958, 10715.089217416295, 10836.295640783324, 10424.0, 10504.26470147113, 10565.894341056492, 10641.255112142077, 10660.978680040736, 10728.570857165938, 10803.513841876977, 10865.750438699652, 11043.779124417306, 11154.498047587716], "value": 9892.617923652355, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1415.702702432489, 1433.141649807154, 1454.9490767823129, 1477.9039362441445, 1538.553819392376, 7877.487963282397, 8133.674653013887, 8870.733877983663, 9169.908300916988, 9213.58538865751, 8580.313574914007, 8935.865962010559, 8967.730968070951, 8979.640814367434, 9009.594568244429, 2027.918883244672, 2081.261152290938, 2082.094288984297, 2084.9687254691194, 2095.8952052397394, 2014.0533949044, 2029.5332073623076, 2060.7836177201402, 2068.48287928018, 2072.585482903418, 1986.0764744393855, 1993.3421970749691, 2006.3980805758288, 2006.5384961458874, 2009.0, 1926.3450426854797, 1929.1800984581566, 1930.4594713480249, 1934.0909772406947, 1936.2351871011012, 1876.7841698204745, 1891.3002189190088, 1896.2699360746212, 1993.7109119177783, 1997.2510308634262, 9092.136247056518, 9135.497547634877, 9152.450852948845, 9222.44665320083, 9234.538273086318, 4339.327404252346, 4519.909601807978, 4524.68327217095, 4529.230030894756, 4535.387722657432, 2502.174282486775, 2621.5805471124527, 2667.83992960423, 2710.6205131281636, 2730.0889377435874, 980.2011360741045, 1042.7810159866438, 1056.2289528644133, 1068.7702144038992, 1075.800976819291, 13145.145565538209, 13158.407871645799, 13199.538016169485, 13268.86731132686, 13281.203127812361, 3850.4801851749653, 4016.779077150726, 4150.688698347636, 4154.086101057763, 4181.080162364275, 10860.511276992554, 10877.129829613612, 10970.0, 10989.945050274857, 11000.504977276041, 4596.770161491912, 4615.492295847454, 4623.052274283764, 4668.626509879202, 4679.578837904605, 3442.1738782692473, 3497.7157673786887, 3911.471951286597, 4212.283911735012, 4242.5121111072, 3340.799552026886, 3374.6287908330064, 3475.4960530722906, 3484.3553942520716, 3499.0027842064887, 961.3606951377395, 987.2891518106951, 996.7209181429212, 998.3111652959435, 1006.5269323417982, 694.711694646716, 708.4721882197796, 718.5042320798632, 728.6793810723265, 743.7062360367732, 5361.731913404315, 5468.304825504027, 5570.860728481739, 5573.136163894603, 5635.633683810539, 836.3058661311097, 855.8202777416687, 857.100044952797, 859.2438653984578, 871.2333146830748, 3544.8404821783083, 3655.4882316475714, 3666.211764470652, 3683.244934788362, 3828.559715632738, 10370.481475926324, 10806.945965270123, 10904.0, 11039.83440248397, 11159.665210043711, 10988.945055274673, 11023.44882755875, 11058.723531911766, 11176.161787865942, 11179.273347232403, 8263.876041859377, 8460.534670593053, 8490.617922193516, 8491.448055876348, 8508.829823403621, 4925.827596034122, 5016.974915125401, 5091.567216786615, 6159.5688301818445, 6160.10678451631, 9842.11420972116, 10011.749706257402, 10083.697489075339, 10094.14199793026, 10164.949175254076, 10581.788364232518, 10593.470326483799, 10637.095846853104, 10798.0, 10832.783344333227, 6990.26602206761, 7146.178189508273, 7146.749863754743, 7181.605011724405, 7271.309225623558, 8069.314108300626, 8102.068262149693, 8118.2693557580105, 8126.75619731409, 8154.388420868578, 6950.54821436605, 7074.080369551925, 7113.822154445973, 7129.287071292829, 7265.200827909031, 7007.229204787367, 7065.682044307916, 7118.572885626879, 7132.072830531998, 7166.426685865223, 6537.313582073813, 6537.738490460519, 6543.214814222324, 6575.210974683068, 6601.801945941629, 4953.975230123826, 5139.588832893434, 5139.6145289102715, 5141.25451809493, 5146.150885103916, 5003.899922001612, 5015.673981191211, 5131.538161565477, 5139.383274006994, 5196.246544251138], "value": 4280.889571343726, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.7999100494729, 374.7564083345825, 376.7739356386167, 377.5299751808998, 388.3359455331384, 5225.529702326789, 5384.703841288732, 5407.107827208516, 5410.242566040757, 5420.1327787554, 5194.844154675357, 5257.36911570612, 5262.236975638531, 5264.947350526493, 5300.178472336785, 4416.867493975186, 4419.955800441995, 4428.468583769952, 4463.776811159445, 4464.620507256887, 4208.6111583177635, 4408.515063343029, 4433.600975912167, 4452.465704115511, 4457.952381190417, 4375.781210939456, 4386.407834942273, 4390.846320378788, 4390.948290937799, 4401.60385565299, 4394.582514661102, 4410.845620403286, 4431.069475410168, 4433.534478879704, 4434.49003364614, 3943.7830919299427, 4073.9388909166387, 4093.5906409359122, 4093.9181216375805, 4121.567235440266, 5131.664418128209, 5144.794208231704, 5162.174052151638, 5172.7155006475, 5176.327077479941, 5048.368953880765, 5067.8986420271385, 5075.492450754932, 5085.872853178663, 5089.643724939256, 5510.194909287027, 5522.006038912994, 5580.330360356743, 5598.412166722517, 5609.551235901118, 4463.843765468226, 4474.731516109011, 4482.439695038121, 4495.213337665896, 4512.729236245836, 5606.327240731098, 5696.458836410493, 5782.392848750863, 5851.941480585182, 5891.351951285355, 4605.263157894721, 4606.0, 4613.308003799457, 4613.607843333354, 4620.260758278727, 4710.764461776897, 4712.811487540528, 4723.409573803275, 4724.984128412408, 4731.526847315241, 4818.301346304836, 5001.824936127218, 5035.77339019745, 5074.771635276347, 5081.644284900021, 5482.13607373495, 5506.256655351476, 5548.306461692288, 5563.721813909288, 5572.192032155314, 1617.2075682915288, 1626.3738460692482, 1652.5951141970295, 1652.7190377635832, 1655.8840881138447, 1230.083587727149, 1233.2415564427813, 1251.9499220031096, 1257.390165769601, 1264.930428826405, 4847.0, 4858.514148585114, 4860.031687166703, 4861.343718598015, 4886.828960986349, 5687.289088863892, 5731.742071606787, 5753.683547404849, 5761.423857614289, 5773.162891380726, 4727.7399743013775, 4833.3958255218095, 4858.5384388483035, 4858.611311095104, 4869.902601947942, 3045.2234680156416, 3049.283418396675, 3051.5575241589845, 3054.4501989642076, 3073.661897191307, 5241.868953276198, 5338.97330513345, 5348.277982472394, 5360.222767698662, 5396.109641909041, 5802.709864506758, 5872.882542349214, 5886.970565147232, 5888.116782482662, 5891.0, 5376.731163441812, 5378.97310513445, 5381.892362152735, 5385.596080293915, 5403.243545903577, 5559.221708960829, 5714.20001199824, 5727.4535875312595, 5738.540916726568, 5768.884622307614, 5310.601704872227, 5643.858903527444, 5662.716864156858, 5683.77264909399, 5689.431056894277, 5203.777112378512, 5267.157254839208, 5377.166539186433, 5407.891842163213, 5411.675299482044, 4602.677812553089, 4635.142498637762, 4635.791389387418, 4656.743879086683, 4657.953420465752, 5546.306711661043, 5764.0, 5766.942330576809, 5770.6249093808765, 5817.5345972321265, 5590.86022849432, 5592.3009623797025, 5613.438656134354, 5642.915356269741, 5645.447501937, 5621.128725047624, 5634.943650563442, 5651.491365777099, 5656.971715141398, 5666.716664166857, 5309.150535914235, 5544.140658197985, 5556.777728890799, 5579.9163012555655, 5582.190582365453, 5656.218291238247, 5658.179563963285, 5667.404922483245, 5682.488576028178, 5688.971555142198, 5190.429052804113, 5453.972730136324, 5522.696251706034, 5528.889422211614, 5539.667619942817], "value": 4385.108696263558, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.9732712027958, 617.3394467919328, 620.1349117980418, 650.2327253840468, 650.7201903181633, 11589.65231043069, 12169.209001414902, 12366.196197247173, 12370.938145309261, 12416.81374779379, 11714.121440891946, 11952.402379880992, 12002.75994480112, 12219.633410997661, 12716.109872308942, 833.2251006563893, 843.026304618167, 864.1142828600672, 865.3423398217337, 865.3726048614735, 859.8495263328892, 873.1225118755642, 873.7902903303193, 874.0865795243985, 875.0112373018512, 895.4090300401704, 900.8918929728409, 900.9279257659372, 901.0538934119148, 901.4951627088818, 896.6771962093641, 899.4378513429107, 899.5052721003422, 900.3652425040331, 901.7249738829654, 655.0796131435293, 655.1188651264042, 656.4453037183572, 657.7369052379039, 660.7291010685644, 13174.27541485218, 13282.867171328357, 13518.256495892721, 13648.181109133484, 13663.18020918748, 13467.326633668376, 13618.931905340509, 14147.575572732834, 14325.35535900887, 14447.566573002827, 9919.454430006346, 10036.94981525095, 10119.747006324827, 10371.636992705218, 10531.94734026325, 3151.3854798314337, 3151.862464183373, 3208.197950512372, 3211.5022171563446, 3215.4212241796467, 66838.99999999952, 67024.0, 67143.66428167876, 67243.66378168078, 68287.0, 10312.329698569569, 10336.5348559315, 10351.567381665303, 10444.21668374875, 10983.066439352584, 20402.795972040385, 20432.387028389174, 20482.89758551198, 20536.281230156874, 20581.794182057987, 6332.556721029576, 6417.614943103429, 6535.346465353522, 6559.967200163968, 6723.966380168165, 3279.0982479817762, 3360.277540328841, 3389.220479289728, 3396.524486571882, 3402.28552004077, 2567.9358016049373, 2665.6934452537816, 2677.5849743289823, 2684.3825920038503, 2693.3670587411943, 434.89127718070483, 436.78573565487994, 437.1737416283227, 438.6008732053879, 445.0, 554.2849723856181, 560.9411011843779, 565.5532129617555, 569.3253494608902, 586.2320360327984, 8313.41806073569, 8672.56637168139, 8733.257673097858, 9019.233365163904, 9148.451092934445, 548.8243761996202, 579.1746760865749, 583.5681595619211, 588.1648059755158, 588.4380416702039, 4135.255653982252, 4221.91556168881, 4475.440569928759, 4491.371208030879, 4784.139429199273, 43518.34722479165, 43966.70249731283, 54993.72503137539, 64040.35959640437, 64250.35749642444, 47395.5260447398, 47897.76051119792, 48070.278945815844, 49017.754911225216, 49600.0, 44102.55897441113, 44658.776706116914, 45141.87145321327, 45760.313595296764, 46198.30702539464, 8431.873521897054, 9095.226905713089, 9220.769480763034, 9323.0, 9327.489588969012, 30389.240268993453, 31310.530342045342, 31449.842750787015, 31856.0, 31915.840420798675, 37849.4322585156, 38076.61923380731, 38602.42096368501, 39062.804685976385, 39493.80253098716, 11097.500612472297, 11105.38920359388, 11150.163737719866, 11188.0, 11222.38276894746, 12065.879341206475, 12910.40123687696, 12981.221126732426, 13408.597742067754, 13686.589402317946, 11492.655220343404, 11513.194076414571, 11608.0, 11644.126690498417, 11698.0, 10425.0, 10646.103912266479, 10940.179486538382, 11164.888351116384, 11352.886471135183, 11683.415829208336, 11954.641360759191, 11980.46087926028, 12223.93888030554, 12608.87391126077, 10268.743281418025, 10486.737831554272, 10545.789084218426, 10710.683355113077, 10726.088282496075, 10043.940992096748, 10366.0, 10390.584376625153, 10455.424951627734, 10769.0], "value": 6200.887046254538, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1586.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 121.0, 122.0, 123.0, 124.0, 122.0, 123.0, 121.0, 121.0, 123.0], "value": 121.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 127.0, 127.0, 181.0, 127.0, 132.0, 133.0, 127.0, 160.0, 128.0], "value": 139.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 168.0, 167.0, 180.0, 163.0, 164.0, 163.0, 166.0, 164.0], "value": 166.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 77.0, 113.0, 75.0, 76.0, 75.0, 76.0, 92.0, 77.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 110.0, 85.0, 86.0, 86.0, 108.0, 86.0, 87.0, 113.0], "value": 92.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 115.0, 113.0, 114.0, 115.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 150.0, 151.0, 150.0, 151.0, 152.0, 152.0, 151.0, 151.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 94.0, 95.0, 94.0, 95.0, 97.0, 95.0, 96.0, 97.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 70.0, 72.0, 72.0, 71.0, 72.0, 74.0, 72.0, 72.0], "value": 71.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 55.0, 55.0, 56.0, 56.0, 56.0, 56.0, 56.0, 56.0], "value": 55.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 82.0, 85.0, 86.0, 82.0, 82.0, 82.0, 89.0, 81.0, 82.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 131.0, 141.0, 137.0, 138.0, 139.0, 134.0, 137.0, 221.0, 141.0], "value": 146.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 197.0, 194.0, 185.0, 198.0, 196.0, 194.0, 195.0, 195.0, 199.0], "value": 194.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 70.0, 70.0, 71.0, 73.0, 71.0, 70.0, 71.0, 71.0], "value": 72.1, "unit": "score"}]}]} 05:49:02 INFO - Return code: 0 05:49:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:49:02 ERROR - # TBPL SUCCESS # 05:49:02 INFO - Running post-action listener: _resource_record_post_action 05:49:02 INFO - [mozharness: 2017-03-15 12:49:02.404700Z] Finished run-tests step (success) 05:49:02 INFO - Running post-run listener: _resource_record_post_run 05:49:02 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 363663360; Read time: 12; Write time: 284092 05:49:02 INFO - TinderboxPrint: CPU usage
13.3% 05:49:02 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 05:49:02 INFO - TinderboxPrint: I/O write bytes / time
363,663,360 / 284,092 05:49:02 INFO - TinderboxPrint: CPU idle
8,314.7 (86.7%) 05:49:02 INFO - TinderboxPrint: CPU user
1,220.2 (12.7%) 05:49:02 INFO - TinderboxPrint: Swap in / out
0 / 0 05:49:02 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 104562688; Read time: 0; Write time: 138312 05:49:02 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 258699264; Read time: 12; Write time: 145780 05:49:03 INFO - Running post-run listener: _upload_blobber_files 05:49:03 INFO - Blob upload gear active. 05:49:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:49:03 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 05:49:03 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'] 05:49:03 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 05:49:03 INFO - (blobuploader) - INFO - Open directory for files ... 05:49:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:49:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:49:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:49:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:49:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:49:04 INFO - (blobuploader) - INFO - Done attempting. 05:49:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:49:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:49:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:49:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:49:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:49:05 INFO - (blobuploader) - INFO - Done attempting. 05:49:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:49:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:49:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:49:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:49:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:49:08 INFO - (blobuploader) - INFO - Done attempting. 05:49:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:49:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:49:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:49:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:49:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:49:09 INFO - (blobuploader) - INFO - Done attempting. 05:49:09 INFO - (blobuploader) - INFO - Iteration through files over. 05:49:09 INFO - Return code: 0 05:49:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:49:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:49:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0d17c0075fbae479ca88de7946c9b826a12c87d95acff495dbc15d75c35a94e1c04c6cab87a259b88e2b67ce58c026cec9370536c14dc35f15d703890c470298", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7b0050ecf5a524fea015170482fff57ee698462f8a6e080d678ee62eba215d3c30202c9bcaed8b10792438c2b7aa7cccb645243662cc164ab6aa80b3651ff7fc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fffec3f757e61b2e14c3295ef02727cc586b40afeaceb87ac15be12b98e36d417458e2cc51c866492849732632676128a6d44207ade3aeb5acf74d5256415a52", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6041cb61f6e68a02e18cdbfbe048c45cdbb3065f55cc85f38f723009aefe32a1b6e6aac71d63cc9c1124dc1bd09e015440e02b03307929bb1da7fef0e9d12005"} 05:49:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:49:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:49:09 INFO - Contents: 05:49:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0d17c0075fbae479ca88de7946c9b826a12c87d95acff495dbc15d75c35a94e1c04c6cab87a259b88e2b67ce58c026cec9370536c14dc35f15d703890c470298", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7b0050ecf5a524fea015170482fff57ee698462f8a6e080d678ee62eba215d3c30202c9bcaed8b10792438c2b7aa7cccb645243662cc164ab6aa80b3651ff7fc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fffec3f757e61b2e14c3295ef02727cc586b40afeaceb87ac15be12b98e36d417458e2cc51c866492849732632676128a6d44207ade3aeb5acf74d5256415a52", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6041cb61f6e68a02e18cdbfbe048c45cdbb3065f55cc85f38f723009aefe32a1b6e6aac71d63cc9c1124dc1bd09e015440e02b03307929bb1da7fef0e9d12005"} 05:49:09 INFO - Running post-run listener: copy_logs_to_upload_dir 05:49:09 INFO - Copying logs to upload dir... 05:49:09 INFO - mkdir: /builds/slave/test/build/upload/logs 05:49:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.454273 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-03-15 05:49:08.899995) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-15 05:49:08.903799) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1489580886.222668-1094734497 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/0d17c0075fbae479ca88de7946c9b826a12c87d95acff495dbc15d75c35a94e1c04c6cab87a259b88e2b67ce58c026cec9370536c14dc35f15d703890c470298", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7b0050ecf5a524fea015170482fff57ee698462f8a6e080d678ee62eba215d3c30202c9bcaed8b10792438c2b7aa7cccb645243662cc164ab6aa80b3651ff7fc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fffec3f757e61b2e14c3295ef02727cc586b40afeaceb87ac15be12b98e36d417458e2cc51c866492849732632676128a6d44207ade3aeb5acf74d5256415a52", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6041cb61f6e68a02e18cdbfbe048c45cdbb3065f55cc85f38f723009aefe32a1b6e6aac71d63cc9c1124dc1bd09e015440e02b03307929bb1da7fef0e9d12005"} build_url:https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011231 build_url: 'https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0d17c0075fbae479ca88de7946c9b826a12c87d95acff495dbc15d75c35a94e1c04c6cab87a259b88e2b67ce58c026cec9370536c14dc35f15d703890c470298", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7b0050ecf5a524fea015170482fff57ee698462f8a6e080d678ee62eba215d3c30202c9bcaed8b10792438c2b7aa7cccb645243662cc164ab6aa80b3651ff7fc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fffec3f757e61b2e14c3295ef02727cc586b40afeaceb87ac15be12b98e36d417458e2cc51c866492849732632676128a6d44207ade3aeb5acf74d5256415a52", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6041cb61f6e68a02e18cdbfbe048c45cdbb3065f55cc85f38f723009aefe32a1b6e6aac71d63cc9c1124dc1bd09e015440e02b03307929bb1da7fef0e9d12005"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-15 05:49:08.928998) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 05:49:08.929324) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1489580886.222668-1094734497 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004496 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 05:49:09.014229) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-15 05:49:09.014588) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-15 05:49:09.014874) ========= ========= Total master_lag: 0.17 =========