builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-062 starttime: 1490796871.27 results: success (0) revision: c4392f466eaab690d9b0ef7bacf72fa5e6573007 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-29 07:14:31.270774) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-29 07:14:31.271237) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-29 07:14:31.271560) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-29 07:14:31.286533) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 07:14:31.286826) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1490796870.317262-994131703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-29 07:14:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 68.3M=0s 2017-03-29 07:14:31 (68.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.150663 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 07:14:31.451297) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 07:14:31.451610) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1490796870.317262-994131703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017439 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 07:14:31.500869) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-29 07:14:31.501206) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c4392f466eaab690d9b0ef7bacf72fa5e6573007 --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 c4392f466eaab690d9b0ef7bacf72fa5e6573007 --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=a4ce256d2ec601f24a60a71e000001bc-1490796870.317262-994131703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-29 07:14:31,890 truncating revision to first 12 chars 2017-03-29 07:14:31,890 Setting DEBUG logging. 2017-03-29 07:14:31,890 attempt 1/10 2017-03-29 07:14:31,890 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c4392f466eaa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-29 07:14:33,022 unpacking tar archive at: mozilla-central-c4392f466eaa/testing/mozharness/ program finished with exit code 0 elapsedTime=1.441298 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-29 07:14:32.957346) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-29 07:14:32.957915) ========= script_repo_revision: c4392f466eaab690d9b0ef7bacf72fa5e6573007 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-29 07:14:32.958487) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-29 07:14:32.958851) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-29 07:14:32.968951) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-29 07:14:32.969317) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=a4ce256d2ec601f24a60a71e000001bc-1490796870.317262-994131703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:14:33 INFO - MultiFileLogger online at 20170329 07:14:33 in /builds/slave/test 07:14:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 07:14:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:14:33 INFO - {'append_to_log': False, 07:14:33 INFO - 'base_work_dir': '/builds/slave/test', 07:14:33 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:14:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:14:33 INFO - 'branch': 'Firefox-Non-PGO', 07:14:33 INFO - 'buildbot_json_path': 'buildprops.json', 07:14:33 INFO - 'config_files': ('talos/linux_config.py',), 07:14:33 INFO - 'default_actions': ('clobber', 07:14:33 INFO - 'read-buildbot-config', 07:14:33 INFO - 'download-and-extract', 07:14:33 INFO - 'populate-webroot', 07:14:33 INFO - 'create-virtualenv', 07:14:33 INFO - 'install', 07:14:33 INFO - 'run-tests'), 07:14:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:14:33 INFO - 'download_minidump_stackwalk': True, 07:14:33 INFO - 'download_symbols': 'ondemand', 07:14:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:14:33 INFO - 'tooltool.py': '/tools/tooltool.py', 07:14:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:14:33 INFO - '/tools/misc-python/virtualenv.py')}, 07:14:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:14:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:14:33 INFO - 'gecko_profile': False, 07:14:33 INFO - 'gecko_profile_interval': 0, 07:14:33 INFO - 'installer_path': 'installer.exe', 07:14:33 INFO - 'log_level': 'info', 07:14:33 INFO - 'log_name': 'talos', 07:14:33 INFO - 'log_to_console': True, 07:14:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:14:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:14:33 INFO - 'opt_config_files': (), 07:14:33 INFO - 'pip_index': False, 07:14:33 INFO - 'suite': 'dromaeojs', 07:14:33 INFO - 'system_bits': '32', 07:14:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:14:33 INFO - 'title': 'talos-linux64-ix-062', 07:14:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:14:33 INFO - 'use_talos_json': True, 07:14:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:14:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:14:33 INFO - 'work_dir': 'build'} 07:14:33 INFO - [mozharness: 2017-03-29 14:14:33.466241Z] Running clobber step. 07:14:33 INFO - Running pre-action listener: _resource_record_pre_action 07:14:33 INFO - Running main action method: clobber 07:14:33 INFO - rmtree: /builds/slave/test/build 07:14:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:14:34 INFO - Running post-action listener: _resource_record_post_action 07:14:34 INFO - [mozharness: 2017-03-29 14:14:34.406788Z] Finished clobber step (success) 07:14:34 INFO - [mozharness: 2017-03-29 14:14:34.406887Z] Running read-buildbot-config step. 07:14:34 INFO - Running pre-action listener: _resource_record_pre_action 07:14:34 INFO - Running main action method: read_buildbot_config 07:14:34 INFO - Using buildbot properties: 07:14:34 INFO - { 07:14:34 INFO - "project": "", 07:14:34 INFO - "product": "firefox", 07:14:34 INFO - "who": "ryanvm@gmail.com", 07:14:34 INFO - "installer_path": "public/build/target.tar.bz2", 07:14:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:14:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 07:14:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:14:34 INFO - "stage_platform": "linux64", 07:14:34 INFO - "basedir": "/builds/slave/test", 07:14:34 INFO - "buildnumber": 1039, 07:14:34 INFO - "platform": "ubuntu64_hw", 07:14:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:14:34 INFO - "slavebuilddir": "test", 07:14:34 INFO - "taskId": "fXqtHNduRgeXDfR5G4R5AA", 07:14:34 INFO - "branch": "mozilla-central", 07:14:34 INFO - "script_repo_revision": "production", 07:14:34 INFO - "revision": "c4392f466eaab690d9b0ef7bacf72fa5e6573007", 07:14:34 INFO - "slavename": "talos-linux64-ix-062", 07:14:34 INFO - "repo_path": "mozilla-central" 07:14:34 INFO - } 07:14:34 INFO - Finding installer, test and symbols from parent task. 07:14:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fXqtHNduRgeXDfR5G4R5AA'}, attempt #1 07:14:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fXqtHNduRgeXDfR5G4R5AA'}, attempt #1 07:14:35 INFO - Task dependencies: Lizx6zgGT2iHJFELVUoVlg 07:14:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg'}, attempt #1 07:14:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.tar.bz2 07:14:35 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/test_packages.json 07:14:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.crashreporter-symbols.zip 07:14:35 INFO - Running post-action listener: _resource_record_post_action 07:14:35 INFO - [mozharness: 2017-03-29 14:14:35.802676Z] Finished read-buildbot-config step (success) 07:14:35 INFO - [mozharness: 2017-03-29 14:14:35.802892Z] Running download-and-extract step. 07:14:35 INFO - Running pre-action listener: _resource_record_pre_action 07:14:35 INFO - Running main action method: download_and_extract 07:14:35 INFO - mkdir: /builds/slave/test/build/tests 07:14:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:14:35 INFO - trying https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.test_packages.json 07:14:35 INFO - Downloading https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:14:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:14:36 INFO - Downloaded 986 bytes. 07:14:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:14:36 INFO - Using the following test package requirements: 07:14:36 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:14:36 INFO - u'common': [u'target.common.tests.zip'], 07:14:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:14:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:14:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:14:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:14:36 INFO - u'mozbase': [u'target.common.tests.zip'], 07:14:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:14:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:14:36 INFO - u'web-platform': [u'target.common.tests.zip', 07:14:36 INFO - u'target.web-platform.tests.zip'], 07:14:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:14:36 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 07:14:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.common.tests.zip 07:14:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:14:36 INFO - Fetch https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.common.tests.zip into memory 07:14:37 INFO - Expected file size: 58223762 07:14:37 INFO - Obtained file size: 58223762 07:14:47 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 07:14:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.common.tests.zip 07:14:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:14:47 INFO - Fetch https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.common.tests.zip into memory 07:14:48 INFO - Expected file size: 58223762 07:14:48 INFO - Obtained file size: 58223762 07:14:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.talos.tests.zip 07:14:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:14:59 INFO - Fetch https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.talos.tests.zip into memory 07:14:59 INFO - Expected file size: 14404171 07:14:59 INFO - Obtained file size: 14404171 07:14: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')]} 07:14:59 INFO - trying https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.tar.bz2 07:14:59 INFO - Downloading https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:14:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:15:01 INFO - Downloaded 62581144 bytes. 07:15:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.tar.bz2 07:15:01 INFO - mkdir: /builds/slave/test/properties 07:15:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:15:01 INFO - Writing to file /builds/slave/test/properties/build_url 07:15:01 INFO - Contents: 07:15:01 INFO - build_url:https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.tar.bz2 07:15:01 INFO - Running post-action listener: _resource_record_post_action 07:15:01 INFO - Running post-action listener: set_extra_try_arguments 07:15:01 INFO - [mozharness: 2017-03-29 14:15:01.118572Z] Finished download-and-extract step (success) 07:15:01 INFO - [mozharness: 2017-03-29 14:15:01.118667Z] Running populate-webroot step. 07:15:01 INFO - Running pre-action listener: _resource_record_pre_action 07:15:01 INFO - Running main action method: populate_webroot 07:15:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:15:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:15:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:15:01 INFO - '--tppagecycles', 07:15:01 INFO - '7'], 07:15:01 INFO - 'tests': ['tsvgm']}}, 07:15:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:15:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:15:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:15:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:15:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:15:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:15:01 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:15:01 INFO - 'talos_options': ['--disable-e10s'], 07:15:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:15:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:15:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:15:01 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:15:01 INFO - 'talos_options': ['--disable-e10s'], 07:15:01 INFO - 'tests': ['damp', 'tps']}, 07:15:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:15:01 INFO - 'tests': ['damp', 'tps']}, 07:15:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:15:01 INFO - 'tests': ['dromaeo_dom']}, 07:15:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:15:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:15:01 INFO - 'tests': ['basic_compositor_video']}, 07:15:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:15:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:15:01 INFO - 'tests': ['a11yr', 07:15:01 INFO - 'ts_paint', 07:15:01 INFO - 'tpaint', 07:15:01 INFO - 'sessionrestore', 07:15:01 INFO - 'sessionrestore_no_auto_restore', 07:15:01 INFO - 'tabpaint']}, 07:15:01 INFO - 'other-e10s': {'tests': ['a11yr', 07:15:01 INFO - 'ts_paint', 07:15:01 INFO - 'tpaint', 07:15:01 INFO - 'sessionrestore', 07:15:01 INFO - 'sessionrestore_no_auto_restore', 07:15:01 INFO - 'tabpaint']}, 07:15:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:15:01 INFO - 'ts_paint', 07:15:01 INFO - 'tpaint', 07:15:01 INFO - 'sessionrestore', 07:15:01 INFO - 'sessionrestore_no_auto_restore', 07:15:01 INFO - 'tabpaint']}, 07:15:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:15:01 INFO - 'ts_paint', 07:15:01 INFO - 'tpaint', 07:15:01 INFO - 'sessionrestore', 07:15:01 INFO - 'sessionrestore_no_auto_restore', 07:15:01 INFO - 'tabpaint']}, 07:15:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:15:01 INFO - 'tests': ['a11yr', 07:15:01 INFO - 'ts_paint', 07:15:01 INFO - 'tpaint', 07:15:01 INFO - 'sessionrestore', 07:15:01 INFO - 'sessionrestore_no_auto_restore', 07:15:01 INFO - 'tabpaint']}, 07:15:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:15:01 INFO - 'tests': ['a11yr', 07:15:01 INFO - 'ts_paint', 07:15:01 INFO - 'tpaint', 07:15:01 INFO - 'sessionrestore', 07:15:01 INFO - 'sessionrestore_no_auto_restore', 07:15:01 INFO - 'tabpaint']}, 07:15:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:15:01 INFO - 'tests': ['tsvgx', 07:15:01 INFO - 'tsvgr_opacity', 07:15:01 INFO - 'tart', 07:15:01 INFO - 'tscrollx', 07:15:01 INFO - 'cart', 07:15:01 INFO - 'tsvg_static']}, 07:15:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:15:01 INFO - 'tsvgr_opacity', 07:15:01 INFO - 'tart', 07:15:01 INFO - 'tscrollx', 07:15:01 INFO - 'cart', 07:15:01 INFO - 'tsvg_static']}, 07:15:01 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:15:01 INFO - 'talos_options': ['--disable-e10s'], 07:15:01 INFO - 'tests': ['tp5o']}, 07:15:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:15:01 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:15:01 INFO - 'talos_options': ['--disable-e10s', 07:15:01 INFO - '--xperf_path', 07:15:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:15:01 INFO - 'tests': ['tp5n']}, 07:15:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:15:01 INFO - 'talos_options': ['--xperf_path', 07:15:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:15:01 INFO - 'tests': ['tp5n']}}, 07:15:01 INFO - 'talos.zip': {'path': '', 07:15:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:15:01 INFO - Running post-action listener: _resource_record_post_action 07:15:01 INFO - [mozharness: 2017-03-29 14:15:01.131800Z] Finished populate-webroot step (success) 07:15:01 INFO - [mozharness: 2017-03-29 14:15:01.131889Z] Running create-virtualenv step. 07:15:01 INFO - Running pre-action listener: _resource_record_pre_action 07:15:01 INFO - Running main action method: create_virtualenv 07:15:01 INFO - Creating virtualenv /builds/slave/test/build/venv 07:15:01 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 07:15:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:15:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:15:01 INFO - Using real prefix '/usr' 07:15:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:15:01 INFO - Installing distribute.............................................................................................................................................................................................done. 07:15:03 INFO - Installing pip.................done. 07:15:03 INFO - Return code: 0 07:15:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:15:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:15:03 INFO - Reading from file tmpfile_stdout 07:15:03 INFO - Output received: 07:15:03 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) 07:15:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:15:03 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')]} 07:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:03 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')]} 07:15:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:03 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 0xf5a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f5290>, '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 0x11f5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f6040>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1490796870.317262-994131703', '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 07:15:03 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 07:15:03 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 07:15:03 INFO - Using env: {'DISPLAY': ':0', 07:15:03 INFO - 'HOME': '/home/cltbld', 07:15:03 INFO - 'LANG': 'en_US.UTF-8', 07:15:03 INFO - 'LANGUAGE': 'en_US:en', 07:15:03 INFO - 'LOGNAME': 'cltbld', 07:15:03 INFO - 'MAIL': '/var/mail/cltbld', 07:15:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:03 INFO - 'MOZ_NO_REMOTE': '1', 07:15:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:03 INFO - 'NO_EM_RESTART': '1', 07:15:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:03 INFO - 'PWD': '/builds/slave/test', 07:15:03 INFO - 'SHELL': '/bin/bash', 07:15:03 INFO - 'SHLVL': '1', 07:15:03 INFO - 'TERM': 'linux', 07:15:03 INFO - 'TMOUT': '86400', 07:15:03 INFO - 'USER': 'cltbld', 07:15:03 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1490796870.317262-994131703', 07:15:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:03 INFO - '_': '/tools/buildbot/bin/python'} 07:15:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:04 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 07:15:04 INFO - Cleaning up... 07:15:04 INFO - Return code: 0 07:15:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:15:04 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')]} 07:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:04 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')]} 07:15:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:04 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 0xf5a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f5290>, '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 0x11f5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f6040>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1490796870.317262-994131703', '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 07:15:04 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 07:15:04 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 07:15:04 INFO - Using env: {'DISPLAY': ':0', 07:15:04 INFO - 'HOME': '/home/cltbld', 07:15:04 INFO - 'LANG': 'en_US.UTF-8', 07:15:04 INFO - 'LANGUAGE': 'en_US:en', 07:15:04 INFO - 'LOGNAME': 'cltbld', 07:15:04 INFO - 'MAIL': '/var/mail/cltbld', 07:15:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:04 INFO - 'MOZ_NO_REMOTE': '1', 07:15:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:04 INFO - 'NO_EM_RESTART': '1', 07:15:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:04 INFO - 'PWD': '/builds/slave/test', 07:15:04 INFO - 'SHELL': '/bin/bash', 07:15:04 INFO - 'SHLVL': '1', 07:15:04 INFO - 'TERM': 'linux', 07:15:04 INFO - 'TMOUT': '86400', 07:15:04 INFO - 'USER': 'cltbld', 07:15:04 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1490796870.317262-994131703', 07:15:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:04 INFO - '_': '/tools/buildbot/bin/python'} 07:15:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:04 INFO - Downloading/unpacking psutil>=3.1.1 07:15:04 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 07:15:04 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 07:15:04 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 07:15:04 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 07:15:04 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 07:15:04 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 07:15:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:15:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:15:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:15:06 INFO - Installing collected packages: psutil 07:15:06 INFO - Running setup.py install for psutil 07:15:06 INFO - building 'psutil._psutil_linux' extension 07:15:06 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 07:15:06 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 07:15:06 INFO - building 'psutil._psutil_posix' extension 07:15:06 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 07:15:06 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 07:15:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:15:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:15:06 INFO - Successfully installed psutil 07:15:06 INFO - Cleaning up... 07:15:07 INFO - Return code: 0 07:15:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:15:07 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')]} 07:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:07 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')]} 07:15:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:07 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 0xf5a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f5290>, '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 0x11f5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f6040>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1490796870.317262-994131703', '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 07:15:07 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 07:15:07 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 07:15:07 INFO - Using env: {'DISPLAY': ':0', 07:15:07 INFO - 'HOME': '/home/cltbld', 07:15:07 INFO - 'LANG': 'en_US.UTF-8', 07:15:07 INFO - 'LANGUAGE': 'en_US:en', 07:15:07 INFO - 'LOGNAME': 'cltbld', 07:15:07 INFO - 'MAIL': '/var/mail/cltbld', 07:15:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:07 INFO - 'MOZ_NO_REMOTE': '1', 07:15:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:07 INFO - 'NO_EM_RESTART': '1', 07:15:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:07 INFO - 'PWD': '/builds/slave/test', 07:15:07 INFO - 'SHELL': '/bin/bash', 07:15:07 INFO - 'SHLVL': '1', 07:15:07 INFO - 'TERM': 'linux', 07:15:07 INFO - 'TMOUT': '86400', 07:15:07 INFO - 'USER': 'cltbld', 07:15:07 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1490796870.317262-994131703', 07:15:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:07 INFO - '_': '/tools/buildbot/bin/python'} 07:15:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:15:07 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 07:15:07 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 07:15:07 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 07:15:07 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 07:15:07 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 07:15:07 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 07:15:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:15:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:15:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:15:09 INFO - Installing collected packages: mozsystemmonitor 07:15:09 INFO - Running setup.py install for mozsystemmonitor 07:15:09 INFO - Successfully installed mozsystemmonitor 07:15:09 INFO - Cleaning up... 07:15:09 INFO - Return code: 0 07:15:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:15:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:09 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 0xf5a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f5290>, '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 0x11f5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f6040>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1490796870.317262-994131703', '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 07:15:09 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 07:15:09 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 07:15:09 INFO - Using env: {'DISPLAY': ':0', 07:15:09 INFO - 'HOME': '/home/cltbld', 07:15:09 INFO - 'LANG': 'en_US.UTF-8', 07:15:09 INFO - 'LANGUAGE': 'en_US:en', 07:15:09 INFO - 'LOGNAME': 'cltbld', 07:15:09 INFO - 'MAIL': '/var/mail/cltbld', 07:15:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:09 INFO - 'MOZ_NO_REMOTE': '1', 07:15:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:09 INFO - 'NO_EM_RESTART': '1', 07:15:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:09 INFO - 'PWD': '/builds/slave/test', 07:15:09 INFO - 'SHELL': '/bin/bash', 07:15:09 INFO - 'SHLVL': '1', 07:15:09 INFO - 'TERM': 'linux', 07:15:09 INFO - 'TMOUT': '86400', 07:15:09 INFO - 'USER': 'cltbld', 07:15:09 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1490796870.317262-994131703', 07:15:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:09 INFO - '_': '/tools/buildbot/bin/python'} 07:15:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:09 INFO - Downloading/unpacking jsonschema==2.5.1 07:15:09 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 07:15:09 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 07:15:09 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 07:15:09 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 07:15:09 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 07:15:09 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 07:15:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:15:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:15:11 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 07:15:11 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 07:15:11 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 07:15:11 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 07:15:11 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 07:15:11 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 07:15:11 INFO - Downloading functools32-3.2.3-2.tar.gz 07:15:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:15:12 INFO - warning: no files found matching '*.txt' 07:15:12 INFO - no previously-included directories found matching 'build' 07:15:12 INFO - no previously-included directories found matching 'dist' 07:15:12 INFO - no previously-included directories found matching '.git*' 07:15:12 INFO - Installing collected packages: jsonschema, functools32 07:15:12 INFO - Running setup.py install for functools32 07:15:12 INFO - warning: no files found matching '*.txt' 07:15:12 INFO - no previously-included directories found matching 'build' 07:15:12 INFO - no previously-included directories found matching 'dist' 07:15:12 INFO - no previously-included directories found matching '.git*' 07:15:12 INFO - Successfully installed jsonschema functools32 07:15:12 INFO - Cleaning up... 07:15:12 INFO - Return code: 0 07:15:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:15:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:12 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 0xf5a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f5290>, '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 0x11f5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f6040>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1490796870.317262-994131703', '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 07:15:12 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 07:15:12 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 07:15:12 INFO - Using env: {'DISPLAY': ':0', 07:15:12 INFO - 'HOME': '/home/cltbld', 07:15:12 INFO - 'LANG': 'en_US.UTF-8', 07:15:12 INFO - 'LANGUAGE': 'en_US:en', 07:15:12 INFO - 'LOGNAME': 'cltbld', 07:15:12 INFO - 'MAIL': '/var/mail/cltbld', 07:15:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:12 INFO - 'MOZ_NO_REMOTE': '1', 07:15:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:12 INFO - 'NO_EM_RESTART': '1', 07:15:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:12 INFO - 'PWD': '/builds/slave/test', 07:15:12 INFO - 'SHELL': '/bin/bash', 07:15:12 INFO - 'SHLVL': '1', 07:15:12 INFO - 'TERM': 'linux', 07:15:12 INFO - 'TMOUT': '86400', 07:15:12 INFO - 'USER': 'cltbld', 07:15:12 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1490796870.317262-994131703', 07:15:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:12 INFO - '_': '/tools/buildbot/bin/python'} 07:15:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:15:12 INFO - Cleaning up... 07:15:12 INFO - Return code: 0 07:15:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:15:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:12 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 0xf5a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f5290>, '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 0x11f5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f6040>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1490796870.317262-994131703', '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 07:15:12 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 07:15:12 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 07:15:12 INFO - Using env: {'DISPLAY': ':0', 07:15:12 INFO - 'HOME': '/home/cltbld', 07:15:12 INFO - 'LANG': 'en_US.UTF-8', 07:15:12 INFO - 'LANGUAGE': 'en_US:en', 07:15:12 INFO - 'LOGNAME': 'cltbld', 07:15:12 INFO - 'MAIL': '/var/mail/cltbld', 07:15:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:12 INFO - 'MOZ_NO_REMOTE': '1', 07:15:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:12 INFO - 'NO_EM_RESTART': '1', 07:15:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:12 INFO - 'PWD': '/builds/slave/test', 07:15:12 INFO - 'SHELL': '/bin/bash', 07:15:12 INFO - 'SHLVL': '1', 07:15:12 INFO - 'TERM': 'linux', 07:15:12 INFO - 'TMOUT': '86400', 07:15:12 INFO - 'USER': 'cltbld', 07:15:12 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1490796870.317262-994131703', 07:15:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:12 INFO - '_': '/tools/buildbot/bin/python'} 07:15:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:12 INFO - Downloading/unpacking blobuploader==1.2.4 07:15:12 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 07:15:12 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 07:15:12 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 07:15:12 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 07:15:12 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 07:15:12 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 07:15:14 INFO - Downloading blobuploader-1.2.4.tar.gz 07:15:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:15:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:15:14 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 07:15:14 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 07:15:14 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 07:15:14 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 07:15:14 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 07:15:14 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 07:15:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:15:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:15:15 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 07:15:15 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 07:15:15 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 07:15:15 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 07:15:15 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 07:15:15 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 07:15:15 INFO - Downloading docopt-0.6.1.tar.gz 07:15:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:15:15 INFO - Installing collected packages: blobuploader, requests, docopt 07:15:15 INFO - Running setup.py install for blobuploader 07:15:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:15:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:15:15 INFO - Running setup.py install for requests 07:15:15 INFO - Running setup.py install for docopt 07:15:16 INFO - Successfully installed blobuploader requests docopt 07:15:16 INFO - Cleaning up... 07:15:16 INFO - Return code: 0 07:15:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:16 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 0xf5a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f5290>, '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 0x11f5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f6040>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1490796870.317262-994131703', '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 07:15:16 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 07:15:16 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 07:15:16 INFO - Using env: {'DISPLAY': ':0', 07:15:16 INFO - 'HOME': '/home/cltbld', 07:15:16 INFO - 'LANG': 'en_US.UTF-8', 07:15:16 INFO - 'LANGUAGE': 'en_US:en', 07:15:16 INFO - 'LOGNAME': 'cltbld', 07:15:16 INFO - 'MAIL': '/var/mail/cltbld', 07:15:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:16 INFO - 'MOZ_NO_REMOTE': '1', 07:15:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:16 INFO - 'NO_EM_RESTART': '1', 07:15:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:16 INFO - 'PWD': '/builds/slave/test', 07:15:16 INFO - 'SHELL': '/bin/bash', 07:15:16 INFO - 'SHLVL': '1', 07:15:16 INFO - 'TERM': 'linux', 07:15:16 INFO - 'TMOUT': '86400', 07:15:16 INFO - 'USER': 'cltbld', 07:15:16 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1490796870.317262-994131703', 07:15:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:16 INFO - '_': '/tools/buildbot/bin/python'} 07:15:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:15:16 INFO - Running setup.py (path:/tmp/pip-OzjvRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:15:16 INFO - Running setup.py (path:/tmp/pip-Ux0zgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:15:16 INFO - Running setup.py (path:/tmp/pip-2iM3VH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:15:16 INFO - Running setup.py (path:/tmp/pip-PqnSPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:15:16 INFO - Running setup.py (path:/tmp/pip-Sn4Mwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:15:16 INFO - Running setup.py (path:/tmp/pip-0PT1Bh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:15:16 INFO - Running setup.py (path:/tmp/pip-69jA4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:15:16 INFO - Running setup.py (path:/tmp/pip-EksEIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:15:16 INFO - Running setup.py (path:/tmp/pip-T7Ry7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:15:16 INFO - Running setup.py (path:/tmp/pip-j_lO0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:15:17 INFO - Running setup.py (path:/tmp/pip-y5sUoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:15:17 INFO - Running setup.py (path:/tmp/pip-X35_rQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:15:17 INFO - Running setup.py (path:/tmp/pip-FyWdlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:15:17 INFO - Running setup.py (path:/tmp/pip-UypSuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:17 INFO - Running setup.py (path:/tmp/pip-NORNZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:15:17 INFO - Running setup.py (path:/tmp/pip-5IqJcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:15:17 INFO - Running setup.py (path:/tmp/pip-EIG5uT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:15:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:15:17 INFO - Running setup.py install for manifestparser 07:15:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:15:17 INFO - Running setup.py install for mozcrash 07:15:17 INFO - Running setup.py install for mozdebug 07:15:17 INFO - Running setup.py install for mozdevice 07:15:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:15:17 INFO - Running setup.py install for mozfile 07:15:18 INFO - Running setup.py install for mozhttpd 07:15:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:15:18 INFO - Running setup.py install for mozinfo 07:15:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:15:18 INFO - Running setup.py install for mozInstall 07:15:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:15:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:15:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:15:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:15:18 INFO - Running setup.py install for mozleak 07:15:18 INFO - Running setup.py install for mozlog 07:15:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:15:18 INFO - Running setup.py install for moznetwork 07:15:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:15:18 INFO - Running setup.py install for mozprocess 07:15:18 INFO - Running setup.py install for mozprofile 07:15:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:15:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:15:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:15:18 INFO - Running setup.py install for mozrunner 07:15:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:15:19 INFO - Running setup.py install for mozscreenshot 07:15:19 INFO - Running setup.py install for moztest 07:15:19 INFO - Running setup.py install for mozversion 07:15:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:15:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:15:19 INFO - Cleaning up... 07:15:19 INFO - Return code: 0 07:15:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:19 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 0xf5a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f5290>, '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 0x11f5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f6040>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1490796870.317262-994131703', '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 07:15:19 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 07:15:19 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 07:15:19 INFO - Using env: {'DISPLAY': ':0', 07:15:19 INFO - 'HOME': '/home/cltbld', 07:15:19 INFO - 'LANG': 'en_US.UTF-8', 07:15:19 INFO - 'LANGUAGE': 'en_US:en', 07:15:19 INFO - 'LOGNAME': 'cltbld', 07:15:19 INFO - 'MAIL': '/var/mail/cltbld', 07:15:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:19 INFO - 'MOZ_NO_REMOTE': '1', 07:15:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:19 INFO - 'NO_EM_RESTART': '1', 07:15:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:19 INFO - 'PWD': '/builds/slave/test', 07:15:19 INFO - 'SHELL': '/bin/bash', 07:15:19 INFO - 'SHLVL': '1', 07:15:19 INFO - 'TERM': 'linux', 07:15:19 INFO - 'TMOUT': '86400', 07:15:19 INFO - 'USER': 'cltbld', 07:15:19 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1490796870.317262-994131703', 07:15:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:19 INFO - '_': '/tools/buildbot/bin/python'} 07:15:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:15:19 INFO - Running setup.py (path:/tmp/pip-2EIoCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:15:19 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)) 07:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:15:19 INFO - Running setup.py (path:/tmp/pip-sTONDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:15:19 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)) 07:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:15:19 INFO - Running setup.py (path:/tmp/pip-ZfnLjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:15:19 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)) 07:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:15:19 INFO - Running setup.py (path:/tmp/pip-9ufzr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:15:19 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)) 07:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:15:19 INFO - Running setup.py (path:/tmp/pip-UQjQCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:15:19 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)) 07:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:15:19 INFO - Running setup.py (path:/tmp/pip-RUGgGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:15:19 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)) 07:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:15:20 INFO - Running setup.py (path:/tmp/pip-0AhTDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:15:20 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)) 07:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:15:20 INFO - Running setup.py (path:/tmp/pip-sDMhdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:15:20 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)) 07:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:15:20 INFO - Running setup.py (path:/tmp/pip-rFXqlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:15:20 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)) 07:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:15:20 INFO - Running setup.py (path:/tmp/pip-N3xuca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:15:20 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)) 07:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:15:20 INFO - Running setup.py (path:/tmp/pip-TOs5VC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:15:20 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)) 07:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:15:20 INFO - Running setup.py (path:/tmp/pip-jRkjXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:15:20 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)) 07:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:15:20 INFO - Running setup.py (path:/tmp/pip-2I7cAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:15:20 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)) 07:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:15:20 INFO - Running setup.py (path:/tmp/pip-HGhAAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:15:20 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)) 07:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:20 INFO - Running setup.py (path:/tmp/pip-a79Wgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:20 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)) 07:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:15:20 INFO - Running setup.py (path:/tmp/pip-1s73Rb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:15:20 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)) 07:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:15:20 INFO - Running setup.py (path:/tmp/pip-VKhF41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:15:20 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)) 07:15:20 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)) 07:15:20 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)) 07:15:20 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)) 07:15:20 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)) 07:15:20 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)) 07:15:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:22 INFO - Downloading blessings-1.6.tar.gz 07:15:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:15:22 INFO - Installing collected packages: blessings 07:15:22 INFO - Running setup.py install for blessings 07:15:23 INFO - Successfully installed blessings 07:15:23 INFO - Cleaning up... 07:15:23 INFO - Return code: 0 07:15:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:15:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:15:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:15:23 INFO - Reading from file tmpfile_stdout 07:15:23 INFO - Current package versions: 07:15:23 INFO - argparse == 1.2.1 07:15:23 INFO - blessings == 1.6 07:15:23 INFO - blobuploader == 1.2.4 07:15:23 INFO - docopt == 0.6.1 07:15:23 INFO - functools32 == 3.2.3-2 07:15:23 INFO - jsonschema == 2.5.1 07:15:23 INFO - manifestparser == 1.1 07:15:23 INFO - mozInstall == 1.12 07:15:23 INFO - mozcrash == 1.0 07:15:23 INFO - mozdebug == 0.1 07:15:23 INFO - mozdevice == 0.49 07:15:23 INFO - mozfile == 1.2 07:15:23 INFO - mozhttpd == 0.7 07:15:23 INFO - mozinfo == 0.9 07:15:23 INFO - mozleak == 0.1 07:15:23 INFO - mozlog == 3.4 07:15:23 INFO - moznetwork == 0.27 07:15:23 INFO - mozprocess == 0.25 07:15:23 INFO - mozprofile == 0.28 07:15:23 INFO - mozrunner == 6.13 07:15:23 INFO - mozscreenshot == 0.1 07:15:23 INFO - mozsystemmonitor == 0.3 07:15:23 INFO - moztest == 0.8 07:15:23 INFO - mozversion == 1.4 07:15:23 INFO - psutil == 3.1.1 07:15:23 INFO - requests == 1.2.3 07:15:23 INFO - wsgiref == 0.1.2 07:15:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:23 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 0xf5a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f5290>, '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 0x11f5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f6040>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1490796870.317262-994131703', '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 07:15:23 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 07:15:23 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 07:15:23 INFO - Using env: {'DISPLAY': ':0', 07:15:23 INFO - 'HOME': '/home/cltbld', 07:15:23 INFO - 'LANG': 'en_US.UTF-8', 07:15:23 INFO - 'LANGUAGE': 'en_US:en', 07:15:23 INFO - 'LOGNAME': 'cltbld', 07:15:23 INFO - 'MAIL': '/var/mail/cltbld', 07:15:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:23 INFO - 'MOZ_NO_REMOTE': '1', 07:15:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:23 INFO - 'NO_EM_RESTART': '1', 07:15:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:23 INFO - 'PWD': '/builds/slave/test', 07:15:23 INFO - 'SHELL': '/bin/bash', 07:15:23 INFO - 'SHLVL': '1', 07:15:23 INFO - 'TERM': 'linux', 07:15:23 INFO - 'TMOUT': '86400', 07:15:23 INFO - 'USER': 'cltbld', 07:15:23 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1490796870.317262-994131703', 07:15:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:23 INFO - '_': '/tools/buildbot/bin/python'} 07:15:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:23 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)) 07:15:23 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)) 07:15:23 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)) 07:15:23 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)) 07:15:23 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)) 07:15:23 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)) 07:15:23 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)) 07:15:23 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)) 07:15:23 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)) 07:15:23 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)) 07:15:23 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)) 07:15:23 INFO - Cleaning up... 07:15:23 INFO - Return code: 0 07:15:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:15:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f5290>, '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 0x11f5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f6040>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1490796870.317262-994131703', '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 07:15:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:15:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:15:23 INFO - Using env: {'DISPLAY': ':0', 07:15:23 INFO - 'HOME': '/home/cltbld', 07:15:23 INFO - 'LANG': 'en_US.UTF-8', 07:15:23 INFO - 'LANGUAGE': 'en_US:en', 07:15:23 INFO - 'LOGNAME': 'cltbld', 07:15:23 INFO - 'MAIL': '/var/mail/cltbld', 07:15:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:23 INFO - 'MOZ_NO_REMOTE': '1', 07:15:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:23 INFO - 'NO_EM_RESTART': '1', 07:15:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:23 INFO - 'PWD': '/builds/slave/test', 07:15:23 INFO - 'SHELL': '/bin/bash', 07:15:23 INFO - 'SHLVL': '1', 07:15:23 INFO - 'TERM': 'linux', 07:15:23 INFO - 'TMOUT': '86400', 07:15:23 INFO - 'USER': 'cltbld', 07:15:23 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1490796870.317262-994131703', 07:15:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:23 INFO - '_': '/tools/buildbot/bin/python'} 07:15:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:15:23 INFO - Cleaning up... 07:15:23 INFO - Return code: 0 07:15:23 INFO - Running post-action listener: _resource_record_post_action 07:15:23 INFO - Running post-action listener: _start_resource_monitoring 07:15:23 INFO - Starting resource monitoring. 07:15:23 INFO - [mozharness: 2017-03-29 14:15:23.826974Z] Finished create-virtualenv step (success) 07:15:23 INFO - [mozharness: 2017-03-29 14:15:23.827445Z] Running install step. 07:15:23 INFO - Running pre-action listener: _resource_record_pre_action 07:15:23 INFO - Running main action method: install 07:15:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:15:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:15:24 INFO - Reading from file tmpfile_stdout 07:15:24 INFO - Detecting whether we're running mozinstall >=1.0... 07:15:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:15:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:15:24 INFO - Reading from file tmpfile_stdout 07:15:24 INFO - Output received: 07:15:24 INFO - Usage: mozinstall [options] installer 07:15:24 INFO - Options: 07:15:24 INFO - -h, --help show this help message and exit 07:15:24 INFO - -d DEST, --destination=DEST 07:15:24 INFO - Directory to install application into. [default: 07:15:24 INFO - "/builds/slave/test"] 07:15:24 INFO - --app=APP Application being installed. [default: firefox] 07:15:24 INFO - mkdir: /builds/slave/test/build/application 07:15:24 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'] 07:15:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:15:39 INFO - Reading from file tmpfile_stdout 07:15:39 INFO - Output received: 07:15:39 INFO - /builds/slave/test/build/application/firefox/firefox 07:15:39 INFO - Running post-action listener: _resource_record_post_action 07:15:39 INFO - [mozharness: 2017-03-29 14:15:39.836441Z] Finished install step (success) 07:15:39 INFO - [mozharness: 2017-03-29 14:15:39.836576Z] Running run-tests step. 07:15:39 INFO - Running pre-action listener: _resource_record_pre_action 07:15:39 INFO - Running main action method: run_tests 07:15:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:15:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:15:39 INFO - Python 2.7.3 07:15:39 INFO - Return code: 0 07:15:39 INFO - grabbing minidump binary from tooltool 07:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:39 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 0x11f5290>, '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 0x11f5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f6040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:15:39 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 07:15:39 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 07:15:39 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 07:15:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:15:39 INFO - Return code: 0 07:15:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:15:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:15:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:15:39 INFO - ENV: RUST_BACKTRACE is now 1 07:15:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:15:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:15:39 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:15:39 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:15:39 INFO - Using env: {'DISPLAY': ':0', 07:15:39 INFO - 'HOME': '/home/cltbld', 07:15:39 INFO - 'LANG': 'en_US.UTF-8', 07:15:39 INFO - 'LANGUAGE': 'en_US:en', 07:15:39 INFO - 'LOGNAME': 'cltbld', 07:15:39 INFO - 'MAIL': '/var/mail/cltbld', 07:15:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:15:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:39 INFO - 'MOZ_NO_REMOTE': '1', 07:15:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:15:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:39 INFO - 'NO_EM_RESTART': '1', 07:15:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:39 INFO - 'PWD': '/builds/slave/test', 07:15:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:15:39 INFO - 'RUST_BACKTRACE': '1', 07:15:39 INFO - 'SHELL': '/bin/bash', 07:15:39 INFO - 'SHLVL': '1', 07:15:39 INFO - 'TERM': 'linux', 07:15:39 INFO - 'TMOUT': '86400', 07:15:39 INFO - 'USER': 'cltbld', 07:15:39 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1490796870.317262-994131703', 07:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:39 INFO - '_': '/tools/buildbot/bin/python'} 07:15:39 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:15:40 INFO - mozversion application_buildid: 20170329134039 07:15:40 INFO - mozversion application_changeset: c4392f466eaab690d9b0ef7bacf72fa5e6573007 07:15:40 INFO - mozversion application_display_name: Nightly 07:15:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:15:40 INFO - mozversion application_name: Firefox 07:15:40 INFO - mozversion application_remotingname: firefox 07:15:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:15:40 INFO - mozversion application_vendor: Mozilla 07:15:40 INFO - mozversion application_version: 55.0a1 07:15:40 INFO - mozversion platform_buildid: 20170329134039 07:15:40 INFO - mozversion platform_changeset: c4392f466eaab690d9b0ef7bacf72fa5e6573007 07:15:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:15:40 INFO - mozversion platform_version: 55.0a1 07:15:40 INFO - using testdate: 1490796940 07:15:40 INFO - actual date: 1490796940 07:15:40 INFO - starting webserver on 'localhost:53938' 07:15:40 INFO - SUITE-START | Running 2 tests 07:15:40 INFO - TEST-START | dromaeo_css 07:15:40 INFO - operating with platform_type : linux_ 07:15:40 INFO - Initialising browser for dromaeo_css test... 07:15:40 INFO - TEST-INFO | started process 27298 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPEnKyp/profile http://localhost:53938/getInfo.html) 07:15:43 INFO - PID 27298 | __metrics Screen width/height:1600/1200 07:15:43 INFO - PID 27298 | colorDepth:24 07:15:43 INFO - PID 27298 | Browser inner width/height: 1024/697 07:15:43 INFO - PID 27298 | __metrics 07:15:44 ERROR - PID 27298 | 1490796944800 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 07:15:44 INFO - PID 27298 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:15:44 INFO - PID 27298 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:15:45 INFO - TEST-INFO | 27298: exit 0 07:15:45 INFO - Browser initialized. 07:15:45 INFO - Running cycle 1/1 for dromaeo_css test... 07:15:45 INFO - TEST-INFO | started process 27392 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPEnKyp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:15:57 INFO - PID 27392 | RSS: Main: 149377024 07:15:57 INFO - PID 27392 | 07:19:04 INFO - PID 27392 | Cycle 1(1): loaded http://localhost:53938/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53938/tests/dromaeo/cssquery-ext.html) 07:19:06 INFO - PID 27392 | RSS: Main: 267350016 07:19:06 INFO - PID 27392 | 07:20:47 INFO - PID 27392 | ************************* 07:20:47 INFO - PID 27392 | A coding exception was thrown and uncaught in a Task. 07:20:47 INFO - PID 27392 | 07:20:47 ERROR - PID 27392 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:20:47 INFO - PID 27392 | Full stack: 07:20:47 INFO - PID 27392 | ************************* 07:20:47 INFO - PID 27392 | ************************* 07:20:47 INFO - PID 27392 | A coding exception was thrown and uncaught in a Task. 07:20:47 INFO - PID 27392 | 07:20:47 ERROR - PID 27392 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:20:47 INFO - PID 27392 | Full stack: 07:20:47 INFO - PID 27392 | ************************* 07:20:47 INFO - PID 27392 | ************************* 07:20:47 INFO - PID 27392 | A coding exception was thrown and uncaught in a Task. 07:20:47 INFO - PID 27392 | 07:20:47 ERROR - PID 27392 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:20:47 INFO - PID 27392 | Full stack: 07:20:47 INFO - PID 27392 | ************************* 07:20:47 INFO - PID 27392 | ************************* 07:20:47 INFO - PID 27392 | A coding exception was thrown and uncaught in a Task. 07:20:47 INFO - PID 27392 | 07:20:47 ERROR - PID 27392 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:20:47 INFO - PID 27392 | Full stack: 07:20:47 INFO - PID 27392 | ************************* 07:22:09 INFO - PID 27392 | Cycle 1(1): loaded http://localhost:53938/tests/dromaeo/cssquery-ext.html (next: http://localhost:53938/tests/dromaeo/cssquery-jquery.html) 07:22:10 INFO - PID 27392 | RSS: Main: 232812544 07:22:10 INFO - PID 27392 | 07:25:12 INFO - PID 27392 | Cycle 1(1): loaded http://localhost:53938/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53938/tests/dromaeo/cssquery-mootools.html) 07:25:12 INFO - PID 27392 | RSS: Main: 199823360 07:25:12 INFO - PID 27392 | 07:28:15 INFO - PID 27392 | Cycle 1(1): loaded http://localhost:53938/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53938/tests/dromaeo/cssquery-prototype.html) 07:28:15 INFO - PID 27392 | RSS: Main: 228241408 07:28:15 INFO - PID 27392 | 07:31:19 INFO - PID 27392 | Cycle 1(1): loaded http://localhost:53938/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53938/tests/dromaeo/cssquery-yui.html) 07:31:19 INFO - PID 27392 | RSS: Main: 187777024 07:31:19 INFO - PID 27392 | 07:34:22 INFO - PID 27392 | Cycle 1(1): loaded http://localhost:53938/tests/dromaeo/cssquery-yui.html (next: http://localhost:53938/tests/dromaeo/cssquery-dojo.html) 07:34:22 INFO - PID 27392 | RSS: Main: 278347776 07:34:22 INFO - PID 27392 | 07:34:22 INFO - PID 27392 | __start_tp_report 07:34:22 INFO - PID 27392 | _x_x_mozilla_page_load 07:34:22 INFO - PID 27392 | _x_x_mozilla_page_load_details 07:34:22 INFO - PID 27392 | |i|pagename|runs| 07:34:22 INFO - PID 27392 | |0;dojo.html;2722.8230165039276;2733.316670832292;2767.4326763013582;2770.833749975002;2774.8335099894007;5226.320578324812;5315.654482458637;5331.2003199520095;5341.572674186065;5380.8923821523595;5333.759980800864;5338.866528336794;5354.22363757255;5400.162974738922;5407.945920540794;4740.312654665072;4834.806607735686;4845.3216549683075;4878.0731660984475;4953.430355509108;4854.320395144682;4872.561469467747;4888.364512613373;4915.8525244242555;4932.684130165553;4736.242201247784;4762.833300834454;4789.449213340476;4790.688605240648;4801.495842936476;4843.636727245471;4854.441739199967;4855.660103792736;4861.2222044473065;4865.902681946377;4795.760211989386;4796.688215265996;4817.349657796188;4831.154547954094;4871.318015477836;5192.091384007784;5204.089284375219;5264.947350526484;5298.92051619226;5300.469953004707;5664.631798933056;5713.542916566665;5734.455226753452;5753.309602847685;5766.596338256324;5568.248286481314;5637.943620563783;5645.068563686987;5705.6291341063115;5761.827145185651;5246.711430871263;5290.92063619046;5343.091674415281;5347.385050719139;5369;5752.654840709571;5910;5912.054071348563;5922.585419020627;5931.377205393372;5580.860478487989;5584.6090773646265;5605.159226116034;5650.773969041193;5657.20799088128;5580.441955804468;5653.067243904792;5719.656820590778;5738.454846789548;5745.1382292656435;5591.161325801081;5702.914456283159;5718.485336319751;5753.280839895013;5764.452377024176;5672.290963629546;5680.261565996477;5694.743736531866;5698.886022279531;5700.458456446631;4754.381930349033;4762.333273341735;4763.499832517605;4781.569658730731;4803.18345881201;3992.0419099416513;4038.313486707208;4054.5742697016976;4080.7347522410946;4085.4076158957378;4852.272159176152;4853.9029219416125;4855.6115510759055;4873.439554451284;4881.243407271879;5756.597038207369;5762.711864406847;5802;5810.883782324415;5816.418358164235;4730.432348118179;4762.119007983534;4790.329353890458;4793.041391721669;4793.113274044313;5046.091703493333;5133.743312834344;5152.124138896396;5156.587473002151;5169.870753231199;5324.8935021298585;5340.75966581497;5357.758900849393;5365.248865158959;5385.138377859524;5655.3213614364895;5790;5798.15926690619;5806.65160090396;5851.063829787214;5234.869128271824;5257.658252213594;5300.496452836975;5307.389650190123;5315.096433606219;5530.474604912527;5623.128415095667;5630.465105814941;5638.154276858504;5676.914846277392;5710.143478478261;5718.456746609066;5719.142128680731;5816.70916454184;5849.824505264849;5543.77824887;5547;5548.778048878161;5562.082256427644;5591.161325801162;5418.295621569171;5500.009998200362;5500.367457742411;5556.861078473071;5573.470520300565;5413.323334583177;5420;5446.346438427414;5453.2365468833605;5509.449055094618;5648.378678345461;5651.350094739158;5659.971700141473;5697.54419646419;5712.457316554921;5477.698726570077;5481.862953426196;5490.368607610176;5491.75287112073;5496.642718223303 07:34:22 INFO - PID 27392 | |1;ext.html;722.4364995303663;1070.7965486557553;1075.043211541728;1077.3643550305321;1188.3642251395506;32097.67902320976;32677.836610816943;32690.67309326906;32728.345433091323;32769.67230327699;30188.547171792387;30532.084037478857;30567.54148687766;30602.23494412641;30643.540346894813;5523.420040895709;6740.764073257449;6883;6885.965570172167;6897.3447522485285;5621.437856214367;6780.457563394916;6869.725210991554;6879.965600172017;6888.380045795878;6956.826079348006;7007.194172670132;7011.614361210131;7016.754413595525;7024.719011239545;5507.586930980193;6912.758053468129;6961.164660240804;6970.825729356756;6989.89515157273;5610.18652295419;6963.4777391695825;7073.398761105313;7079.787606371817;7107.1471423429;30678.846605767052;31029.844850775826;31034.37931241385;31088.222794430094;31108.37783244345;2612.3599718069195;2622.6362291608257;2623.4490756941063;2631.63157157998;2646.1532309660915;21802.89098554513;21840.23559175421;21983.34049978503;22063.11747530113;23214.187503437297;2927.780416468773;2972.1529364131334;3001.264690150905;3007.188059224019;3047.222958145681;164705;166072;166756.99999999878;166796;167010.1649491757;32367.35265294681;32863.342733145204;43805.56194438079;44247;44259.77870110629;39431;39907.20185596272;39997.60002399997;40022.39966400506;44025.779871100436;11717.414129293502;11837.763244735057;11838.704032399259;11838.763224735458;11848.644540663621;9181.403208791407;9211.76970575741;9267.119623635745;9268.304877134242;9290.628374865066;13347.199168049754;13397.866021339856;13413.39639716215;13514.121582097132;13579.45682172702;5444.646098003617;5525.585581081435;5532.1425179097305;5628.493435590816;5678.097837224576;852.9701460448855;880.1796042165406;880.5773228850188;885.5616469847466;919.9126083022102;20646;21222.78777212208;21232.575348492945;21434;21828.126874924827;940.9294302927308;945.8250223708636;952.1906379577442;959.7408699651055;981.8085473332632;10717.946410268054;10999.725006874893;11204.383758893338;11332.461148112836;11398.658040258806;242771;245046;245333;245416;246180;41389.793051034554;41758.164836703705;41858.790706046275;41884;41894.371584426255;1189.2151180221013;1242.9316387598587;1244.7199380139396;1247.650657815813;1253.8620751717303;19952.401427957186;20265.392038238875;21109.89445052765;21113.683294750284;21319.680204797252;30578;30601.08196754101;30617.54073688852;30661;30661.846690766404;198459.00770496056;198649;199258;199320;200066;22313;24368.6344704826;26566.203013909613;26662.733372666025;29784.255393615334;31356.372872542877;31408;32750.836245818617;33479.801842603956;34517.482237766955;25507.23478295654;25807.483850323264;26211.213663590122;26274.343141421617;26931.730682692923;25685.917689877333;25860;26135.73864261333;26571.60142597824;26721;27974.720252798026;28426.85786571054;28475.28811779722;28732.281692957844;28978.56532151977;24195.75804241935;24774.628380574668;25469.81627296588;25877.741222587534;26341.73658263393;19666;20583.279585214445;20816.47958801042;20867.791322086585;20926.790732092486 07:34:22 INFO - PID 27392 | |2;jquery.html;405.6025095406503;413.34691187923084;420.14500491499797;434.3181205507353;436.19521981943313;16962.745558816612;17685.204165812553;17708.291668333266;18222.180001899913;19139.712904306445;16828.495145145636;17307.740383894252;17817.732734009;17950.192241349137;18087.366942157027;5585.469380408865;5593.580481463907;5636.15457681347;5685.687287199203;5841.269841269841;5610.66336019838;5676.829695109153;5689;5703.0589952657765;5705.286839145107;5363.892722145555;5528.198411230389;5586.13414920686;5652.463016013472;5658;5583.6928968906695;5615.859603509904;5620.775168993236;5620.775168993236;5632.042552766019;5078.085944529983;5126.333576635051;5167.638265321429;5169.276301317818;5171.612129090333;22355.776442235532;22974.42563935915;23151.800578944974;23217.187398441143;23483.295501134995;1532.762421824619;1547.210922429569;1553.3786485405815;1573.6852629474151;1588.070978477592;13211.471541138342;14097.506587269396;14315.14109153454;14847.851521484756;14867.479638212611;1738.5914310137107;1749.0426397349224;1765.2674140231788;1799.1903643360408;1799.8830076045015;77643.61178194072;78136;78326;78851;79139.99999999942;10761;10799.67600971972;10951.616693415692;11017.268276938086;11268.436578171222;15681.294341754648;15731.292091855894;15731.764023539656;15764.211789410483;15780.368785248691;6790.287019862942;6987.755428559976;7093.822654433578;7155.391791697764;7223.699734047922;6096.786612468542;6233.532485063638;6382.5532212744665;6386.978083506617;6393.488520918316;6886.173659160932;6890.036339643278;6960.895586566206;7005.474589405815;7033.613151276627;1918.9712154317697;1960.7941166177632;1969.5863868587471;1971.4120301051948;2131.8720876747443;831.821158450936;854.3976496569903;871.6818361298081;872.9956350218208;875.4790899414838;16652.250648720837;16961.830381696025;17220.82779172217;17625.7356139658;17640.20619072145;856.3705676327894;874.3791907745444;877.359527544883;886.1891369397058;887.7514295997131;9175.58709858058;10900.182486313559;11997.880021199677;12036.338001410006;12202.32887191213;424125;427644;428292;430976;431353;86760.5661971686;91225;92686;94055.52972235232;94487.52756236175;1068.71144790906;1083.7182332593425;1083.7940791249637;1084.4686103809233;1094.8248280275118;17358.218880150675;17546.298148073933;17979.370722024665;18121.365752199137;18372;43448;43468.78265608778;43997.34003989879;44386.34466279045;44673.55326446694;50719.2392114126;52880;53093.469065308855;53314.4668553325;53709.73145134406;7663.501872378501;7692.115406728298;7811.296983271533;7842.019747531559;7995.84008319842;11583;11606.535738570363;11736.530538778354;11820.349880756641;12090.516379344728;9636.132748052709;10058.29591928558;10121.089101980857;10155.84766228522;10459.633912813015;9473.952630236805;9690.321677482509;10219.386836789816;10297.17622590176;10396.636117736145;10335.741606459898;10343.84484232722;10404.115650169517;10738.731531711457;10907.181961352771;7421.146568144733;7519.774406767806;7594.924050759421;7739.3034626883855;7859.685612575433;9574;9883.813942326968;10228.693139205836;10300.381977081399;10369.274150809371 07:34:22 INFO - PID 27392 | |3;mootools.html;1119.283658458587;1251.7809383357912;1306.5818937939857;1318.512150504313;1337.6120924931763;8311.625976831043;9607.66373176939;9845.21238300936;9854.507274636275;9875.65435209766;9501.762455938606;9598.328117031811;9601.903980960189;9619.470929098898;9621.134097931184;2165.2746329979436;2211.4360837986374;2211.7235345581803;2215.4350640586626;2219.7780221977832;1882.9246830126779;1950.658634738922;2149.9785002149933;2192.6162921488753;2209.4034610655112;2228.832837537183;2248.8875556222206;2250.9774902250933;2261.807746341563;2262.751097379287;2199.395166329264;2235.6311208650554;2249.9550008999727;2257.4582100295893;2272.9318120456414;2183.5196256823474;2201.8238540916686;2203.5923354179367;2206.558688262338;2211.281333566581;9828.803423931553;9850.162736167435;9923.354981926152;9965.103140717298;9990.9500452498;5249.527542521153;5440.455954404568;5458.344998600193;5463.399026107125;5476.151196564539;2934.4424559333656;3117;3170.5878235829196;3173.2066983254185;3179.682031796825;1033.4316126130598;1110.0952723530297;1124.578283143821;1128.5203788389902;1193.4271549656128;14580.125192488485;14621.6344591385;14713.852861471356;14743.77884331736;14762.926185369111;4622.208157594149;4838.758062096881;4947.90104197914;4952.504749525018;5062.392512898476;12259.877401226053;12269.38653067361;12299.631011069681;12460.875391246153;12480.313582752855;5178.145605974972;5250.868728281747;5256.1327380982475;5266.315379000705;5475.479829416199;4142.2543942090715;4711.905761884743;4746.501617330199;4754.168020596382;4923.409190897115;3521.6654417830264;3989.683404476516;4090.877273681794;4096.795160242035;4105.753654780723;1235;1276.7318863038681;1281.2120545864227;1291.3285091752236;1296.2028352563295;684.2268236892379;688.5317983771084;703.4829400390709;711.9394851437686;720.8882623193414;5601.591315734273;5678.630888992202;5688.459596338341;5817.592768506249;6099.085137229451;775.0931410250021;797.4139007829241;801.9157988411249;819.8934138561949;837.3134030095264;3704.49989251453;3854.7301688881507;3894.571597124314;3903.4925459690057;4026.7181297308907;12514.624561263177;13103;13145.408456619474;13147.67130821718;13173.670658233621;12753.808692869614;12844.614661560168;12981.610551683465;12983.935080324727;12991;8789.648414063493;8931.19619234272;9435.433873967446;9447.480388578557;9453.952730236304;5652.971735141298;5655.349634792052;5794.681292528783;5848.2689663792025;5866.911996319973;11644.941775291409;11652.359120248468;11702.70743231426;11709.063274938155;11855.52577896909;11473.311601303949;11968;11979.76040479203;12231.510739570318;12292.508299667914;8185.631646575799;8186.672533098847;8205.671773129247;8288.709895153881;8293.046299675614;7669.5398276103615;8251;9215.907840921773;9318.72043838686;9326.114019168168;7927.813395442217;7952.483088599222;8159.673613055649;8319.792005199919;8366.707165249187;7637;7969.242921922408;7969.6015199240965;8145.674173033012;8170.142135075969;6096.085587161784;6135.294441139326;6202.4417802398;6202.782902598387;6311.147995020613;5152.149895267239;5259.500347466985;5274.498922602346;5285.577153827761;5374.516293533601;5312.5484333832055;5334.279872217201;5340.172273297645;5445.754941027584;5523.8895222094525 07:34:22 INFO - PID 27392 | |4;prototype.html;374.81821316661416;394.78878799842084;398.86239247459616;398.98603548875775;402.0511592641367;5258.0535503609335;5348.973255133719;5378.762884536559;5379.327584051994;5384.7307634618255;5047.697138171703;5221.190715439113;5241.2179858847985;5250.159974404096;5283.392409872866;4257.40396344512;4263.976645605048;4267.357067528993;4268.807903644343;4287.078278170193;4272.081502476967;4285.078708077763;4285.164392943378;4294.549072347405;4299.914001719963;4052.5744796796353;4210.642095421893;4225.978870105645;4246.787660616972;4247.915041699164;4223.66210703143;4232.619064284198;4237.660987121023;4242.787860606973;4248.129133527619;3813.733038687293;3827.789471579062;3830;3836.079340958178;3844.596317386662;5063.949360506422;5139.717315547643;5148.61385396093;5185.792568297264;5198.324217851693;4838.758062096881;4907.877303067452;4927.728974906378;4948.208286674115;4957.206846904514;5577.8047768328315;5580.497755202051;5598.480683692314;5615.354234263071;5632.605717599769;4078.9184216315507;4213.852515161954;4228.809703563347;4240.491141063061;4258.48898132223;5607.299087614048;5711.428857114255;5808.651480911159;5842.357340692521;5886.087021717916;4328.891777705519;4342.978285108554;4353.172897149531;4375.518692943773;4385.605295523418;4444.8444304449185;4451.087527056946;4455.420795296591;4456.5766252205985;4457.732536047847;4592.931106033412;4748.0978614063215;4755.120302744003;4871.415430148405;4893.314935908976;5577.972110139423;5594.748236329294;5597.384287728347;5600.971995139998;5620.241267428926;1521.2621878388973;1529.495266562032;1553.223388305847;1555.2068445093084;1560.3992462901865;1094.600470828142;1103.6302838549016;1104.2546281260118;1106.1261603333437;1111.4776055254017;4782.976085119552;4822.42130944289;4838.395200599925;4850.563449289581;4855.562999330077;5751.338596061507;5756.107803290497;5759.65442073477;5778.670905691714;5793.7392817323325;4677.853925788204;4814.181589129857;4823.252395878644;4825.131476334293;4841.273808928689;3032.4238394704935;3045.4974929136442;3053.2366908272934;3053.4351145037795;3056.144279601715;5214.97392513035;5351.25082488452;5351.51836334724;5361.597880159004;5378.97310513445;5809.796657116981;5855.180274761537;5874.441928016831;5876.6180198286975;5904.586678932434;5314.562340445694;5319.361676598833;5323.414424413311;5341.332333458317;5345.81289654868;5521.420250873601;5701;5725.2843394575675;5734.197212390352;5736.627119237236;5356.7589458473685;5618.52242559387;5629.971850140723;5634.6337488063145;5652.463016013472;5110.386753589593;5250.18622113573;5276.103062479465;5290.206469029677;5326.840194794162;4269.380939763779;4360.345948107809;4362.978185109181;4375.1031038636365;4376.693631445768;5545.584081193846;5729.9713501432225;5737;5756.992526307963;5765.250517432707;5476.644018138808;5498.395176530498;5507.311586051744;5529.723513824212;5576.498115169492;5494.890102198014;5508.394076651485;5517.972410138084;5522.199281104297;5523.502884740393;5286.709230992333;5398.892022159614;5428.158635411518;5443.129099344086;5453.263809385682;5515.696636685021;5539.9169012464035;5554.416786237549;5567.137093750475;5571.8885622288135;5291.894162116813;5427.891442171055;5445.809396671098;5450.127979523258;5455.972720136374 07:34:22 INFO - PID 27392 | |5;yui.html;682.7576210445292;695.3950063444804;700.1912790726713;725.8620862036213;726.9963650181746;11703.824442633368;12037.699057523567;12056.035517158618;12215.022798176158;13458.663533411645;12683.492660293601;12703.110782245247;12709.682257943556;12911.354432278373;13348.399322030507;865.3726048614751;890.3366991591273;892.8080462700518;892.8749975003504;898.5866501409326;891.61660485991;900.7432881628737;902.6434558349448;905.108468158863;905.7237542549519;928.9814203715922;930.186087173723;932.435876294842;932.5337331334333;932.7201839448172;916.5600511754328;923.1968187676764;928.679605536089;929.1405449958795;929.2287401456774;682.2290811383106;683.0266869710642;690.6339639990813;691.0325544238107;692.3076923076923;12182.756344873053;12334;12525.311107889063;12531.749365012649;12688.80966785499;10365;10387.636432724817;10547.683569492927;10875.510602022849;11236.438178091144;9500.904990950141;9541.713748587554;9622.364198086341;9802.65690700822;9814.312998090136;2607.374230184761;2641.656584643984;2644.8148629595935;2723.360010397555;2738.698743138253;60234.39765602332;61438.692806535684;61622.69188654028;62302.065469018;62327.37672623261;8002.399820013406;8018.799530011796;8264.702210013735;8282.674772036566;8292.751217463485;16624.83375166257;16711.749323760152;16786.244618992176;16835.83164168367;16899.66200676004;6284.969038090078;6367.490600752021;6396.5522413431545;6426.164598602152;6462.870742585122;3290.1939024939043;3333.8166400848186;3388.9830550847087;3391.7117045050954;3463.549738534025;3231.5619549300804;3244.918877028046;3287.112479630486;3308.8676452942095;3320.867165313409;609.8993666045053;615.7136931326954;615.8737458820931;619.5632079384023;627.6108812536256;523.4346905342221;546.6173678425118;548.150366931255;550.2461627570254;561.3348182403864;7985.760427187193;8173.18268173178;8316.667333306721;8363.749087527383;8617.827643447095;534.9010433069894;545.3864402547134;558.7960394455994;565.6577770448819;566.334556895646;3741.2330472253125;3848.7113466490127;3909.4526766252748;3994.1013272013565;4000.2599519089063;45888;56489.43510564924;59937.70031149816;61154.08268875971;61999.07001394983;51758;54446;54460;54519.45480545223;55116.72441637766;47123.5287647126;48052;49268;49674.0065198694;50492;7492.175860655215;7774.378049755893;7775.57234352116;7843.098043725045;8309.37679674039;23672.526549469258;23721.051157953487;24449.633255501536;24881.50236995286;25244.368890777878;35141;36559.45160822643;37444.251114977;39993.00017499586;44877.77561112174;11332.546698131982;11659.766804664028;11898.821517677068;11925.0459963201;12161.57434489824;12609.614158163396;12812.743745125232;13013.739725205633;13379.464821407035;13403.32983350848;12299.69250768738;12560.811587826007;12705.745885082062;12836.679083022625;13229.272390018257;11805.328173835323;11909.642710718692;12155;12239.69400764988;12250.264984100982;11046.558137674403;11169.553217871195;11318.660440186808;11374.260673056226;11412.087033037504;8384.874226886725;8394;8474.904721917072;8478.872816907875;8642.43824151428;8886.022537520998;9887.802243955224;9930.453825039693;9941.801163976535;10015.298929074896 07:34:22 INFO - PID 27392 | __end_tp_report 07:34:22 INFO - PID 27392 | __start_cc_report 07:34:22 INFO - PID 27392 | _x_x_mozilla_cycle_collect,1609 07:34:22 INFO - PID 27392 | __end_cc_report 07:34:22 INFO - PID 27392 | __startTimestamp1490798062930__endTimestamp 07:34:22 INFO - PID 27392 | 07:34:22 INFO - PID 27392 | ------- Summary: start ------- 07:34:22 INFO - PID 27392 | Number of tests: 6 07:34:22 INFO - PID 27392 | 07:34:22 INFO - PID 27392 | [#0] dojo.html Cycles:165 Average:5243.78 Median:5385.14 stddev:609.04 (11.3%) stddev-sans-first:577.91 07:34:22 INFO - PID 27392 | Values: 2722.8 2733.3 2767.4 2770.8 2774.8 5226.3 5315.7 5331.2 5341.6 5380.9 5333.8 5338.9 5354.2 5400.2 5407.9 4740.3 4834.8 4845.3 4878.1 4953.4 4854.3 4872.6 4888.4 4915.9 4932.7 4736.2 4762.8 4789.4 4790.7 4801.5 4843.6 4854.4 4855.7 4861.2 4865.9 4795.8 4796.7 4817.3 4831.2 4871.3 5192.1 5204.1 5264.9 5298.9 5300.5 5664.6 5713.5 5734.5 5753.3 5766.6 5568.2 5637.9 5645.1 5705.6 5761.8 5246.7 5290.9 5343.1 5347.4 5369.0 5752.7 5910.0 5912.1 5922.6 5931.4 5580.9 5584.6 5605.2 5650.8 5657.2 5580.4 5653.1 5719.7 5738.5 5745.1 5591.2 5702.9 5718.5 5753.3 5764.5 5672.3 5680.3 5694.7 5698.9 5700.5 4754.4 4762.3 4763.5 4781.6 4803.2 3992.0 4038.3 4054.6 4080.7 4085.4 4852.3 4853.9 4855.6 4873.4 4881.2 5756.6 5762.7 5802.0 5810.9 5816.4 4730.4 4762.1 4790.3 4793.0 4793.1 5046.1 5133.7 5152.1 5156.6 5169.9 5324.9 5340.8 5357.8 5365.2 5385.1 5655.3 5790.0 5798.2 5806.7 5851.1 5234.9 5257.7 5300.5 5307.4 5315.1 5530.5 5623.1 5630.5 5638.2 5676.9 5710.1 5718.5 5719.1 5816.7 5849.8 5543.8 5547.0 5548.8 5562.1 5591.2 5418.3 5500.0 5500.4 5556.9 5573.5 5413.3 5420.0 5446.3 5453.2 5509.4 5648.4 5651.4 5660.0 5697.5 5712.5 5477.7 5481.9 5490.4 5491.8 5496.6 07:34:22 INFO - PID 27392 | 07:34:22 INFO - PID 27392 | [#1] ext.html Cycles:180 Average:33366.33 Median:16392.76 stddev:53716.07 (327.7%) stddev-sans-first:53810.84 07:34:22 INFO - PID 27392 | Values: 722.4 1070.8 1075.0 1077.4 1188.4 32097.7 32677.8 32690.7 32728.3 32769.7 30188.5 30532.1 30567.5 30602.2 30643.5 5523.4 6740.8 6883.0 6886.0 6897.3 5621.4 6780.5 6869.7 6880.0 6888.4 6956.8 7007.2 7011.6 7016.8 7024.7 5507.6 6912.8 6961.2 6970.8 6989.9 5610.2 6963.5 7073.4 7079.8 7107.1 30678.8 31029.8 31034.4 31088.2 31108.4 2612.4 2622.6 2623.4 2631.6 2646.2 21802.9 21840.2 21983.3 22063.1 23214.2 2927.8 2972.2 3001.3 3007.2 3047.2 164705.0 166072.0 166757.0 166796.0 167010.2 32367.4 32863.3 43805.6 44247.0 44259.8 39431.0 39907.2 39997.6 40022.4 44025.8 11717.4 11837.8 11838.7 11838.8 11848.6 9181.4 9211.8 9267.1 9268.3 9290.6 13347.2 13397.9 13413.4 13514.1 13579.5 5444.6 5525.6 5532.1 5628.5 5678.1 853.0 880.2 880.6 885.6 919.9 20646.0 21222.8 21232.6 21434.0 21828.1 940.9 945.8 952.2 959.7 981.8 10717.9 10999.7 11204.4 11332.5 11398.7 242771.0 245046.0 245333.0 245416.0 246180.0 41389.8 41758.2 41858.8 41884.0 41894.4 1189.2 1242.9 1244.7 1247.7 1253.9 19952.4 20265.4 21109.9 21113.7 21319.7 30578.0 30601.1 30617.5 30661.0 30661.8 198459.0 198649.0 199258.0 199320.0 200066.0 22313.0 24368.6 26566.2 26662.7 29784.3 31356.4 31408.0 32750.8 33479.8 34517.5 25507.2 25807.5 26211.2 26274.3 26931.7 25685.9 25860.0 26135.7 26571.6 26721.0 27974.7 28426.9 28475.3 28732.3 28978.6 24195.8 24774.6 25469.8 25877.7 26341.7 19666.0 20583.3 20816.5 20867.8 20926.8 07:34:22 INFO - PID 27392 | 07:34:22 INFO - PID 27392 | [#2] jquery.html Cycles:180 Average:26828.37 Median:431164.50 stddev:70997.65 (16.5%) stddev-sans-first:71169.10 07:34:22 INFO - PID 27392 | Values: 405.6 413.3 420.1 434.3 436.2 16962.7 17685.2 17708.3 18222.2 19139.7 16828.5 17307.7 17817.7 17950.2 18087.4 5585.5 5593.6 5636.2 5685.7 5841.3 5610.7 5676.8 5689.0 5703.1 5705.3 5363.9 5528.2 5586.1 5652.5 5658.0 5583.7 5615.9 5620.8 5620.8 5632.0 5078.1 5126.3 5167.6 5169.3 5171.6 22355.8 22974.4 23151.8 23217.2 23483.3 1532.8 1547.2 1553.4 1573.7 1588.1 13211.5 14097.5 14315.1 14847.9 14867.5 1738.6 1749.0 1765.3 1799.2 1799.9 77643.6 78136.0 78326.0 78851.0 79140.0 10761.0 10799.7 10951.6 11017.3 11268.4 15681.3 15731.3 15731.8 15764.2 15780.4 6790.3 6987.8 7093.8 7155.4 7223.7 6096.8 6233.5 6382.6 6387.0 6393.5 6886.2 6890.0 6960.9 7005.5 7033.6 1919.0 1960.8 1969.6 1971.4 2131.9 831.8 854.4 871.7 873.0 875.5 16652.3 16961.8 17220.8 17625.7 17640.2 856.4 874.4 877.4 886.2 887.8 9175.6 10900.2 11997.9 12036.3 12202.3 424125.0 427644.0 428292.0 430976.0 431353.0 86760.6 91225.0 92686.0 94055.5 94487.5 1068.7 1083.7 1083.8 1084.5 1094.8 17358.2 17546.3 17979.4 18121.4 18372.0 43448.0 43468.8 43997.3 44386.3 44673.6 50719.2 52880.0 53093.5 53314.5 53709.7 7663.5 7692.1 7811.3 7842.0 7995.8 11583.0 11606.5 11736.5 11820.3 12090.5 9636.1 10058.3 10121.1 10155.8 10459.6 9474.0 9690.3 10219.4 10297.2 10396.6 10335.7 10343.8 10404.1 10738.7 10907.2 7421.1 7519.8 7594.9 7739.3 7859.7 9574.0 9883.8 10228.7 10300.4 10369.3 07:34:22 INFO - PID 27392 | 07:34:22 INFO - PID 27392 | [#3] mootools.html Cycles:180 Average:6214.55 Median:4881.08 stddev:3993.09 (81.8%) stddev-sans-first:3985.93 07:34:22 INFO - PID 27392 | Values: 1119.3 1251.8 1306.6 1318.5 1337.6 8311.6 9607.7 9845.2 9854.5 9875.7 9501.8 9598.3 9601.9 9619.5 9621.1 2165.3 2211.4 2211.7 2215.4 2219.8 1882.9 1950.7 2150.0 2192.6 2209.4 2228.8 2248.9 2251.0 2261.8 2262.8 2199.4 2235.6 2250.0 2257.5 2272.9 2183.5 2201.8 2203.6 2206.6 2211.3 9828.8 9850.2 9923.4 9965.1 9991.0 5249.5 5440.5 5458.3 5463.4 5476.2 2934.4 3117.0 3170.6 3173.2 3179.7 1033.4 1110.1 1124.6 1128.5 1193.4 14580.1 14621.6 14713.9 14743.8 14762.9 4622.2 4838.8 4947.9 4952.5 5062.4 12259.9 12269.4 12299.6 12460.9 12480.3 5178.1 5250.9 5256.1 5266.3 5475.5 4142.3 4711.9 4746.5 4754.2 4923.4 3521.7 3989.7 4090.9 4096.8 4105.8 1235.0 1276.7 1281.2 1291.3 1296.2 684.2 688.5 703.5 711.9 720.9 5601.6 5678.6 5688.5 5817.6 6099.1 775.1 797.4 801.9 819.9 837.3 3704.5 3854.7 3894.6 3903.5 4026.7 12514.6 13103.0 13145.4 13147.7 13173.7 12753.8 12844.6 12981.6 12983.9 12991.0 8789.6 8931.2 9435.4 9447.5 9454.0 5653.0 5655.3 5794.7 5848.3 5866.9 11644.9 11652.4 11702.7 11709.1 11855.5 11473.3 11968.0 11979.8 12231.5 12292.5 8185.6 8186.7 8205.7 8288.7 8293.0 7669.5 8251.0 9215.9 9318.7 9326.1 7927.8 7952.5 8159.7 8319.8 8366.7 7637.0 7969.2 7969.6 8145.7 8170.1 6096.1 6135.3 6202.4 6202.8 6311.1 5152.1 5259.5 5274.5 5285.6 5374.5 5312.5 5334.3 5340.2 5445.8 5523.9 07:34:22 INFO - PID 27392 | 07:34:22 INFO - PID 27392 | [#4] prototype.html Cycles:180 Average:4671.51 Median:5192.06 stddev:1289.04 (24.8%) stddev-sans-first:1251.67 07:34:22 INFO - PID 27392 | Values: 374.8 394.8 398.9 399.0 402.1 5258.1 5349.0 5378.8 5379.3 5384.7 5047.7 5221.2 5241.2 5250.2 5283.4 4257.4 4264.0 4267.4 4268.8 4287.1 4272.1 4285.1 4285.2 4294.5 4299.9 4052.6 4210.6 4226.0 4246.8 4247.9 4223.7 4232.6 4237.7 4242.8 4248.1 3813.7 3827.8 3830.0 3836.1 3844.6 5063.9 5139.7 5148.6 5185.8 5198.3 4838.8 4907.9 4927.7 4948.2 4957.2 5577.8 5580.5 5598.5 5615.4 5632.6 4078.9 4213.9 4228.8 4240.5 4258.5 5607.3 5711.4 5808.7 5842.4 5886.1 4328.9 4343.0 4353.2 4375.5 4385.6 4444.8 4451.1 4455.4 4456.6 4457.7 4592.9 4748.1 4755.1 4871.4 4893.3 5578.0 5594.7 5597.4 5601.0 5620.2 1521.3 1529.5 1553.2 1555.2 1560.4 1094.6 1103.6 1104.3 1106.1 1111.5 4783.0 4822.4 4838.4 4850.6 4855.6 5751.3 5756.1 5759.7 5778.7 5793.7 4677.9 4814.2 4823.3 4825.1 4841.3 3032.4 3045.5 3053.2 3053.4 3056.1 5215.0 5351.3 5351.5 5361.6 5379.0 5809.8 5855.2 5874.4 5876.6 5904.6 5314.6 5319.4 5323.4 5341.3 5345.8 5521.4 5701.0 5725.3 5734.2 5736.6 5356.8 5618.5 5630.0 5634.6 5652.5 5110.4 5250.2 5276.1 5290.2 5326.8 4269.4 4360.3 4363.0 4375.1 4376.7 5545.6 5730.0 5737.0 5757.0 5765.3 5476.6 5498.4 5507.3 5529.7 5576.5 5494.9 5508.4 5518.0 5522.2 5523.5 5286.7 5398.9 5428.2 5443.1 5453.3 5515.7 5539.9 5554.4 5567.1 5571.9 5291.9 5427.9 5445.8 5450.1 5456.0 07:34:22 INFO - PID 27392 | 07:34:22 INFO - PID 27392 | [#5] yui.html Cycles:180 Average:13593.49 Median:54453.00 stddev:16735.65 (30.7%) stddev-sans-first:16754.52 07:34:22 INFO - PID 27392 | Values: 682.8 695.4 700.2 725.9 727.0 11703.8 12037.7 12056.0 12215.0 13458.7 12683.5 12703.1 12709.7 12911.4 13348.4 865.4 890.3 892.8 892.9 898.6 891.6 900.7 902.6 905.1 905.7 929.0 930.2 932.4 932.5 932.7 916.6 923.2 928.7 929.1 929.2 682.2 683.0 690.6 691.0 692.3 12182.8 12334.0 12525.3 12531.7 12688.8 10365.0 10387.6 10547.7 10875.5 11236.4 9500.9 9541.7 9622.4 9802.7 9814.3 2607.4 2641.7 2644.8 2723.4 2738.7 60234.4 61438.7 61622.7 62302.1 62327.4 8002.4 8018.8 8264.7 8282.7 8292.8 16624.8 16711.7 16786.2 16835.8 16899.7 6285.0 6367.5 6396.6 6426.2 6462.9 3290.2 3333.8 3389.0 3391.7 3463.5 3231.6 3244.9 3287.1 3308.9 3320.9 609.9 615.7 615.9 619.6 627.6 523.4 546.6 548.2 550.2 561.3 7985.8 8173.2 8316.7 8363.7 8617.8 534.9 545.4 558.8 565.7 566.3 3741.2 3848.7 3909.5 3994.1 4000.3 45888.0 56489.4 59937.7 61154.1 61999.1 51758.0 54446.0 54460.0 54519.5 55116.7 47123.5 48052.0 49268.0 49674.0 50492.0 7492.2 7774.4 7775.6 7843.1 8309.4 23672.5 23721.1 24449.6 24881.5 25244.4 35141.0 36559.5 37444.3 39993.0 44877.8 11332.5 11659.8 11898.8 11925.0 12161.6 12609.6 12812.7 13013.7 13379.5 13403.3 12299.7 12560.8 12705.7 12836.7 13229.3 11805.3 11909.6 12155.0 12239.7 12250.3 11046.6 11169.6 11318.7 11374.3 11412.1 8384.9 8394.0 8474.9 8478.9 8642.4 8886.0 9887.8 9930.5 9941.8 10015.3 07:34:22 INFO - PID 27392 | -------- Summary: end -------- 07:34:22 INFO - PID 27392 | 07:34:23 INFO - TEST-INFO | 27392: exit 0 07:34:23 INFO - TEST-OK | dromaeo_css | took 1123603ms 07:34:23 INFO - TEST-START | kraken 07:34:23 INFO - operating with platform_type : linux_ 07:34:23 INFO - Initialising browser for kraken test... 07:34:23 INFO - TEST-INFO | started process 27724 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEwVlvz/profile http://localhost:53938/getInfo.html) 07:34:27 INFO - PID 27724 | __metrics Screen width/height:1600/1200 07:34:27 INFO - PID 27724 | colorDepth:24 07:34:27 INFO - PID 27724 | Browser inner width/height: 1024/697 07:34:27 INFO - PID 27724 | __metrics 07:34:28 ERROR - PID 27724 | 1490798068330 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 07:34:28 INFO - PID 27724 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:34:28 INFO - PID 27724 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:34:29 INFO - TEST-INFO | 27724: exit 0 07:34:29 INFO - Browser initialized. 07:34:29 INFO - Running cycle 1/1 for kraken test... 07:34:29 INFO - TEST-INFO | started process 27817 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEwVlvz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:34:41 INFO - PID 27817 | RSS: Main: 150036480 07:34:41 INFO - PID 27817 | 07:34:44 INFO - PID 27817 | Cycle 1(1): loaded http://localhost:53938/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53938/tests/kraken/driver.html?testName=audio-beat-detection) 07:34:45 INFO - PID 27817 | RSS: Main: 204668928 07:34:45 INFO - PID 27817 | 07:34:48 INFO - PID 27817 | Cycle 1(1): loaded http://localhost:53938/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53938/tests/kraken/driver.html?testName=audio-dft) 07:34:48 INFO - PID 27817 | RSS: Main: 183930880 07:34:48 INFO - PID 27817 | 07:34:51 INFO - PID 27817 | Cycle 1(1): loaded http://localhost:53938/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53938/tests/kraken/driver.html?testName=audio-fft) 07:34:52 INFO - PID 27817 | RSS: Main: 267247616 07:34:52 INFO - PID 27817 | 07:34:54 INFO - PID 27817 | Cycle 1(1): loaded http://localhost:53938/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53938/tests/kraken/driver.html?testName=audio-oscillator) 07:34:55 INFO - PID 27817 | RSS: Main: 177639424 07:34:55 INFO - PID 27817 | 07:34:57 INFO - PID 27817 | Cycle 1(1): loaded http://localhost:53938/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53938/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:34:58 INFO - PID 27817 | RSS: Main: 180842496 07:34:58 INFO - PID 27817 | 07:35:01 INFO - PID 27817 | Cycle 1(1): loaded http://localhost:53938/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53938/tests/kraken/driver.html?testName=imaging-darkroom) 07:35:02 INFO - PID 27817 | RSS: Main: 219901952 07:35:02 INFO - PID 27817 | 07:35:05 INFO - PID 27817 | Cycle 1(1): loaded http://localhost:53938/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53938/tests/kraken/driver.html?testName=imaging-desaturate) 07:35:06 INFO - PID 27817 | RSS: Main: 214757376 07:35:06 INFO - PID 27817 | 07:35:09 INFO - PID 27817 | Cycle 1(1): loaded http://localhost:53938/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53938/tests/kraken/driver.html?testName=json-parse-financial) 07:35:09 INFO - PID 27817 | RSS: Main: 217010176 07:35:10 INFO - PID 27817 | 07:35:11 INFO - PID 27817 | Cycle 1(1): loaded http://localhost:53938/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53938/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:35:12 INFO - PID 27817 | RSS: Main: 180580352 07:35:12 INFO - PID 27817 | 07:35:14 INFO - PID 27817 | Cycle 1(1): loaded http://localhost:53938/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53938/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:35:14 INFO - PID 27817 | RSS: Main: 187879424 07:35:14 INFO - PID 27817 | 07:35:17 INFO - PID 27817 | Cycle 1(1): loaded http://localhost:53938/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53938/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:35:17 INFO - PID 27817 | RSS: Main: 196640768 07:35:17 INFO - PID 27817 | 07:35:20 INFO - PID 27817 | Cycle 1(1): loaded http://localhost:53938/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53938/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:35:21 INFO - PID 27817 | RSS: Main: 205926400 07:35:21 INFO - PID 27817 | 07:35:24 INFO - PID 27817 | Cycle 1(1): loaded http://localhost:53938/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53938/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:35:25 INFO - PID 27817 | RSS: Main: 193310720 07:35:25 INFO - PID 27817 | 07:35:27 INFO - PID 27817 | Cycle 1(1): loaded http://localhost:53938/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53938/tests/kraken/driver.html?testName=ai-astar) 07:35:27 INFO - PID 27817 | RSS: Main: 266850304 07:35:27 INFO - PID 27817 | 07:35:27 INFO - PID 27817 | __start_tp_report 07:35:27 INFO - PID 27817 | _x_x_mozilla_page_load 07:35:27 INFO - PID 27817 | _x_x_mozilla_page_load_details 07:35:27 INFO - PID 27817 | |i|pagename|runs| 07:35:27 INFO - PID 27817 | |0;ai-astar;103;116;118;115;116;114;121;126;117;113 07:35:27 INFO - PID 27817 | |1;audio-beat-detection;149;127;127;167;127;132;125;126;151;134 07:35:27 INFO - PID 27817 | |2;audio-dft;166;167;166;170;169;165;165;166;167;166 07:35:27 INFO - PID 27817 | |3;audio-fft;75;77;76;110;76;80;77;76;94;77 07:35:27 INFO - PID 27817 | |4;audio-oscillator;86;85;108;86;87;86;104;85;86;102 07:35:27 INFO - PID 27817 | |5;imaging-gaussian-blur;114;114;114;114;114;115;114;116;116;115 07:35:27 INFO - PID 27817 | |6;imaging-darkroom;153;151;153;152;150;152;151;151;151;152 07:35:27 INFO - PID 27817 | |7;imaging-desaturate;96;96;96;95;96;95;95;94;95;96 07:35:27 INFO - PID 27817 | |8;json-parse-financial;68;68;66;69;68;69;69;70;70;69 07:35:27 INFO - PID 27817 | |9;json-stringify-tinderbox;57;56;57;57;57;56;57;63;56;57 07:35:27 INFO - PID 27817 | |10;stanford-crypto-aes;85;85;85;85;85;84;83;85;85;86 07:35:27 INFO - PID 27817 | |11;stanford-crypto-ccm;141;145;146;150;135;135;143;135;186;137 07:35:27 INFO - PID 27817 | |12;stanford-crypto-pbkdf2;198;201;197;191;196;202;199;203;207;186 07:35:27 INFO - PID 27817 | |13;stanford-crypto-sha256-iterative;73;74;74;76;73;74;72;73;72;78 07:35:27 INFO - PID 27817 | __end_tp_report 07:35:27 INFO - PID 27817 | __start_cc_report 07:35:27 INFO - PID 27817 | _x_x_mozilla_cycle_collect,2021 07:35:27 INFO - PID 27817 | __end_cc_report 07:35:27 INFO - PID 27817 | __startTimestamp1490798127519__endTimestamp 07:35:27 INFO - PID 27817 | 07:35:27 INFO - PID 27817 | ------- Summary: start ------- 07:35:27 INFO - PID 27817 | Number of tests: 14 07:35:27 INFO - PID 27817 | 07:35:27 INFO - PID 27817 | [#0] ai-astar Cycles:10 Average:115.90 Median:116.50 stddev:5.90 (5.1%) stddev-sans-first:4.00 07:35:27 INFO - PID 27817 | Values: 103.0 116.0 118.0 115.0 116.0 114.0 121.0 126.0 117.0 113.0 07:35:27 INFO - PID 27817 | 07:35:27 INFO - PID 27817 | [#1] audio-beat-detection Cycles:10 Average:136.50 Median:133.00 stddev:14.28 (10.7%) stddev-sans-first:14.42 07:35:27 INFO - PID 27817 | Values: 149.0 127.0 127.0 167.0 127.0 132.0 125.0 126.0 151.0 134.0 07:35:27 INFO - PID 27817 | 07:35:27 INFO - PID 27817 | [#2] audio-dft Cycles:10 Average:166.70 Median:166.50 stddev:1.64 (1.0%) stddev-sans-first:1.72 07:35:27 INFO - PID 27817 | Values: 166.0 167.0 166.0 170.0 169.0 165.0 165.0 166.0 167.0 166.0 07:35:27 INFO - PID 27817 | 07:35:27 INFO - PID 27817 | [#3] audio-fft Cycles:10 Average:81.80 Median:77.00 stddev:11.37 (14.8%) stddev-sans-first:11.79 07:35:27 INFO - PID 27817 | Values: 75.0 77.0 76.0 110.0 76.0 80.0 77.0 76.0 94.0 77.0 07:35:27 INFO - PID 27817 | 07:35:27 INFO - PID 27817 | [#4] audio-oscillator Cycles:10 Average:91.50 Median:86.00 stddev:9.22 (10.7%) stddev-sans-first:9.56 07:35:27 INFO - PID 27817 | Values: 86.0 85.0 108.0 86.0 87.0 86.0 104.0 85.0 86.0 102.0 07:35:27 INFO - PID 27817 | 07:35:27 INFO - PID 27817 | [#5] imaging-gaussian-blur Cycles:10 Average:114.60 Median:114.50 stddev:0.84 (0.7%) stddev-sans-first:0.87 07:35:27 INFO - PID 27817 | Values: 114.0 114.0 114.0 114.0 114.0 115.0 114.0 116.0 116.0 115.0 07:35:27 INFO - PID 27817 | 07:35:27 INFO - PID 27817 | [#6] imaging-darkroom Cycles:10 Average:151.60 Median:152.00 stddev:0.97 (0.6%) stddev-sans-first:0.88 07:35:27 INFO - PID 27817 | Values: 153.0 151.0 153.0 152.0 150.0 152.0 151.0 151.0 151.0 152.0 07:35:27 INFO - PID 27817 | 07:35:27 INFO - PID 27817 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 07:35:27 INFO - PID 27817 | Values: 96.0 96.0 96.0 95.0 96.0 95.0 95.0 94.0 95.0 96.0 07:35:27 INFO - PID 27817 | 07:35:27 INFO - PID 27817 | [#8] json-parse-financial Cycles:10 Average:68.60 Median:69.00 stddev:1.17 (1.7%) stddev-sans-first:1.22 07:35:27 INFO - PID 27817 | Values: 68.0 68.0 66.0 69.0 68.0 69.0 69.0 70.0 70.0 69.0 07:35:27 INFO - PID 27817 | 07:35:27 INFO - PID 27817 | [#9] json-stringify-tinderbox Cycles:10 Average:57.30 Median:57.00 stddev:2.06 (3.6%) stddev-sans-first:2.18 07:35:27 INFO - PID 27817 | Values: 57.0 56.0 57.0 57.0 57.0 56.0 57.0 63.0 56.0 57.0 07:35:27 INFO - PID 27817 | 07:35:27 INFO - PID 27817 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:85.00 stddev:0.79 (0.9%) stddev-sans-first:0.83 07:35:27 INFO - PID 27817 | Values: 85.0 85.0 85.0 85.0 85.0 84.0 83.0 85.0 85.0 86.0 07:35:27 INFO - PID 27817 | 07:35:27 INFO - PID 27817 | [#11] stanford-crypto-ccm Cycles:10 Average:145.30 Median:144.00 stddev:15.24 (10.6%) stddev-sans-first:16.08 07:35:27 INFO - PID 27817 | Values: 141.0 145.0 146.0 150.0 135.0 135.0 143.0 135.0 186.0 137.0 07:35:27 INFO - PID 27817 | 07:35:27 INFO - PID 27817 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:198.00 Median:200.00 stddev:6.06 (3.0%) stddev-sans-first:6.42 07:35:27 INFO - PID 27817 | Values: 198.0 201.0 197.0 191.0 196.0 202.0 199.0 203.0 207.0 186.0 07:35:27 INFO - PID 27817 | 07:35:27 INFO - PID 27817 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.90 Median:74.00 stddev:1.85 (2.5%) stddev-sans-first:1.94 07:35:27 INFO - PID 27817 | Values: 73.0 74.0 74.0 76.0 73.0 74.0 72.0 73.0 72.0 78.0 07:35:27 INFO - PID 27817 | -------- Summary: end -------- 07:35:27 INFO - PID 27817 | 07:35:28 INFO - TEST-INFO | 27817: exit 0 07:35:28 INFO - TEST-OK | kraken | took 65015ms 07:35:28 INFO - SUITE-END | took 1188s 07:35:29 INFO - Completed test suite (00:19:49) 07:35:29 INFO - javascript benchmark 07:35:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6571.718366376053, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2722.8230165039276, 2733.316670832292, 2767.4326763013582, 2770.833749975002, 2774.8335099894007, 5226.320578324812, 5315.654482458637, 5331.2003199520095, 5341.572674186065, 5380.8923821523595, 5333.759980800864, 5338.866528336794, 5354.22363757255, 5400.162974738922, 5407.945920540794, 4740.312654665072, 4834.806607735686, 4845.3216549683075, 4878.0731660984475, 4953.430355509108, 4854.320395144682, 4872.561469467747, 4888.364512613373, 4915.8525244242555, 4932.684130165553, 4736.242201247784, 4762.833300834454, 4789.449213340476, 4790.688605240648, 4801.495842936476, 4843.636727245471, 4854.441739199967, 4855.660103792736, 4861.2222044473065, 4865.902681946377, 4795.760211989386, 4796.688215265996, 4817.349657796188, 4831.154547954094, 4871.318015477836, 5192.091384007784, 5204.089284375219, 5264.947350526484, 5298.92051619226, 5300.469953004707, 5664.631798933056, 5713.542916566665, 5734.455226753452, 5753.309602847685, 5766.596338256324, 5568.248286481314, 5637.943620563783, 5645.068563686987, 5705.6291341063115, 5761.827145185651, 5246.711430871263, 5290.92063619046, 5343.091674415281, 5347.385050719139, 5369.0, 5752.654840709571, 5910.0, 5912.054071348563, 5922.585419020627, 5931.377205393372, 5580.860478487989, 5584.6090773646265, 5605.159226116034, 5650.773969041193, 5657.20799088128, 5580.441955804468, 5653.067243904792, 5719.656820590778, 5738.454846789548, 5745.1382292656435, 5591.161325801081, 5702.914456283159, 5718.485336319751, 5753.280839895013, 5764.452377024176, 5672.290963629546, 5680.261565996477, 5694.743736531866, 5698.886022279531, 5700.458456446631, 4754.381930349033, 4762.333273341735, 4763.499832517605, 4781.569658730731, 4803.18345881201, 3992.0419099416513, 4038.313486707208, 4054.5742697016976, 4080.7347522410946, 4085.4076158957378, 4852.272159176152, 4853.9029219416125, 4855.6115510759055, 4873.439554451284, 4881.243407271879, 5756.597038207369, 5762.711864406847, 5802.0, 5810.883782324415, 5816.418358164235, 4730.432348118179, 4762.119007983534, 4790.329353890458, 4793.041391721669, 4793.113274044313, 5046.091703493333, 5133.743312834344, 5152.124138896396, 5156.587473002151, 5169.870753231199, 5324.8935021298585, 5340.75966581497, 5357.758900849393, 5365.248865158959, 5385.138377859524, 5655.3213614364895, 5790.0, 5798.15926690619, 5806.65160090396, 5851.063829787214, 5234.869128271824, 5257.658252213594, 5300.496452836975, 5307.389650190123, 5315.096433606219, 5530.474604912527, 5623.128415095667, 5630.465105814941, 5638.154276858504, 5676.914846277392, 5710.143478478261, 5718.456746609066, 5719.142128680731, 5816.70916454184, 5849.824505264849, 5543.77824887, 5547.0, 5548.778048878161, 5562.082256427644, 5591.161325801162, 5418.295621569171, 5500.009998200362, 5500.367457742411, 5556.861078473071, 5573.470520300565, 5413.323334583177, 5420.0, 5446.346438427414, 5453.2365468833605, 5509.449055094618, 5648.378678345461, 5651.350094739158, 5659.971700141473, 5697.54419646419, 5712.457316554921, 5477.698726570077, 5481.862953426196, 5490.368607610176, 5491.75287112073, 5496.642718223303], "value": 5199.517028072073, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.4364995303663, 1070.7965486557553, 1075.043211541728, 1077.3643550305321, 1188.3642251395506, 32097.67902320976, 32677.836610816943, 32690.67309326906, 32728.345433091323, 32769.67230327699, 30188.547171792387, 30532.084037478857, 30567.54148687766, 30602.23494412641, 30643.540346894813, 5523.420040895709, 6740.764073257449, 6883.0, 6885.965570172167, 6897.3447522485285, 5621.437856214367, 6780.457563394916, 6869.725210991554, 6879.965600172017, 6888.380045795878, 6956.826079348006, 7007.194172670132, 7011.614361210131, 7016.754413595525, 7024.719011239545, 5507.586930980193, 6912.758053468129, 6961.164660240804, 6970.825729356756, 6989.89515157273, 5610.18652295419, 6963.4777391695825, 7073.398761105313, 7079.787606371817, 7107.1471423429, 30678.846605767052, 31029.844850775826, 31034.37931241385, 31088.222794430094, 31108.37783244345, 2612.3599718069195, 2622.6362291608257, 2623.4490756941063, 2631.63157157998, 2646.1532309660915, 21802.89098554513, 21840.23559175421, 21983.34049978503, 22063.11747530113, 23214.187503437297, 2927.780416468773, 2972.1529364131334, 3001.264690150905, 3007.188059224019, 3047.222958145681, 164705.0, 166072.0, 166756.99999999878, 166796.0, 167010.1649491757, 32367.35265294681, 32863.342733145204, 43805.56194438079, 44247.0, 44259.77870110629, 39431.0, 39907.20185596272, 39997.60002399997, 40022.39966400506, 44025.779871100436, 11717.414129293502, 11837.763244735057, 11838.704032399259, 11838.763224735458, 11848.644540663621, 9181.403208791407, 9211.76970575741, 9267.119623635745, 9268.304877134242, 9290.628374865066, 13347.199168049754, 13397.866021339856, 13413.39639716215, 13514.121582097132, 13579.45682172702, 5444.646098003617, 5525.585581081435, 5532.1425179097305, 5628.493435590816, 5678.097837224576, 852.9701460448855, 880.1796042165406, 880.5773228850188, 885.5616469847466, 919.9126083022102, 20646.0, 21222.78777212208, 21232.575348492945, 21434.0, 21828.126874924827, 940.9294302927308, 945.8250223708636, 952.1906379577442, 959.7408699651055, 981.8085473332632, 10717.946410268054, 10999.725006874893, 11204.383758893338, 11332.461148112836, 11398.658040258806, 242771.0, 245046.0, 245333.0, 245416.0, 246180.0, 41389.793051034554, 41758.164836703705, 41858.790706046275, 41884.0, 41894.371584426255, 1189.2151180221013, 1242.9316387598587, 1244.7199380139396, 1247.650657815813, 1253.8620751717303, 19952.401427957186, 20265.392038238875, 21109.89445052765, 21113.683294750284, 21319.680204797252, 30578.0, 30601.08196754101, 30617.54073688852, 30661.0, 30661.846690766404, 198459.00770496056, 198649.0, 199258.0, 199320.0, 200066.0, 22313.0, 24368.6344704826, 26566.203013909613, 26662.733372666025, 29784.255393615334, 31356.372872542877, 31408.0, 32750.836245818617, 33479.801842603956, 34517.482237766955, 25507.23478295654, 25807.483850323264, 26211.213663590122, 26274.343141421617, 26931.730682692923, 25685.917689877333, 25860.0, 26135.73864261333, 26571.60142597824, 26721.0, 27974.720252798026, 28426.85786571054, 28475.28811779722, 28732.281692957844, 28978.56532151977, 24195.75804241935, 24774.628380574668, 25469.81627296588, 25877.741222587534, 26341.73658263393, 19666.0, 20583.279585214445, 20816.47958801042, 20867.791322086585, 20926.790732092486], "value": 14364.335423613025, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.6025095406503, 413.34691187923084, 420.14500491499797, 434.3181205507353, 436.19521981943313, 16962.745558816612, 17685.204165812553, 17708.291668333266, 18222.180001899913, 19139.712904306445, 16828.495145145636, 17307.740383894252, 17817.732734009, 17950.192241349137, 18087.366942157027, 5585.469380408865, 5593.580481463907, 5636.15457681347, 5685.687287199203, 5841.269841269841, 5610.66336019838, 5676.829695109153, 5689.0, 5703.0589952657765, 5705.286839145107, 5363.892722145555, 5528.198411230389, 5586.13414920686, 5652.463016013472, 5658.0, 5583.6928968906695, 5615.859603509904, 5620.775168993236, 5620.775168993236, 5632.042552766019, 5078.085944529983, 5126.333576635051, 5167.638265321429, 5169.276301317818, 5171.612129090333, 22355.776442235532, 22974.42563935915, 23151.800578944974, 23217.187398441143, 23483.295501134995, 1532.762421824619, 1547.210922429569, 1553.3786485405815, 1573.6852629474151, 1588.070978477592, 13211.471541138342, 14097.506587269396, 14315.14109153454, 14847.851521484756, 14867.479638212611, 1738.5914310137107, 1749.0426397349224, 1765.2674140231788, 1799.1903643360408, 1799.8830076045015, 77643.61178194072, 78136.0, 78326.0, 78851.0, 79139.99999999942, 10761.0, 10799.67600971972, 10951.616693415692, 11017.268276938086, 11268.436578171222, 15681.294341754648, 15731.292091855894, 15731.764023539656, 15764.211789410483, 15780.368785248691, 6790.287019862942, 6987.755428559976, 7093.822654433578, 7155.391791697764, 7223.699734047922, 6096.786612468542, 6233.532485063638, 6382.5532212744665, 6386.978083506617, 6393.488520918316, 6886.173659160932, 6890.036339643278, 6960.895586566206, 7005.474589405815, 7033.613151276627, 1918.9712154317697, 1960.7941166177632, 1969.5863868587471, 1971.4120301051948, 2131.8720876747443, 831.821158450936, 854.3976496569903, 871.6818361298081, 872.9956350218208, 875.4790899414838, 16652.250648720837, 16961.830381696025, 17220.82779172217, 17625.7356139658, 17640.20619072145, 856.3705676327894, 874.3791907745444, 877.359527544883, 886.1891369397058, 887.7514295997131, 9175.58709858058, 10900.182486313559, 11997.880021199677, 12036.338001410006, 12202.32887191213, 424125.0, 427644.0, 428292.0, 430976.0, 431353.0, 86760.5661971686, 91225.0, 92686.0, 94055.52972235232, 94487.52756236175, 1068.71144790906, 1083.7182332593425, 1083.7940791249637, 1084.4686103809233, 1094.8248280275118, 17358.218880150675, 17546.298148073933, 17979.370722024665, 18121.365752199137, 18372.0, 43448.0, 43468.78265608778, 43997.34003989879, 44386.34466279045, 44673.55326446694, 50719.2392114126, 52880.0, 53093.469065308855, 53314.4668553325, 53709.73145134406, 7663.501872378501, 7692.115406728298, 7811.296983271533, 7842.019747531559, 7995.84008319842, 11583.0, 11606.535738570363, 11736.530538778354, 11820.349880756641, 12090.516379344728, 9636.132748052709, 10058.29591928558, 10121.089101980857, 10155.84766228522, 10459.633912813015, 9473.952630236805, 9690.321677482509, 10219.386836789816, 10297.17622590176, 10396.636117736145, 10335.741606459898, 10343.84484232722, 10404.115650169517, 10738.731531711457, 10907.181961352771, 7421.146568144733, 7519.774406767806, 7594.924050759421, 7739.3034626883855, 7859.685612575433, 9574.0, 9883.813942326968, 10228.693139205836, 10300.381977081399, 10369.274150809371], "value": 8802.886253273271, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1119.283658458587, 1251.7809383357912, 1306.5818937939857, 1318.512150504313, 1337.6120924931763, 8311.625976831043, 9607.66373176939, 9845.21238300936, 9854.507274636275, 9875.65435209766, 9501.762455938606, 9598.328117031811, 9601.903980960189, 9619.470929098898, 9621.134097931184, 2165.2746329979436, 2211.4360837986374, 2211.7235345581803, 2215.4350640586626, 2219.7780221977832, 1882.9246830126779, 1950.658634738922, 2149.9785002149933, 2192.6162921488753, 2209.4034610655112, 2228.832837537183, 2248.8875556222206, 2250.9774902250933, 2261.807746341563, 2262.751097379287, 2199.395166329264, 2235.6311208650554, 2249.9550008999727, 2257.4582100295893, 2272.9318120456414, 2183.5196256823474, 2201.8238540916686, 2203.5923354179367, 2206.558688262338, 2211.281333566581, 9828.803423931553, 9850.162736167435, 9923.354981926152, 9965.103140717298, 9990.9500452498, 5249.527542521153, 5440.455954404568, 5458.344998600193, 5463.399026107125, 5476.151196564539, 2934.4424559333656, 3117.0, 3170.5878235829196, 3173.2066983254185, 3179.682031796825, 1033.4316126130598, 1110.0952723530297, 1124.578283143821, 1128.5203788389902, 1193.4271549656128, 14580.125192488485, 14621.6344591385, 14713.852861471356, 14743.77884331736, 14762.926185369111, 4622.208157594149, 4838.758062096881, 4947.90104197914, 4952.504749525018, 5062.392512898476, 12259.877401226053, 12269.38653067361, 12299.631011069681, 12460.875391246153, 12480.313582752855, 5178.145605974972, 5250.868728281747, 5256.1327380982475, 5266.315379000705, 5475.479829416199, 4142.2543942090715, 4711.905761884743, 4746.501617330199, 4754.168020596382, 4923.409190897115, 3521.6654417830264, 3989.683404476516, 4090.877273681794, 4096.795160242035, 4105.753654780723, 1235.0, 1276.7318863038681, 1281.2120545864227, 1291.3285091752236, 1296.2028352563295, 684.2268236892379, 688.5317983771084, 703.4829400390709, 711.9394851437686, 720.8882623193414, 5601.591315734273, 5678.630888992202, 5688.459596338341, 5817.592768506249, 6099.085137229451, 775.0931410250021, 797.4139007829241, 801.9157988411249, 819.8934138561949, 837.3134030095264, 3704.49989251453, 3854.7301688881507, 3894.571597124314, 3903.4925459690057, 4026.7181297308907, 12514.624561263177, 13103.0, 13145.408456619474, 13147.67130821718, 13173.670658233621, 12753.808692869614, 12844.614661560168, 12981.610551683465, 12983.935080324727, 12991.0, 8789.648414063493, 8931.19619234272, 9435.433873967446, 9447.480388578557, 9453.952730236304, 5652.971735141298, 5655.349634792052, 5794.681292528783, 5848.2689663792025, 5866.911996319973, 11644.941775291409, 11652.359120248468, 11702.70743231426, 11709.063274938155, 11855.52577896909, 11473.311601303949, 11968.0, 11979.76040479203, 12231.510739570318, 12292.508299667914, 8185.631646575799, 8186.672533098847, 8205.671773129247, 8288.709895153881, 8293.046299675614, 7669.5398276103615, 8251.0, 9215.907840921773, 9318.72043838686, 9326.114019168168, 7927.813395442217, 7952.483088599222, 8159.673613055649, 8319.792005199919, 8366.707165249187, 7637.0, 7969.242921922408, 7969.6015199240965, 8145.674173033012, 8170.142135075969, 6096.085587161784, 6135.294441139326, 6202.4417802398, 6202.782902598387, 6311.147995020613, 5152.149895267239, 5259.500347466985, 5274.498922602346, 5285.577153827761, 5374.516293533601, 5312.5484333832055, 5334.279872217201, 5340.172273297645, 5445.754941027584, 5523.8895222094525], "value": 4701.664798307715, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.81821316661416, 394.78878799842084, 398.86239247459616, 398.98603548875775, 402.0511592641367, 5258.0535503609335, 5348.973255133719, 5378.762884536559, 5379.327584051994, 5384.7307634618255, 5047.697138171703, 5221.190715439113, 5241.2179858847985, 5250.159974404096, 5283.392409872866, 4257.40396344512, 4263.976645605048, 4267.357067528993, 4268.807903644343, 4287.078278170193, 4272.081502476967, 4285.078708077763, 4285.164392943378, 4294.549072347405, 4299.914001719963, 4052.5744796796353, 4210.642095421893, 4225.978870105645, 4246.787660616972, 4247.915041699164, 4223.66210703143, 4232.619064284198, 4237.660987121023, 4242.787860606973, 4248.129133527619, 3813.733038687293, 3827.789471579062, 3830.0, 3836.079340958178, 3844.596317386662, 5063.949360506422, 5139.717315547643, 5148.61385396093, 5185.792568297264, 5198.324217851693, 4838.758062096881, 4907.877303067452, 4927.728974906378, 4948.208286674115, 4957.206846904514, 5577.8047768328315, 5580.497755202051, 5598.480683692314, 5615.354234263071, 5632.605717599769, 4078.9184216315507, 4213.852515161954, 4228.809703563347, 4240.491141063061, 4258.48898132223, 5607.299087614048, 5711.428857114255, 5808.651480911159, 5842.357340692521, 5886.087021717916, 4328.891777705519, 4342.978285108554, 4353.172897149531, 4375.518692943773, 4385.605295523418, 4444.8444304449185, 4451.087527056946, 4455.420795296591, 4456.5766252205985, 4457.732536047847, 4592.931106033412, 4748.0978614063215, 4755.120302744003, 4871.415430148405, 4893.314935908976, 5577.972110139423, 5594.748236329294, 5597.384287728347, 5600.971995139998, 5620.241267428926, 1521.2621878388973, 1529.495266562032, 1553.223388305847, 1555.2068445093084, 1560.3992462901865, 1094.600470828142, 1103.6302838549016, 1104.2546281260118, 1106.1261603333437, 1111.4776055254017, 4782.976085119552, 4822.42130944289, 4838.395200599925, 4850.563449289581, 4855.562999330077, 5751.338596061507, 5756.107803290497, 5759.65442073477, 5778.670905691714, 5793.7392817323325, 4677.853925788204, 4814.181589129857, 4823.252395878644, 4825.131476334293, 4841.273808928689, 3032.4238394704935, 3045.4974929136442, 3053.2366908272934, 3053.4351145037795, 3056.144279601715, 5214.97392513035, 5351.25082488452, 5351.51836334724, 5361.597880159004, 5378.97310513445, 5809.796657116981, 5855.180274761537, 5874.441928016831, 5876.6180198286975, 5904.586678932434, 5314.562340445694, 5319.361676598833, 5323.414424413311, 5341.332333458317, 5345.81289654868, 5521.420250873601, 5701.0, 5725.2843394575675, 5734.197212390352, 5736.627119237236, 5356.7589458473685, 5618.52242559387, 5629.971850140723, 5634.6337488063145, 5652.463016013472, 5110.386753589593, 5250.18622113573, 5276.103062479465, 5290.206469029677, 5326.840194794162, 4269.380939763779, 4360.345948107809, 4362.978185109181, 4375.1031038636365, 4376.693631445768, 5545.584081193846, 5729.9713501432225, 5737.0, 5756.992526307963, 5765.250517432707, 5476.644018138808, 5498.395176530498, 5507.311586051744, 5529.723513824212, 5576.498115169492, 5494.890102198014, 5508.394076651485, 5517.972410138084, 5522.199281104297, 5523.502884740393, 5286.709230992333, 5398.892022159614, 5428.158635411518, 5443.129099344086, 5453.263809385682, 5515.696636685021, 5539.9169012464035, 5554.416786237549, 5567.137093750475, 5571.8885622288135, 5291.894162116813, 5427.891442171055, 5445.809396671098, 5450.127979523258, 5455.972720136374], "value": 4288.010305205903, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [682.7576210445292, 695.3950063444804, 700.1912790726713, 725.8620862036213, 726.9963650181746, 11703.824442633368, 12037.699057523567, 12056.035517158618, 12215.022798176158, 13458.663533411645, 12683.492660293601, 12703.110782245247, 12709.682257943556, 12911.354432278373, 13348.399322030507, 865.3726048614751, 890.3366991591273, 892.8080462700518, 892.8749975003504, 898.5866501409326, 891.61660485991, 900.7432881628737, 902.6434558349448, 905.108468158863, 905.7237542549519, 928.9814203715922, 930.186087173723, 932.435876294842, 932.5337331334333, 932.7201839448172, 916.5600511754328, 923.1968187676764, 928.679605536089, 929.1405449958795, 929.2287401456774, 682.2290811383106, 683.0266869710642, 690.6339639990813, 691.0325544238107, 692.3076923076923, 12182.756344873053, 12334.0, 12525.311107889063, 12531.749365012649, 12688.80966785499, 10365.0, 10387.636432724817, 10547.683569492927, 10875.510602022849, 11236.438178091144, 9500.904990950141, 9541.713748587554, 9622.364198086341, 9802.65690700822, 9814.312998090136, 2607.374230184761, 2641.656584643984, 2644.8148629595935, 2723.360010397555, 2738.698743138253, 60234.39765602332, 61438.692806535684, 61622.69188654028, 62302.065469018, 62327.37672623261, 8002.399820013406, 8018.799530011796, 8264.702210013735, 8282.674772036566, 8292.751217463485, 16624.83375166257, 16711.749323760152, 16786.244618992176, 16835.83164168367, 16899.66200676004, 6284.969038090078, 6367.490600752021, 6396.5522413431545, 6426.164598602152, 6462.870742585122, 3290.1939024939043, 3333.8166400848186, 3388.9830550847087, 3391.7117045050954, 3463.549738534025, 3231.5619549300804, 3244.918877028046, 3287.112479630486, 3308.8676452942095, 3320.867165313409, 609.8993666045053, 615.7136931326954, 615.8737458820931, 619.5632079384023, 627.6108812536256, 523.4346905342221, 546.6173678425118, 548.150366931255, 550.2461627570254, 561.3348182403864, 7985.760427187193, 8173.18268173178, 8316.667333306721, 8363.749087527383, 8617.827643447095, 534.9010433069894, 545.3864402547134, 558.7960394455994, 565.6577770448819, 566.334556895646, 3741.2330472253125, 3848.7113466490127, 3909.4526766252748, 3994.1013272013565, 4000.2599519089063, 45888.0, 56489.43510564924, 59937.70031149816, 61154.08268875971, 61999.07001394983, 51758.0, 54446.0, 54460.0, 54519.45480545223, 55116.72441637766, 47123.5287647126, 48052.0, 49268.0, 49674.0065198694, 50492.0, 7492.175860655215, 7774.378049755893, 7775.57234352116, 7843.098043725045, 8309.37679674039, 23672.526549469258, 23721.051157953487, 24449.633255501536, 24881.50236995286, 25244.368890777878, 35141.0, 36559.45160822643, 37444.251114977, 39993.00017499586, 44877.77561112174, 11332.546698131982, 11659.766804664028, 11898.821517677068, 11925.0459963201, 12161.57434489824, 12609.614158163396, 12812.743745125232, 13013.739725205633, 13379.464821407035, 13403.32983350848, 12299.69250768738, 12560.811587826007, 12705.745885082062, 12836.679083022625, 13229.272390018257, 11805.328173835323, 11909.642710718692, 12155.0, 12239.69400764988, 12250.264984100982, 11046.558137674403, 11169.553217871195, 11318.660440186808, 11374.260673056226, 11412.087033037504, 8384.874226886725, 8394.0, 8474.904721917072, 8478.872816907875, 8642.43824151428, 8886.022537520998, 9887.802243955224, 9930.453825039693, 9941.801163976535, 10015.298929074896], "value": 6076.602777664787, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1581.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 116.0, 118.0, 115.0, 116.0, 114.0, 121.0, 126.0, 117.0, 113.0], "value": 115.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 127.0, 127.0, 167.0, 127.0, 132.0, 125.0, 126.0, 151.0, 134.0], "value": 136.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 167.0, 166.0, 170.0, 169.0, 165.0, 165.0, 166.0, 167.0, 166.0], "value": 166.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 110.0, 76.0, 80.0, 77.0, 76.0, 94.0, 77.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 108.0, 86.0, 87.0, 86.0, 104.0, 85.0, 86.0, 102.0], "value": 91.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 115.0, 114.0, 116.0, 116.0, 115.0], "value": 114.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 151.0, 153.0, 152.0, 150.0, 152.0, 151.0, 151.0, 151.0, 152.0], "value": 151.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 94.0, 95.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 66.0, 69.0, 68.0, 69.0, 69.0, 70.0, 70.0, 69.0], "value": 68.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 57.0, 57.0, 57.0, 56.0, 57.0, 63.0, 56.0, 57.0], "value": 57.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 85.0, 84.0, 83.0, 85.0, 85.0, 86.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 145.0, 146.0, 150.0, 135.0, 135.0, 143.0, 135.0, 186.0, 137.0], "value": 145.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 201.0, 197.0, 191.0, 196.0, 202.0, 199.0, 203.0, 207.0, 186.0], "value": 198.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 76.0, 73.0, 74.0, 72.0, 73.0, 72.0, 78.0], "value": 73.9, "unit": "score"}]}]} 07:35:29 INFO - Return code: 0 07:35:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:35:29 ERROR - # TBPL SUCCESS # 07:35:29 INFO - Running post-action listener: _resource_record_post_action 07:35:29 INFO - [mozharness: 2017-03-29 14:35:29.293135Z] Finished run-tests step (success) 07:35:29 INFO - Running post-run listener: _resource_record_post_run 07:35:29 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 2543616; Write bytes: 368017408; Read time: 580; Write time: 251768 07:35:29 INFO - TinderboxPrint: CPU usage
13.1% 07:35:29 INFO - TinderboxPrint: I/O read bytes / time
2,543,616 / 580 07:35:29 INFO - TinderboxPrint: I/O write bytes / time
368,017,408 / 251,768 07:35:29 INFO - TinderboxPrint: CPU idle
8,358.7 (86.9%) 07:35:29 INFO - TinderboxPrint: CPU user
1,208.4 (12.6%) 07:35:29 INFO - TinderboxPrint: Swap in / out
0 / 0 07:35:29 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 106696704; Read time: 0; Write time: 106444 07:35:29 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 2543616; Write bytes: 261320704; Read time: 580; Write time: 145324 07:35:29 INFO - Running post-run listener: _upload_blobber_files 07:35:29 INFO - Blob upload gear active. 07:35:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:35:29 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:35:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:35:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:35:30 INFO - (blobuploader) - INFO - Open directory for files ... 07:35:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:35:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:35:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:35:31 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:35:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:35:31 INFO - (blobuploader) - INFO - Done attempting. 07:35:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:35:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:35:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:35:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:35:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:35:34 INFO - (blobuploader) - INFO - Done attempting. 07:35:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:35:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:35:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:35:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:35:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:35:35 INFO - (blobuploader) - INFO - Done attempting. 07:35:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:35:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:35:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:35:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:35:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:35:35 INFO - (blobuploader) - INFO - Done attempting. 07:35:35 INFO - (blobuploader) - INFO - Iteration through files over. 07:35:35 INFO - Return code: 0 07:35:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:35:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:35:35 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/475482327b624b70a5ba4e2946f5986cdbcb735cbf443966036bd99a854eade164445564227c489390c8504d8008ba9f17f1c7e1429f67f7468dadd587b88f27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/407b3e1ccbf173454303c580722a6366ae254d96a716fa4eb72bf0a7a09d4a868bc5a693309e29202901e553eb5185b0b1ec8dd57213513509b62fbe7589b398", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b88087640a36ed2c9443520e696de289c54770612823490d256b911281f906d12a15d0a15db652f5b746a773b1743480c9491d18c98767fe859e50152daed9b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ac839971d054d0dd32c40df8d119802d6da6ff64e50e31bcec7d8f029571e30ee7bb8566e48e8c7b70a3a2862db3e02ad842cff406680caf3d906d036482d373"} 07:35:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:35:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:35:35 INFO - Contents: 07:35:35 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/475482327b624b70a5ba4e2946f5986cdbcb735cbf443966036bd99a854eade164445564227c489390c8504d8008ba9f17f1c7e1429f67f7468dadd587b88f27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/407b3e1ccbf173454303c580722a6366ae254d96a716fa4eb72bf0a7a09d4a868bc5a693309e29202901e553eb5185b0b1ec8dd57213513509b62fbe7589b398", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b88087640a36ed2c9443520e696de289c54770612823490d256b911281f906d12a15d0a15db652f5b746a773b1743480c9491d18c98767fe859e50152daed9b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ac839971d054d0dd32c40df8d119802d6da6ff64e50e31bcec7d8f029571e30ee7bb8566e48e8c7b70a3a2862db3e02ad842cff406680caf3d906d036482d373"} 07:35:35 INFO - Running post-run listener: copy_logs_to_upload_dir 07:35:35 INFO - Copying logs to upload dir... 07:35:35 INFO - mkdir: /builds/slave/test/build/upload/logs 07:35:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.677746 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-29 07:35:35.660830) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-29 07:35:35.664682) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1490796870.317262-994131703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/475482327b624b70a5ba4e2946f5986cdbcb735cbf443966036bd99a854eade164445564227c489390c8504d8008ba9f17f1c7e1429f67f7468dadd587b88f27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/407b3e1ccbf173454303c580722a6366ae254d96a716fa4eb72bf0a7a09d4a868bc5a693309e29202901e553eb5185b0b1ec8dd57213513509b62fbe7589b398", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b88087640a36ed2c9443520e696de289c54770612823490d256b911281f906d12a15d0a15db652f5b746a773b1743480c9491d18c98767fe859e50152daed9b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ac839971d054d0dd32c40df8d119802d6da6ff64e50e31bcec7d8f029571e30ee7bb8566e48e8c7b70a3a2862db3e02ad842cff406680caf3d906d036482d373"} build_url:https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011234 build_url: 'https://queue.taskcluster.net/v1/task/Lizx6zgGT2iHJFELVUoVlg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/475482327b624b70a5ba4e2946f5986cdbcb735cbf443966036bd99a854eade164445564227c489390c8504d8008ba9f17f1c7e1429f67f7468dadd587b88f27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/407b3e1ccbf173454303c580722a6366ae254d96a716fa4eb72bf0a7a09d4a868bc5a693309e29202901e553eb5185b0b1ec8dd57213513509b62fbe7589b398", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b88087640a36ed2c9443520e696de289c54770612823490d256b911281f906d12a15d0a15db652f5b746a773b1743480c9491d18c98767fe859e50152daed9b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ac839971d054d0dd32c40df8d119802d6da6ff64e50e31bcec7d8f029571e30ee7bb8566e48e8c7b70a3a2862db3e02ad842cff406680caf3d906d036482d373"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-29 07:35:35.692027) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 07:35:35.692631) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1490796870.317262-994131703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004392 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 07:35:35.776983) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-29 07:35:35.777316) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-29 07:35:35.777610) ========= ========= Total master_lag: 0.17 =========