builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-032 starttime: 1486865934.64 results: success (0) revision: 09ef6a4f41186ea6951830d1506f741005dcc46f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-11 18:18:54.643075) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-11 18:18:54.643641) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-11 18:18:54.643948) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-11 18:18:54.696258) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-11 18:18:54.696563) ========= 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=745a4373a2a16df560f216e000000264-1486861849.488943-1863273647 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-11 18:18:54-- 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% 33.6M=0s 2017-02-11 18:18:55 (33.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.119844 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-11 18:18:54.832356) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-11 18:18:54.832728) ========= 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=745a4373a2a16df560f216e000000264-1486861849.488943-1863273647 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020401 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-11 18:18:54.887776) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-11 18:18:54.888108) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 09ef6a4f41186ea6951830d1506f741005dcc46f --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 09ef6a4f41186ea6951830d1506f741005dcc46f --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=745a4373a2a16df560f216e000000264-1486861849.488943-1863273647 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-11 18:18:55,195 truncating revision to first 12 chars 2017-02-11 18:18:55,195 Setting DEBUG logging. 2017-02-11 18:18:55,195 attempt 1/10 2017-02-11 18:18:55,195 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/09ef6a4f4118?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-11 18:18:55,644 unpacking tar archive at: mozilla-central-09ef6a4f4118/testing/mozharness/ program finished with exit code 0 elapsedTime=0.761453 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-11 18:18:55.664437) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-11 18:18:55.664760) ========= script_repo_revision: 09ef6a4f41186ea6951830d1506f741005dcc46f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-11 18:18:55.665188) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-11 18:18:55.665487) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-11 18:18:55.687368) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-02-11 18:18:55.687670) ========= /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=745a4373a2a16df560f216e000000264-1486861849.488943-1863273647 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:18:56 INFO - MultiFileLogger online at 20170211 18:18:56 in /builds/slave/test 18:18:56 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 18:18:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:18:56 INFO - {'append_to_log': False, 18:18:56 INFO - 'base_work_dir': '/builds/slave/test', 18:18:56 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 18:18:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:18:56 INFO - 'branch': 'Firefox-Non-PGO', 18:18:56 INFO - 'buildbot_json_path': 'buildprops.json', 18:18:56 INFO - 'config_files': ('talos/linux_config.py',), 18:18:56 INFO - 'default_actions': ('clobber', 18:18:56 INFO - 'read-buildbot-config', 18:18:56 INFO - 'download-and-extract', 18:18:56 INFO - 'populate-webroot', 18:18:56 INFO - 'create-virtualenv', 18:18:56 INFO - 'install', 18:18:56 INFO - 'run-tests'), 18:18:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:18:56 INFO - 'download_minidump_stackwalk': True, 18:18:56 INFO - 'download_symbols': 'ondemand', 18:18:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:18:56 INFO - 'tooltool.py': '/tools/tooltool.py', 18:18:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:18:56 INFO - '/tools/misc-python/virtualenv.py')}, 18:18:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:18:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:18:56 INFO - 'installer_path': 'installer.exe', 18:18:56 INFO - 'log_level': 'info', 18:18:56 INFO - 'log_name': 'talos', 18:18:56 INFO - 'log_to_console': True, 18:18:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:18:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:18:56 INFO - 'opt_config_files': (), 18:18:56 INFO - 'pip_index': False, 18:18:56 INFO - 'sps_profile': False, 18:18:56 INFO - 'sps_profile_interval': 0, 18:18:56 INFO - 'suite': 'dromaeojs', 18:18:56 INFO - 'system_bits': '32', 18:18:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:18:56 INFO - 'title': 'talos-linux64-ix-032', 18:18:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:18:56 INFO - 'use_talos_json': True, 18:18:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:18:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:18:56 INFO - 'work_dir': 'build'} 18:18:56 INFO - [mozharness: 2017-02-12 02:18:56.093732Z] Running clobber step. 18:18:56 INFO - Running pre-action listener: _resource_record_pre_action 18:18:56 INFO - Running main action method: clobber 18:18:56 INFO - rmtree: /builds/slave/test/build 18:18:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:18:57 INFO - Running post-action listener: _resource_record_post_action 18:18:57 INFO - [mozharness: 2017-02-12 02:18:57.078948Z] Finished clobber step (success) 18:18:57 INFO - [mozharness: 2017-02-12 02:18:57.079049Z] Running read-buildbot-config step. 18:18:57 INFO - Running pre-action listener: _resource_record_pre_action 18:18:57 INFO - Running main action method: read_buildbot_config 18:18:57 INFO - Using buildbot properties: 18:18:57 INFO - { 18:18:57 INFO - "project": "", 18:18:57 INFO - "product": "firefox", 18:18:57 INFO - "who": "philringnalda@gmail.com", 18:18:57 INFO - "installer_path": "public/build/target.tar.bz2", 18:18:57 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 18:18:57 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 18:18:57 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 18:18:57 INFO - "stage_platform": "linux64", 18:18:57 INFO - "basedir": "/builds/slave/test", 18:18:57 INFO - "buildnumber": 973, 18:18:57 INFO - "platform": "ubuntu64_hw", 18:18:57 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:18:57 INFO - "slavebuilddir": "test", 18:18:57 INFO - "taskId": "ElcUMStESxCS8MMJEVI8SA", 18:18:57 INFO - "branch": "mozilla-central", 18:18:57 INFO - "script_repo_revision": "production", 18:18:57 INFO - "revision": "09ef6a4f41186ea6951830d1506f741005dcc46f", 18:18:57 INFO - "slavename": "talos-linux64-ix-032", 18:18:57 INFO - "repo_path": "mozilla-central" 18:18:57 INFO - } 18:18:57 INFO - Finding installer, test and symbols from parent task. 18:18:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ElcUMStESxCS8MMJEVI8SA'}, attempt #1 18:18:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ElcUMStESxCS8MMJEVI8SA'}, attempt #1 18:18:57 INFO - Task dependencies: Zz1_d1s5T-aWQ-8dLcFa6g 18:18:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zz1_d1s5T-aWQ-8dLcFa6g'}, attempt #1 18:18:58 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Zz1_d1s5T-aWQ-8dLcFa6g/artifacts/public/build/target.tar.bz2 18:18:58 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Zz1_d1s5T-aWQ-8dLcFa6g/artifacts/public/build/test_packages.json 18:18:58 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Zz1_d1s5T-aWQ-8dLcFa6g/artifacts/public/build/target.crashreporter-symbols.zip 18:18:58 INFO - Running post-action listener: _resource_record_post_action 18:18:58 INFO - [mozharness: 2017-02-12 02:18:58.470286Z] Finished read-buildbot-config step (success) 18:18:58 INFO - [mozharness: 2017-02-12 02:18:58.470504Z] Running download-and-extract step. 18:18:58 INFO - Running pre-action listener: _resource_record_pre_action 18:18:58 INFO - Running main action method: download_and_extract 18:18:58 INFO - mkdir: /builds/slave/test/build/tests 18:18:58 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')]} 18:18:58 INFO - trying https://queue.taskcluster.net/v1/task/Zz1_d1s5T-aWQ-8dLcFa6g/artifacts/public/build/target.test_packages.json 18:18:58 INFO - Downloading https://queue.taskcluster.net/v1/task/Zz1_d1s5T-aWQ-8dLcFa6g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:18:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zz1_d1s5T-aWQ-8dLcFa6g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:18:59 INFO - Downloaded 896 bytes. 18:18:59 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:18:59 INFO - Using the following test package requirements: 18:18:59 INFO - {u'common': [u'target.common.tests.zip'], 18:18:59 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:18:59 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:18:59 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:18:59 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:18:59 INFO - u'mozbase': [u'target.common.tests.zip'], 18:18:59 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:18:59 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:18:59 INFO - u'web-platform': [u'target.common.tests.zip', 18:18:59 INFO - u'target.web-platform.tests.zip'], 18:18:59 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:18:59 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:18:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zz1_d1s5T-aWQ-8dLcFa6g/artifacts/public/build/target.common.tests.zip 18:18:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zz1_d1s5T-aWQ-8dLcFa6g/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:18:59 INFO - Fetch https://queue.taskcluster.net/v1/task/Zz1_d1s5T-aWQ-8dLcFa6g/artifacts/public/build/target.common.tests.zip into memory 18:19:00 INFO - Expected file size: 57078713 18:19:00 INFO - Obtained file size: 57078713 18:19:09 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:19:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zz1_d1s5T-aWQ-8dLcFa6g/artifacts/public/build/target.common.tests.zip 18:19:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zz1_d1s5T-aWQ-8dLcFa6g/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:19:09 INFO - Fetch https://queue.taskcluster.net/v1/task/Zz1_d1s5T-aWQ-8dLcFa6g/artifacts/public/build/target.common.tests.zip into memory 18:19:11 INFO - Expected file size: 57078713 18:19:11 INFO - Obtained file size: 57078713 18:19:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zz1_d1s5T-aWQ-8dLcFa6g/artifacts/public/build/target.talos.tests.zip 18:19:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zz1_d1s5T-aWQ-8dLcFa6g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:19:21 INFO - Fetch https://queue.taskcluster.net/v1/task/Zz1_d1s5T-aWQ-8dLcFa6g/artifacts/public/build/target.talos.tests.zip into memory 18:19:22 INFO - Expected file size: 14403647 18:19:22 INFO - Obtained file size: 14403647 18:19:22 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')]} 18:19:22 INFO - trying https://queue.taskcluster.net/v1/task/Zz1_d1s5T-aWQ-8dLcFa6g/artifacts/public/build/target.tar.bz2 18:19:22 INFO - Downloading https://queue.taskcluster.net/v1/task/Zz1_d1s5T-aWQ-8dLcFa6g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:19:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zz1_d1s5T-aWQ-8dLcFa6g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:19:23 INFO - Downloaded 56450131 bytes. 18:19:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Zz1_d1s5T-aWQ-8dLcFa6g/artifacts/public/build/target.tar.bz2 18:19:23 INFO - mkdir: /builds/slave/test/properties 18:19:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:19:23 INFO - Writing to file /builds/slave/test/properties/build_url 18:19:23 INFO - Contents: 18:19:23 INFO - build_url:https://queue.taskcluster.net/v1/task/Zz1_d1s5T-aWQ-8dLcFa6g/artifacts/public/build/target.tar.bz2 18:19:23 INFO - Running post-action listener: _resource_record_post_action 18:19:23 INFO - Running post-action listener: set_extra_try_arguments 18:19:23 INFO - [mozharness: 2017-02-12 02:19:23.887667Z] Finished download-and-extract step (success) 18:19:23 INFO - [mozharness: 2017-02-12 02:19:23.887892Z] Running populate-webroot step. 18:19:23 INFO - Running pre-action listener: _resource_record_pre_action 18:19:23 INFO - Running main action method: populate_webroot 18:19:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:19:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:19:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:19:23 INFO - '--tppagecycles', 18:19:23 INFO - '7'], 18:19:23 INFO - 'tests': ['tsvgm']}}, 18:19:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:19:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:19:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:19:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:19:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:19:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:19:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:19:23 INFO - 'talos_options': ['--disable-e10s'], 18:19:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:19:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:19:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:19:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:19:23 INFO - 'talos_options': ['--disable-e10s'], 18:19:23 INFO - 'tests': ['damp', 'tps']}, 18:19:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:19:23 INFO - 'tests': ['damp', 'tps']}, 18:19:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:19:23 INFO - 'tests': ['dromaeo_dom']}, 18:19:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:19:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:19:23 INFO - 'tests': ['basic_compositor_video']}, 18:19:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:19:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:19:23 INFO - 'tests': ['a11yr', 18:19:23 INFO - 'ts_paint', 18:19:23 INFO - 'tpaint', 18:19:23 INFO - 'sessionrestore', 18:19:23 INFO - 'sessionrestore_no_auto_restore', 18:19:23 INFO - 'tabpaint']}, 18:19:23 INFO - 'other-e10s': {'tests': ['a11yr', 18:19:23 INFO - 'ts_paint', 18:19:23 INFO - 'tpaint', 18:19:23 INFO - 'sessionrestore', 18:19:23 INFO - 'sessionrestore_no_auto_restore', 18:19:23 INFO - 'tabpaint']}, 18:19:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:19:23 INFO - 'ts_paint', 18:19:23 INFO - 'tpaint', 18:19:23 INFO - 'sessionrestore', 18:19:23 INFO - 'sessionrestore_no_auto_restore', 18:19:23 INFO - 'tabpaint']}, 18:19:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:19:23 INFO - 'ts_paint', 18:19:23 INFO - 'tpaint', 18:19:23 INFO - 'sessionrestore', 18:19:23 INFO - 'sessionrestore_no_auto_restore', 18:19:23 INFO - 'tabpaint']}, 18:19:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:19:23 INFO - 'tests': ['a11yr', 18:19:23 INFO - 'ts_paint', 18:19:23 INFO - 'tpaint', 18:19:23 INFO - 'sessionrestore', 18:19:23 INFO - 'sessionrestore_no_auto_restore', 18:19:23 INFO - 'tabpaint']}, 18:19:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:19:23 INFO - 'tests': ['a11yr', 18:19:23 INFO - 'ts_paint', 18:19:23 INFO - 'tpaint', 18:19:23 INFO - 'sessionrestore', 18:19:23 INFO - 'sessionrestore_no_auto_restore', 18:19:23 INFO - 'tabpaint']}, 18:19:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:19:23 INFO - 'tests': ['tsvgx', 18:19:23 INFO - 'tsvgr_opacity', 18:19:23 INFO - 'tart', 18:19:23 INFO - 'tscrollx', 18:19:23 INFO - 'cart', 18:19:23 INFO - 'tsvg_static']}, 18:19:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:19:23 INFO - 'tsvgr_opacity', 18:19:23 INFO - 'tart', 18:19:23 INFO - 'tscrollx', 18:19:23 INFO - 'cart', 18:19:23 INFO - 'tsvg_static']}, 18:19:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:19:23 INFO - 'talos_options': ['--disable-e10s'], 18:19:23 INFO - 'tests': ['tp5o']}, 18:19:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:19:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:19:23 INFO - 'talos_options': ['--disable-e10s', 18:19:23 INFO - '--xperf_path', 18:19:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:19:23 INFO - 'tests': ['tp5n']}, 18:19:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:19:23 INFO - 'talos_options': ['--xperf_path', 18:19:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:19:23 INFO - 'tests': ['tp5n']}}, 18:19:23 INFO - 'talos.zip': {'path': '', 18:19:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:19:23 INFO - Running post-action listener: _resource_record_post_action 18:19:23 INFO - [mozharness: 2017-02-12 02:19:23.904729Z] Finished populate-webroot step (success) 18:19:23 INFO - [mozharness: 2017-02-12 02:19:23.904822Z] Running create-virtualenv step. 18:19:23 INFO - Running pre-action listener: _resource_record_pre_action 18:19:23 INFO - Running main action method: create_virtualenv 18:19:23 INFO - Creating virtualenv /builds/slave/test/build/venv 18:19:23 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 18:19:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:19:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:19:24 INFO - Using real prefix '/usr' 18:19:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:19:24 INFO - Installing distribute.............................................................................................................................................................................................done. 18:19:26 INFO - Installing pip.................done. 18:19:26 INFO - Return code: 0 18:19:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:19:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:19:26 INFO - Reading from file tmpfile_stdout 18:19:26 INFO - Output received: 18:19:26 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) 18:19:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:19:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:26 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 0x27fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b70630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf9850>, '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 0x2b6e6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6eb60>, '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': '745a4373a2a16df560f216e000000264-1486861849.488943-1863273647', '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 18:19:26 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 18:19:26 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 18:19:26 INFO - Using env: {'DISPLAY': ':0', 18:19:26 INFO - 'HOME': '/home/cltbld', 18:19:26 INFO - 'LANG': 'en_US.UTF-8', 18:19:26 INFO - 'LANGUAGE': 'en_US:en', 18:19:26 INFO - 'LOGNAME': 'cltbld', 18:19:26 INFO - 'MAIL': '/var/mail/cltbld', 18:19:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:26 INFO - 'MOZ_NO_REMOTE': '1', 18:19:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:26 INFO - 'NO_EM_RESTART': '1', 18:19:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:26 INFO - 'PWD': '/builds/slave/test', 18:19:26 INFO - 'SHELL': '/bin/bash', 18:19:26 INFO - 'SHLVL': '1', 18:19:26 INFO - 'TERM': 'linux', 18:19:26 INFO - 'TMOUT': '86400', 18:19:26 INFO - 'USER': 'cltbld', 18:19:26 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1486861849.488943-1863273647', 18:19:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:26 INFO - '_': '/tools/buildbot/bin/python'} 18:19:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:26 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 18:19:26 INFO - Cleaning up... 18:19:26 INFO - Return code: 0 18:19:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:19:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:26 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 0x27fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b70630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf9850>, '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 0x2b6e6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6eb60>, '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': '745a4373a2a16df560f216e000000264-1486861849.488943-1863273647', '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 18:19:26 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 18:19:26 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 18:19:26 INFO - Using env: {'DISPLAY': ':0', 18:19:26 INFO - 'HOME': '/home/cltbld', 18:19:26 INFO - 'LANG': 'en_US.UTF-8', 18:19:26 INFO - 'LANGUAGE': 'en_US:en', 18:19:26 INFO - 'LOGNAME': 'cltbld', 18:19:26 INFO - 'MAIL': '/var/mail/cltbld', 18:19:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:26 INFO - 'MOZ_NO_REMOTE': '1', 18:19:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:26 INFO - 'NO_EM_RESTART': '1', 18:19:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:26 INFO - 'PWD': '/builds/slave/test', 18:19:26 INFO - 'SHELL': '/bin/bash', 18:19:26 INFO - 'SHLVL': '1', 18:19:26 INFO - 'TERM': 'linux', 18:19:26 INFO - 'TMOUT': '86400', 18:19:26 INFO - 'USER': 'cltbld', 18:19:26 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1486861849.488943-1863273647', 18:19:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:26 INFO - '_': '/tools/buildbot/bin/python'} 18:19:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:27 INFO - Downloading/unpacking psutil>=3.1.1 18:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:19:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:19:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:19:29 INFO - Installing collected packages: psutil 18:19:29 INFO - Running setup.py install for psutil 18:19:29 INFO - building 'psutil._psutil_linux' extension 18:19:29 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 18:19:29 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 18:19:29 INFO - building 'psutil._psutil_posix' extension 18:19:29 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 18:19:29 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 18:19:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:19:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:19:29 INFO - Successfully installed psutil 18:19:29 INFO - Cleaning up... 18:19:29 INFO - Return code: 0 18:19:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:19:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:29 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 0x27fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b70630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf9850>, '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 0x2b6e6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6eb60>, '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': '745a4373a2a16df560f216e000000264-1486861849.488943-1863273647', '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 18:19:29 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 18:19:29 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 18:19:29 INFO - Using env: {'DISPLAY': ':0', 18:19:29 INFO - 'HOME': '/home/cltbld', 18:19:29 INFO - 'LANG': 'en_US.UTF-8', 18:19:29 INFO - 'LANGUAGE': 'en_US:en', 18:19:29 INFO - 'LOGNAME': 'cltbld', 18:19:29 INFO - 'MAIL': '/var/mail/cltbld', 18:19:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:29 INFO - 'MOZ_NO_REMOTE': '1', 18:19:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:29 INFO - 'NO_EM_RESTART': '1', 18:19:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:29 INFO - 'PWD': '/builds/slave/test', 18:19:29 INFO - 'SHELL': '/bin/bash', 18:19:29 INFO - 'SHLVL': '1', 18:19:29 INFO - 'TERM': 'linux', 18:19:29 INFO - 'TMOUT': '86400', 18:19:29 INFO - 'USER': 'cltbld', 18:19:29 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1486861849.488943-1863273647', 18:19:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:29 INFO - '_': '/tools/buildbot/bin/python'} 18:19:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:19:29 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 18:19:29 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 18:19:29 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 18:19:29 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 18:19:29 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 18:19:29 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 18:19:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:19:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:19:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:19:32 INFO - Installing collected packages: mozsystemmonitor 18:19:32 INFO - Running setup.py install for mozsystemmonitor 18:19:32 INFO - Successfully installed mozsystemmonitor 18:19:32 INFO - Cleaning up... 18:19:32 INFO - Return code: 0 18:19:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:19:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b70630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf9850>, '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 0x2b6e6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6eb60>, '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': '745a4373a2a16df560f216e000000264-1486861849.488943-1863273647', '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 18:19:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:19:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:19:32 INFO - Using env: {'DISPLAY': ':0', 18:19:32 INFO - 'HOME': '/home/cltbld', 18:19:32 INFO - 'LANG': 'en_US.UTF-8', 18:19:32 INFO - 'LANGUAGE': 'en_US:en', 18:19:32 INFO - 'LOGNAME': 'cltbld', 18:19:32 INFO - 'MAIL': '/var/mail/cltbld', 18:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:32 INFO - 'MOZ_NO_REMOTE': '1', 18:19:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:32 INFO - 'NO_EM_RESTART': '1', 18:19:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:32 INFO - 'PWD': '/builds/slave/test', 18:19:32 INFO - 'SHELL': '/bin/bash', 18:19:32 INFO - 'SHLVL': '1', 18:19:32 INFO - 'TERM': 'linux', 18:19:32 INFO - 'TMOUT': '86400', 18:19:32 INFO - 'USER': 'cltbld', 18:19:32 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1486861849.488943-1863273647', 18:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:32 INFO - '_': '/tools/buildbot/bin/python'} 18:19:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:32 INFO - Downloading/unpacking jsonschema==2.5.1 18:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:19:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:19:34 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 18:19:34 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 18:19:34 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 18:19:34 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 18:19:34 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 18:19:34 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 18:19:34 INFO - Downloading functools32-3.2.3-2.tar.gz 18:19:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:19:34 INFO - warning: no files found matching '*.txt' 18:19:34 INFO - no previously-included directories found matching 'build' 18:19:34 INFO - no previously-included directories found matching 'dist' 18:19:34 INFO - no previously-included directories found matching '.git*' 18:19:34 INFO - Installing collected packages: jsonschema, functools32 18:19:34 INFO - Running setup.py install for functools32 18:19:34 INFO - warning: no files found matching '*.txt' 18:19:34 INFO - no previously-included directories found matching 'build' 18:19:34 INFO - no previously-included directories found matching 'dist' 18:19:34 INFO - no previously-included directories found matching '.git*' 18:19:34 INFO - Successfully installed jsonschema functools32 18:19:34 INFO - Cleaning up... 18:19:34 INFO - Return code: 0 18:19:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:19:34 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')]} 18:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:34 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')]} 18:19:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:34 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 0x27fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b70630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf9850>, '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 0x2b6e6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6eb60>, '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': '745a4373a2a16df560f216e000000264-1486861849.488943-1863273647', '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 18:19:34 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 18:19:34 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 18:19:34 INFO - Using env: {'DISPLAY': ':0', 18:19:34 INFO - 'HOME': '/home/cltbld', 18:19:34 INFO - 'LANG': 'en_US.UTF-8', 18:19:34 INFO - 'LANGUAGE': 'en_US:en', 18:19:34 INFO - 'LOGNAME': 'cltbld', 18:19:34 INFO - 'MAIL': '/var/mail/cltbld', 18:19:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:34 INFO - 'MOZ_NO_REMOTE': '1', 18:19:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:34 INFO - 'NO_EM_RESTART': '1', 18:19:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:34 INFO - 'PWD': '/builds/slave/test', 18:19:34 INFO - 'SHELL': '/bin/bash', 18:19:34 INFO - 'SHLVL': '1', 18:19:34 INFO - 'TERM': 'linux', 18:19:34 INFO - 'TMOUT': '86400', 18:19:34 INFO - 'USER': 'cltbld', 18:19:34 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1486861849.488943-1863273647', 18:19:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:34 INFO - '_': '/tools/buildbot/bin/python'} 18:19:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:19:35 INFO - Cleaning up... 18:19:35 INFO - Return code: 0 18:19:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:19: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')]} 18:19:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19: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')]} 18:19:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x27fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b70630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf9850>, '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 0x2b6e6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6eb60>, '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': '745a4373a2a16df560f216e000000264-1486861849.488943-1863273647', '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 18:19:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:19:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:19:35 INFO - Using env: {'DISPLAY': ':0', 18:19:35 INFO - 'HOME': '/home/cltbld', 18:19:35 INFO - 'LANG': 'en_US.UTF-8', 18:19:35 INFO - 'LANGUAGE': 'en_US:en', 18:19:35 INFO - 'LOGNAME': 'cltbld', 18:19:35 INFO - 'MAIL': '/var/mail/cltbld', 18:19:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:35 INFO - 'MOZ_NO_REMOTE': '1', 18:19:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:35 INFO - 'NO_EM_RESTART': '1', 18:19:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:35 INFO - 'PWD': '/builds/slave/test', 18:19:35 INFO - 'SHELL': '/bin/bash', 18:19:35 INFO - 'SHLVL': '1', 18:19:35 INFO - 'TERM': 'linux', 18:19:35 INFO - 'TMOUT': '86400', 18:19:35 INFO - 'USER': 'cltbld', 18:19:35 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1486861849.488943-1863273647', 18:19:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:35 INFO - '_': '/tools/buildbot/bin/python'} 18:19:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:35 INFO - Downloading/unpacking blobuploader==1.2.4 18:19:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:37 INFO - Downloading blobuploader-1.2.4.tar.gz 18:19:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:19:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:19:37 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 18:19:37 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 18:19:37 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 18:19:37 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 18:19:37 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 18:19:37 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 18:19:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:19:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:19:37 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 18:19:37 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 18:19:37 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 18:19:37 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 18:19:37 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 18:19:37 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 18:19:38 INFO - Downloading docopt-0.6.1.tar.gz 18:19:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:19:38 INFO - Installing collected packages: blobuploader, requests, docopt 18:19:38 INFO - Running setup.py install for blobuploader 18:19:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:19:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:19:38 INFO - Running setup.py install for requests 18:19:38 INFO - Running setup.py install for docopt 18:19:38 INFO - Successfully installed blobuploader requests docopt 18:19:38 INFO - Cleaning up... 18:19:38 INFO - Return code: 0 18:19:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:19:38 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')]} 18:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:38 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')]} 18:19:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:38 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 0x27fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b70630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf9850>, '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 0x2b6e6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6eb60>, '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': '745a4373a2a16df560f216e000000264-1486861849.488943-1863273647', '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 18:19:38 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 18:19:38 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 18:19:38 INFO - Using env: {'DISPLAY': ':0', 18:19:38 INFO - 'HOME': '/home/cltbld', 18:19:38 INFO - 'LANG': 'en_US.UTF-8', 18:19:38 INFO - 'LANGUAGE': 'en_US:en', 18:19:38 INFO - 'LOGNAME': 'cltbld', 18:19:38 INFO - 'MAIL': '/var/mail/cltbld', 18:19:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:38 INFO - 'MOZ_NO_REMOTE': '1', 18:19:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:38 INFO - 'NO_EM_RESTART': '1', 18:19:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:38 INFO - 'PWD': '/builds/slave/test', 18:19:38 INFO - 'SHELL': '/bin/bash', 18:19:38 INFO - 'SHLVL': '1', 18:19:38 INFO - 'TERM': 'linux', 18:19:38 INFO - 'TMOUT': '86400', 18:19:38 INFO - 'USER': 'cltbld', 18:19:38 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1486861849.488943-1863273647', 18:19:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:38 INFO - '_': '/tools/buildbot/bin/python'} 18:19:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:19:39 INFO - Running setup.py (path:/tmp/pip-clYYaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:19:39 INFO - Running setup.py (path:/tmp/pip-uRQNq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:19:39 INFO - Running setup.py (path:/tmp/pip-kES3Vr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:19:39 INFO - Running setup.py (path:/tmp/pip-WbVKFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:19:39 INFO - Running setup.py (path:/tmp/pip-T0ZDPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:19:39 INFO - Running setup.py (path:/tmp/pip-MVrxxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:19:39 INFO - Running setup.py (path:/tmp/pip-kdnaSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:19:39 INFO - Running setup.py (path:/tmp/pip-nof6mT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:19:39 INFO - Running setup.py (path:/tmp/pip-kdsRSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:19:39 INFO - Running setup.py (path:/tmp/pip-3k48Wa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:19:39 INFO - Running setup.py (path:/tmp/pip-oGU2w6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:19:39 INFO - Running setup.py (path:/tmp/pip-rdEi2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:19:39 INFO - Running setup.py (path:/tmp/pip-ks1DAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:19:39 INFO - Running setup.py (path:/tmp/pip-74hfMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:19:40 INFO - Running setup.py (path:/tmp/pip-Ld_AR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:19:40 INFO - Running setup.py (path:/tmp/pip-NYm4X8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:19:40 INFO - Running setup.py (path:/tmp/pip-f9AeI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:19:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:19:40 INFO - Running setup.py install for manifestparser 18:19:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:19:40 INFO - Running setup.py install for mozcrash 18:19:40 INFO - Running setup.py install for mozdebug 18:19:40 INFO - Running setup.py install for mozdevice 18:19:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:19:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:19:40 INFO - Running setup.py install for mozfile 18:19:40 INFO - Running setup.py install for mozhttpd 18:19:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:19:40 INFO - Running setup.py install for mozinfo 18:19:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:19:40 INFO - Running setup.py install for mozInstall 18:19:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:19:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:19:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:19:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:19:41 INFO - Running setup.py install for mozleak 18:19:41 INFO - Running setup.py install for mozlog 18:19:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:19:41 INFO - Running setup.py install for moznetwork 18:19:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:19:41 INFO - Running setup.py install for mozprocess 18:19:41 INFO - Running setup.py install for mozprofile 18:19:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:19:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:19:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:19:41 INFO - Running setup.py install for mozrunner 18:19:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:19:41 INFO - Running setup.py install for mozscreenshot 18:19:41 INFO - Running setup.py install for moztest 18:19:41 INFO - Running setup.py install for mozversion 18:19:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:19:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:19:42 INFO - Cleaning up... 18:19:42 INFO - Return code: 0 18:19:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:19:42 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')]} 18:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:42 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')]} 18:19:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:42 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 0x27fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b70630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf9850>, '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 0x2b6e6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6eb60>, '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': '745a4373a2a16df560f216e000000264-1486861849.488943-1863273647', '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 18:19:42 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 18:19:42 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 18:19:42 INFO - Using env: {'DISPLAY': ':0', 18:19:42 INFO - 'HOME': '/home/cltbld', 18:19:42 INFO - 'LANG': 'en_US.UTF-8', 18:19:42 INFO - 'LANGUAGE': 'en_US:en', 18:19:42 INFO - 'LOGNAME': 'cltbld', 18:19:42 INFO - 'MAIL': '/var/mail/cltbld', 18:19:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:42 INFO - 'MOZ_NO_REMOTE': '1', 18:19:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:42 INFO - 'NO_EM_RESTART': '1', 18:19:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:42 INFO - 'PWD': '/builds/slave/test', 18:19:42 INFO - 'SHELL': '/bin/bash', 18:19:42 INFO - 'SHLVL': '1', 18:19:42 INFO - 'TERM': 'linux', 18:19:42 INFO - 'TMOUT': '86400', 18:19:42 INFO - 'USER': 'cltbld', 18:19:42 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1486861849.488943-1863273647', 18:19:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:42 INFO - '_': '/tools/buildbot/bin/python'} 18:19:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:19:42 INFO - Running setup.py (path:/tmp/pip-nUsEKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:19:42 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)) 18:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:19:42 INFO - Running setup.py (path:/tmp/pip-t55UA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:19:42 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)) 18:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:19:42 INFO - Running setup.py (path:/tmp/pip-lg59XL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:19:42 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)) 18:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:19:42 INFO - Running setup.py (path:/tmp/pip-2u53Cl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:19:42 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)) 18:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:19:42 INFO - Running setup.py (path:/tmp/pip-UKSjir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:19:42 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)) 18:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:19:42 INFO - Running setup.py (path:/tmp/pip-p5FtkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:19:42 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)) 18:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:19:42 INFO - Running setup.py (path:/tmp/pip-A7rjk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:19:42 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)) 18:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:19:42 INFO - Running setup.py (path:/tmp/pip-mGvzrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:19:42 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)) 18:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:19:42 INFO - Running setup.py (path:/tmp/pip-footPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:19:42 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)) 18:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:19:42 INFO - Running setup.py (path:/tmp/pip-BdVQ0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:19:43 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)) 18:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:19:43 INFO - Running setup.py (path:/tmp/pip-VZs8f3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:19:43 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)) 18:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:19:43 INFO - Running setup.py (path:/tmp/pip-ZrI_a8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:19:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:19:43 INFO - Running setup.py (path:/tmp/pip-xIwbRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:19:43 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)) 18:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:19:43 INFO - Running setup.py (path:/tmp/pip-Aklc46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:19:43 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)) 18:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:19:43 INFO - Running setup.py (path:/tmp/pip-ejESY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:19:43 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)) 18:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:19:43 INFO - Running setup.py (path:/tmp/pip-k1QVtr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:19:43 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)) 18:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:19:43 INFO - Running setup.py (path:/tmp/pip-KIzfyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:19:43 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)) 18:19:43 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)) 18:19:43 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)) 18:19:43 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)) 18:19:43 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)) 18:19:43 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)) 18:19:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:45 INFO - Downloading blessings-1.6.tar.gz 18:19:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:19:45 INFO - Installing collected packages: blessings 18:19:45 INFO - Running setup.py install for blessings 18:19:45 INFO - Successfully installed blessings 18:19:45 INFO - Cleaning up... 18:19:45 INFO - Return code: 0 18:19:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:19:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:19:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:19:46 INFO - Reading from file tmpfile_stdout 18:19:46 INFO - Current package versions: 18:19:46 INFO - argparse == 1.2.1 18:19:46 INFO - blessings == 1.6 18:19:46 INFO - blobuploader == 1.2.4 18:19:46 INFO - docopt == 0.6.1 18:19:46 INFO - functools32 == 3.2.3-2 18:19:46 INFO - jsonschema == 2.5.1 18:19:46 INFO - manifestparser == 1.1 18:19:46 INFO - mozInstall == 1.12 18:19:46 INFO - mozcrash == 1.0 18:19:46 INFO - mozdebug == 0.1 18:19:46 INFO - mozdevice == 0.49 18:19:46 INFO - mozfile == 1.2 18:19:46 INFO - mozhttpd == 0.7 18:19:46 INFO - mozinfo == 0.9 18:19:46 INFO - mozleak == 0.1 18:19:46 INFO - mozlog == 3.4 18:19:46 INFO - moznetwork == 0.27 18:19:46 INFO - mozprocess == 0.24 18:19:46 INFO - mozprofile == 0.28 18:19:46 INFO - mozrunner == 6.13 18:19:46 INFO - mozscreenshot == 0.1 18:19:46 INFO - mozsystemmonitor == 0.3 18:19:46 INFO - moztest == 0.8 18:19:46 INFO - mozversion == 1.4 18:19:46 INFO - psutil == 3.1.1 18:19:46 INFO - requests == 1.2.3 18:19:46 INFO - wsgiref == 0.1.2 18:19:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:19:46 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')]} 18:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:46 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')]} 18:19:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:46 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 0x27fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b70630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf9850>, '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 0x2b6e6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6eb60>, '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': '745a4373a2a16df560f216e000000264-1486861849.488943-1863273647', '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 18:19:46 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 18:19:46 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 18:19:46 INFO - Using env: {'DISPLAY': ':0', 18:19:46 INFO - 'HOME': '/home/cltbld', 18:19:46 INFO - 'LANG': 'en_US.UTF-8', 18:19:46 INFO - 'LANGUAGE': 'en_US:en', 18:19:46 INFO - 'LOGNAME': 'cltbld', 18:19:46 INFO - 'MAIL': '/var/mail/cltbld', 18:19:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:46 INFO - 'MOZ_NO_REMOTE': '1', 18:19:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:46 INFO - 'NO_EM_RESTART': '1', 18:19:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:46 INFO - 'PWD': '/builds/slave/test', 18:19:46 INFO - 'SHELL': '/bin/bash', 18:19:46 INFO - 'SHLVL': '1', 18:19:46 INFO - 'TERM': 'linux', 18:19:46 INFO - 'TMOUT': '86400', 18:19:46 INFO - 'USER': 'cltbld', 18:19:46 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1486861849.488943-1863273647', 18:19:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:46 INFO - '_': '/tools/buildbot/bin/python'} 18:19:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:46 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)) 18:19:46 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)) 18:19:46 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)) 18:19:46 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)) 18:19:46 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)) 18:19:46 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)) 18:19:46 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)) 18:19:46 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)) 18:19:46 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)) 18:19:46 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)) 18:19:46 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)) 18:19:46 INFO - Cleaning up... 18:19:46 INFO - Return code: 0 18:19:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:19:46 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')]} 18:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:46 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')]} 18:19:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:46 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 0x27fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b70630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf9850>, '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 0x2b6e6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6eb60>, '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': '745a4373a2a16df560f216e000000264-1486861849.488943-1863273647', '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 18:19:46 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 18:19:46 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 18:19:46 INFO - Using env: {'DISPLAY': ':0', 18:19:46 INFO - 'HOME': '/home/cltbld', 18:19:46 INFO - 'LANG': 'en_US.UTF-8', 18:19:46 INFO - 'LANGUAGE': 'en_US:en', 18:19:46 INFO - 'LOGNAME': 'cltbld', 18:19:46 INFO - 'MAIL': '/var/mail/cltbld', 18:19:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:46 INFO - 'MOZ_NO_REMOTE': '1', 18:19:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:46 INFO - 'NO_EM_RESTART': '1', 18:19:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:46 INFO - 'PWD': '/builds/slave/test', 18:19:46 INFO - 'SHELL': '/bin/bash', 18:19:46 INFO - 'SHLVL': '1', 18:19:46 INFO - 'TERM': 'linux', 18:19:46 INFO - 'TMOUT': '86400', 18:19:46 INFO - 'USER': 'cltbld', 18:19:46 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1486861849.488943-1863273647', 18:19:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:46 INFO - '_': '/tools/buildbot/bin/python'} 18:19:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:19:46 INFO - Cleaning up... 18:19:46 INFO - Return code: 0 18:19:46 INFO - Running post-action listener: _resource_record_post_action 18:19:46 INFO - Running post-action listener: _start_resource_monitoring 18:19:46 INFO - Starting resource monitoring. 18:19:46 INFO - [mozharness: 2017-02-12 02:19:46.494761Z] Finished create-virtualenv step (success) 18:19:46 INFO - [mozharness: 2017-02-12 02:19:46.495280Z] Running install step. 18:19:46 INFO - Running pre-action listener: _resource_record_pre_action 18:19:46 INFO - Running main action method: install 18:19:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:19:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:19:46 INFO - Reading from file tmpfile_stdout 18:19:46 INFO - Detecting whether we're running mozinstall >=1.0... 18:19:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:19:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:19:46 INFO - Reading from file tmpfile_stdout 18:19:46 INFO - Output received: 18:19:46 INFO - Usage: mozinstall [options] installer 18:19:46 INFO - Options: 18:19:46 INFO - -h, --help show this help message and exit 18:19:46 INFO - -d DEST, --destination=DEST 18:19:46 INFO - Directory to install application into. [default: 18:19:46 INFO - "/builds/slave/test"] 18:19:46 INFO - --app=APP Application being installed. [default: firefox] 18:19:46 INFO - mkdir: /builds/slave/test/build/application 18:19:46 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'] 18:19:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:20:03 INFO - Reading from file tmpfile_stdout 18:20:03 INFO - Output received: 18:20:03 INFO - /builds/slave/test/build/application/firefox/firefox 18:20:03 INFO - Running post-action listener: _resource_record_post_action 18:20:03 INFO - [mozharness: 2017-02-12 02:20:03.076435Z] Finished install step (success) 18:20:03 INFO - [mozharness: 2017-02-12 02:20:03.076715Z] Running run-tests step. 18:20:03 INFO - Running pre-action listener: _resource_record_pre_action 18:20:03 INFO - Running main action method: run_tests 18:20:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:20:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:20:03 INFO - Python 2.7.3 18:20:03 INFO - Return code: 0 18:20:03 INFO - grabbing minidump binary from tooltool 18:20: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')]} 18:20:03 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 0x2bf9850>, '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 0x2b6e6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6eb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:20:03 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 18:20:03 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 18:20:03 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 18:20:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:20:03 INFO - Return code: 0 18:20:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:20:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:20:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:20:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:20:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:20:03 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/Zz1_d1s5T-aWQ-8dLcFa6g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 18:20:03 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/Zz1_d1s5T-aWQ-8dLcFa6g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 18:20:03 INFO - Using env: {'DISPLAY': ':0', 18:20:03 INFO - 'HOME': '/home/cltbld', 18:20:03 INFO - 'LANG': 'en_US.UTF-8', 18:20:03 INFO - 'LANGUAGE': 'en_US:en', 18:20:03 INFO - 'LOGNAME': 'cltbld', 18:20:03 INFO - 'MAIL': '/var/mail/cltbld', 18:20:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:20:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:20:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:03 INFO - 'MOZ_NO_REMOTE': '1', 18:20:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:20:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:03 INFO - 'NO_EM_RESTART': '1', 18:20:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:03 INFO - 'PWD': '/builds/slave/test', 18:20:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:20:03 INFO - 'SHELL': '/bin/bash', 18:20:03 INFO - 'SHLVL': '1', 18:20:03 INFO - 'TERM': 'linux', 18:20:03 INFO - 'TMOUT': '86400', 18:20:03 INFO - 'USER': 'cltbld', 18:20:03 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1486861849.488943-1863273647', 18:20:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:03 INFO - '_': '/tools/buildbot/bin/python'} 18:20:03 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/Zz1_d1s5T-aWQ-8dLcFa6g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 18:20:03 INFO - mozversion application_buildid: 20170212014256 18:20:03 INFO - mozversion application_changeset: 09ef6a4f41186ea6951830d1506f741005dcc46f 18:20:03 INFO - mozversion application_display_name: Nightly 18:20:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:20:03 INFO - mozversion application_name: Firefox 18:20:03 INFO - mozversion application_remotingname: firefox 18:20:03 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:20:03 INFO - mozversion application_vendor: Mozilla 18:20:03 INFO - mozversion application_version: 54.0a1 18:20:03 INFO - mozversion platform_buildid: 20170212014256 18:20:03 INFO - mozversion platform_changeset: 09ef6a4f41186ea6951830d1506f741005dcc46f 18:20:03 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:20:03 INFO - mozversion platform_version: 54.0a1 18:20:03 INFO - using testdate: 1486866003 18:20:03 INFO - actual date: 1486866003 18:20:03 INFO - starting webserver on 'localhost:40051' 18:20:03 INFO - SUITE-START | Running 2 tests 18:20:03 INFO - TEST-START | dromaeo_css 18:20:03 INFO - operating with platform_type : linux_ 18:20:03 INFO - Initialising browser for dromaeo_css test... 18:20:03 INFO - TEST-INFO | started process 29954 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps9PSeX/profile http://localhost:40051/getInfo.html) 18:20:07 INFO - PROCESS | 29954 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 18:20:08 INFO - PROCESS | 29954 | __metrics Screen width/height:1600/1200 18:20:08 INFO - PROCESS | 29954 | colorDepth:24 18:20:08 INFO - PROCESS | 29954 | Browser inner width/height: 1024/697 18:20:08 INFO - PROCESS | 29954 | __metrics 18:20:09 INFO - PROCESS | 29954 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:20:09 INFO - PROCESS | 29954 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:20:09 INFO - PROCESS | 29954 | console.error: PushService: 18:20:09 INFO - PROCESS | 29954 | stateChangeProcessEnqueue: Error transitioning state 18:20:09 INFO - PROCESS | 29954 | UnknownError 18:20:10 INFO - TEST-INFO | 29954: exit 0 18:20:10 INFO - Browser initialized. 18:20:10 INFO - Running cycle 1/1 for dromaeo_css test... 18:20:10 INFO - TEST-INFO | started process 30038 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps9PSeX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:20:22 INFO - PROCESS | 30038 | RSS: Main: 154054656 18:20:22 INFO - PROCESS | 30038 | 18:23:29 INFO - PROCESS | 30038 | Cycle 1(1): loaded http://localhost:40051/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40051/tests/dromaeo/cssquery-ext.html) 18:23:30 INFO - PROCESS | 30038 | RSS: Main: 247496704 18:23:30 INFO - PROCESS | 30038 | 18:25:12 INFO - PROCESS | 30038 | ************************* 18:25:12 INFO - PROCESS | 30038 | A coding exception was thrown and uncaught in a Task. 18:25:12 INFO - PROCESS | 30038 | 18:25:12 ERROR - PROCESS | 30038 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:25:12 INFO - PROCESS | 30038 | Full stack: 18:25:12 INFO - PROCESS | 30038 | ************************* 18:26:33 INFO - PROCESS | 30038 | Cycle 1(1): loaded http://localhost:40051/tests/dromaeo/cssquery-ext.html (next: http://localhost:40051/tests/dromaeo/cssquery-jquery.html) 18:26:33 INFO - PROCESS | 30038 | RSS: Main: 237101056 18:26:33 INFO - PROCESS | 30038 | 18:29:35 INFO - PROCESS | 30038 | Cycle 1(1): loaded http://localhost:40051/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40051/tests/dromaeo/cssquery-mootools.html) 18:29:36 INFO - PROCESS | 30038 | RSS: Main: 252915712 18:29:36 INFO - PROCESS | 30038 | 18:32:38 INFO - PROCESS | 30038 | Cycle 1(1): loaded http://localhost:40051/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40051/tests/dromaeo/cssquery-prototype.html) 18:32:39 INFO - PROCESS | 30038 | RSS: Main: 187285504 18:32:39 INFO - PROCESS | 30038 | 18:35:42 INFO - PROCESS | 30038 | Cycle 1(1): loaded http://localhost:40051/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40051/tests/dromaeo/cssquery-yui.html) 18:35:43 INFO - PROCESS | 30038 | RSS: Main: 189104128 18:35:43 INFO - PROCESS | 30038 | 18:38:46 INFO - PROCESS | 30038 | Cycle 1(1): loaded http://localhost:40051/tests/dromaeo/cssquery-yui.html (next: http://localhost:40051/tests/dromaeo/cssquery-dojo.html) 18:38:46 INFO - PROCESS | 30038 | RSS: Main: 280457216 18:38:46 INFO - PROCESS | 30038 | 18:38:46 INFO - PROCESS | 30038 | __start_tp_report 18:38:46 INFO - PROCESS | 30038 | _x_x_mozilla_page_load 18:38:46 INFO - PROCESS | 30038 | _x_x_mozilla_page_load_details 18:38:46 INFO - PROCESS | 30038 | |i|pagename|runs| 18:38:46 INFO - PROCESS | 30038 | |0;dojo.html;2565.5382031234376;2584.1472314136336;2610.3604616868865;2618.0444137889663;2622.1346955504687;4611.3774640423535;4685.765711714409;4774.665773395859;4775.737334446604;4780.4980477049885;4625.653076019295;4664.743439110847;4710.858674239778;4741.193997020515;4791.856244312677;4215.388768628547;4330.610245077943;4353.608175264226;4450;4481.170983368087;4401.911961760763;4468.307412351074;4469.3296005599095;4481.417415735966;4514.435695538058;4299.14017196562;4335.981044454551;4337.587929146757;4338.674599405057;4385.320275357293;4389.341598760179;4402.427684401039;4444.955550444486;4448.621867141297;4453.042595841877;4358.0848021915435;4363.694541382105;4372;4376.584224498668;4434.091011342667;4616.5152658970665;4628.606568441686;4637.953620463786;4753.168195565762;4805.903881922377;5022.196448568212;5059.569936555397;5065;5069.239614057884;5102.6173037022;5091.592672586185;5097.184450487941;5100.183970564729;5104.897902041976;5152.407473140599;4653.046125544255;4847.369841920563;4847.61219102478;4850.733209673502;4892.290617860391;5063.87340316495;5158.993996170786;5207.973960130175;5251.842444726664;5253.763580638881;4882.487338829443;4937.061958227925;4963.230699241623;4987.551120399182;5019.272205530177;5071.492850714899;5100.6684565503865;5114.360704911886;5115.769790359443;5164.8192313268855;4896.46138924718;5045.091883461012;5074.771635276347;5084.2627818966785;5097.235414687826;4940.357753492023;4989.027139707722;5011.498850114959;5017.67385119966;5059.2916991621205;4331.480222373335;4336.436263285816;4345.044090300129;4361.80371883266;4374.825006999748;3732;3747.775133491945;3759.736818422739;3781.7541859779026;3785.545734511821;4346.978265108654;4377.1683380157665;4401.449818772653;4441.888952776142;4463.821447142078;5096.362954630671;5101.413337466165;5106.208537676666;5142.948570514247;5155.948440515622;4428.867133985986;4431.556844315607;4433.667474939392;4474.306482495218;4474.7762611869275;4419.049904270597;4458.86623401292;4520.0507893341455;4567.040921406542;4580.496145424001;4768.451628062817;4795.9280610790165;4800.3759511263315;4826.372571565674;4842.927356089591;5066.721330326867;5088.641496612218;5105.081085404663;5116.1814109743755;5154.819581314636;4581.908361832811;4617.930731039104;4779.976100119477;4798.73606951621;4837.661363704507;4919.901601967869;4923.384576927884;4959.057779021974;5032.773525191302;5053.898922021613;5116.692998420107;5117.232415137759;5121.769520371667;5125.461826508163;5128.205128205134;4854.393200849894;4891.021795640957;4897;4904.901901961869;4912.508749125059;4944.851654450372;4965.230389289666;4966.255061740768;4974.253861920741;5026.120428924996;4770.308305295782;4790.760461976957;4832.468428472936;4833.202521583899;4894;4853.956399374151;4937.77779999908;4942.357493525962;4953.777080031479;5001.549860512426;4840.588549973291;4846.600932538416;4847.321375007572;4849.660523763444;4897.338859253955 18:38:46 INFO - PROCESS | 30038 | |1;ext.html;526.9552088072513;548.3036543589639;556.8858384031274;558.5252535344957;561.7528287553479;29697.851510742443;38813.417798733004;39269.803650981776;39305.41041884374;41874.58125418745;39075.21849563007;39320.60679393205;39387.80306098473;39440.60559394405;39530.60469395305;7491.25087491252;7724.691012359499;7735.419843511731;7742.187070357616;7750.5349679019155;7182.784516464514;7369.594672293022;9319.161275485205;9540.236781057498;9554.140127388533;9814.018598140165;9901.158401535879;9901.20790336775;9906.851397229048;9908.603655853793;9724.416535007887;9815.460149691764;9828.4102953823;9828.705138845846;9835.803283934352;9620.518974051269;9694.466804325759;9696.17582505488;9698.224142068617;9699.078587534173;36318.63681363205;36602.26795464102;36640.26719465596;36656.26687466236;36716.63283367186;3476.200473890994;3534.5935217450065;3551.94672079919;3576.409892367756;3634.254977729559;26462.73537264622;26617.20148395532;26660.46679066427;26733.732662673512;27376.178714638594;3383.374075795986;3397.167693914982;3472.340255351475;3502.176988407722;3628.872989445357;235502.82248588817;236450;236915;237123;237636;44439.55560444419;50911;51220;51242.48757512452;51288;43371.783141084095;52523.73738131285;53378.46621533813;53911;58224;13885.514007009908;14122.576322710334;14134.293285335692;14135.363908624136;14145.222012789189;10876.456177191109;11096.5561377544;11101.38942358178;11115.666530004113;11125.332480051224;13025.609231723063;13308.800367994489;13335.466581336832;13671.794923076162;14424.567262982127;5595.916061259084;5844.357120716718;5887.2052272943465;5984;5998.910016349758;749.3031480722871;786.7915002524336;794.2216627704881;795.0975642645639;812.4515951732675;25832.870835645703;26280.73719262821;26780.330491737863;26823.329416764736;26833.597496037575;938.6949241496404;947.1901524196712;952.8570714392758;958.9568469418892;960.3085778239656;13819.239941803296;13873.167609943435;13913.373898174606;13957.79063314051;14014.159150451005;326630;329164;329531;330662;330737;46142.30786538205;46336.304955425694;46532;46570.5342946573;46592.7670361646;1136.2046567402851;1191.0352614382377;1191.8033524468365;1198.6703656494533;1207.3178654060603;23971.500119246888;25061;25568.744312556635;25613;25752.227433177035;38597.68413895175;38708.61291387163;39112;39250.411243831935;39272.80363598164;263226;263992;264251;264317.03524446767;265865;21757;22411.663825042964;24320.148794792098;24644.658757418016;24668;30909.69090309158;30995;31864.68135318617;34381;43088.35367469428;35369.82315088408;36234;36372.818135909154;37254.8137259312;37965.81017095008;35582.822085889406;35633.46549801807;36484.63515364812;36792;36812;35994.10014749652;36339.63660363468;36512.08719782027;37049.25901482009;37137.25725485421;29494.705052949197;31736.682633173372;32734.181645459055;32883.34233315368;32914.34171316608;24064.278071657878;24333.878330608943;24797.25608231756;25453.3636659085;27547.724522754517 18:38:46 INFO - PROCESS | 30038 | |2;jquery.html;373.88222709846394;382.902359898226;392.550529643558;394.92693851637443;417.3218519905154;15313.310901009454;16982.830171698293;17047.659046819088;17050;17266.82733172668;17491.300347986064;17597.3840915568;17726.734098988527;17778.64442711145;18056;5040.773165207565;5261.1056120459425;5261.1319132343115;5262.184361423985;5264.8157314494;5063.31645227895;5094.974525127369;5353.973230133844;5384.326959130109;5456.727163641822;5446.046941785192;5454.181872719084;5456.48163424474;5456.590755693319;5465.125579907216;5419.132938729804;5876.676782776945;5909.999999999978;5935.198748168985;5944.643321400687;5150.896982060338;5281.181416880389;5294.655847369947;5300.886813769113;5342.572594192456;12658.620241392773;12911.418986145645;12984.805227921493;12994.610161695164;13002;2353.376355265856;2393.6529203265604;2402.267308470916;2415.516896620665;2448.6082226843796;9301.953490232574;9416.529173541296;9517.048295170496;9679.90320096797;11131.276467029698;1669.2071266148603;1705.7100292950229;1710.7006273902018;1726.7841519810024;1737.1487970894298;71406;73769;74034.62982685052;75107.62446187733;76342.61828690821;10714;10830.945845270724;10851.728706782395;10948.835767463494;11064.05955493776;15115;15153.924230378778;15163.924180379028;15168.469103581321;15207.239638018054;6657.866842663119;6799.728010879509;6888.070110535114;6982.2319544850025;6997.545159564612;6085.300190478151;6107.358727333566;6284.780032698834;6291.748330066746;6300.7479700811455;4451.1765323415275;4587.587117159472;4683.7892294846815;4722.126406614719;4837.782299796518;1876.9061546922599;1914.3491212987371;1940.262700173925;1942.5823447958473;1946.0756140833273;714.125196634119;730.455810421229;738.9150247721474;744.5346658338539;750.4709180028067;17222.397216097375;17228.483145505656;17949.192286347145;18018;18294.451166465027;717.1752484642702;732.0995175933632;743.2121950732242;749.3518106837655;751.5265382808795;9629.711108666612;9953.353032053039;10022.649207277856;10028.598856045823;10105.987680490873;435227;445334;450360;456241;458968;83089;83346;83967;84183.15816841875;85667.14332856591;906.1572737354323;907.5870478932202;927.9768005799909;931.4457897550947;932.5710173320213;14766.926165369105;14810.444903285432;15138.924305378403;16203.75694364609;16469.752953705465;37670.62329376671;38116;38678;39089.80455097706;39475.40786888256;50839.2374114396;50936.74531627318;50979.49020509747;51340.486595133574;52080.73959630178;7946.8807967879375;7957.244061814118;7979.72070977513;7982.560959147303;8336.041355243982;8763;11426.314421134759;11732.12009099304;12421.93789031049;12580.811287830873;10485;10505.422201778976;10524.894751052392;10894.346339219672;11172.273802202832;10201;10458.163346932379;11219.326840389604;11238.66284011481;11252.549898003988;10591.364518128938;10958.506867190836;11026.558937642725;11100.944495277472;11496.367699776258;8053.234942680436;8104.959475202586;8257.917420825715;8266.173382661686;8300.418970672237;9240.907590924005;10944.835827462754;11047.116230701686;11115.944420277847;11316.94341528287 18:38:46 INFO - PROCESS | 30038 | |3;mootools.html;1191.1602320364145;1325.3638253638253;1367.6717587778933;1368.7330970460757;1372.8833049190819;6166.691665416728;7110.5733655980675;7285.781426557199;7355.595442250681;7591.658375373107;7365.742199023022;7421.369183619398;7440.330370266688;7444.739434119807;7445.739399121032;2085.906134223956;2121.692354608581;2121.7666056733747;2122.670985997165;2122.8301735861173;1706.940257091002;1769.27459741506;2071.140476702167;2133.7866213378616;2136.433845031068;1986;1997.5904939487443;1998.560316730317;1999.8000199979958;2000.249906285143;2011.859169858103;2050.39513343564;2051.138521820839;2055.7738648748627;2062.4431403521116;1989.4031790462802;2027.8174964253287;2046.6213750456213;2051.2307884543297;2080.573482436097;7293.4894557381;7385.409167266659;7392.926070739278;7393;7394.112706475204;4455.554444555551;4577.771111444415;4589.678722489427;4591.885202869921;4594.081183763261;2775.084222206667;2943.7350638442645;2963.155500682317;3025.667176610571;3030.1818509002665;1077.5312738958578;1145.6448500964643;1152.8443660105863;1196.3539688568162;1235.234154824015;9946.20430365569;10000.549975251131;10009.099181073738;10017.449040302781;10029.59881604735;3890.5720370759195;4063.329550624173;4170.791460426966;4178.540360560336;4200.831966721297;8570.228679418882;8570.914290857012;8576.742697719079;8578.313734901192;8581.227689507974;4631;4631.560001799824;4632.258838585877;4632.444106707217;4639.37368455261;3992.1416895367634;4113.753174809462;4180.811863466151;4187.581241875788;4195.202911446815;3446.293509830479;3488.8255587220538;3572.4819901114192;3615.222727113683;3627.238279961185;1142.520141540555;1155.7052951497483;1182.9704257393462;1196.1806162778526;1198.3109711915683;801.1187693537179;801.1787917384611;811.3144392987916;814.7596459044596;822.7535284044677;4954.430240522314;5087.465816089331;5097.923531147036;5111.05445492585;5114.43741188469;529.2669652531272;534.5162627821827;537.3149234725756;554.7032337699311;556.1407625219047;3286.868525258963;3325.617553981275;3338.7329013678846;3339.833008349573;3459.08334291413;8549.615267312985;8908;8918.777030574287;8945.821083578292;8960.849396144878;8812.369711603375;8867.334949878656;8867.467951922905;8972.910270897339;8977.596008179647;6659.433948114368;6729.6971636276485;6749.662516874137;6752.729890804411;6759.932400675931;4909.9018019640125;4953.876153096201;4991.201407774739;5022.949770502249;5237.188235823453;7989.680412783424;8003.679852806055;8102.473339232931;8177.509349439053;8198.959005204935;8138.389620778347;8266.751997440086;8281.21328473794;8295.58522073906;8368.12134725845;5549.112142057252;5742.626729262584;5974.581779275409;6084.209052823105;6428.19647544057;6901.89647155283;6960.303969602999;6963.895541566982;6968.895466568107;6976.441884649114;6234.470070044097;6243.250809902841;6321.589096708699;6332.746690132343;6461.838454038687;6056.242969628796;6070.969645151746;6120.846978825387;6122;6198.380161983766;5734.569907256889;5878.147668587945;5880.735366908585;5890.9116363253725;5894.6736984178215;4308.5260621331;4375.124975004948;4443.3334999749;4459.48715897663;4483.394741709827;4399.802008909671;4490.640748740027;4561.429821272341;4617.653675974382;4682.484926657997 18:38:46 INFO - PROCESS | 30038 | |4;prototype.html;357.1392943007353;360.4629102637071;362.62468345262624;366.99082522936925;369.6617594900665;4782.880427989302;4810.230363141898;4814.374131362927;4849.8545043648655;4854.902901941963;4644.396228490292;4788.371953535797;4790.2096154134615;4808.663393562452;4814.229723244282;3817.236552689459;3830.636089571486;3832.9808350958274;3833.4824798652244;3850.3839385698293;3808.7905165215902;3810.2379524095154;3821.7579286731784;3825.387937929932;3862.671672907792;3799.7910114943807;3804.885853424402;3811.561670407897;3827.1771569112634;3847.9615203847884;3589.4974703541525;3768.2651882882847;3798.2213646202463;3837.750546214501;3842.3275926712995;3326.76712630116;3333.116853921365;3336.6496517865517;3351.7988920664593;3353.2622822978906;4720.811167553294;4728.6453515986095;4732.385923724376;4734.313524538922;4734.905301893943;4196.58034196581;4320.308750599889;4329.935050974238;4334.263175260214;4337.7397356158735;5006.6245031622775;5039.344885164942;5044.192929131322;5068.4424713281505;5102.209157580581;3639.253952939641;3640.10817349751;3661.963380366189;3666.3767159582935;3676.191237927652;5063.291139240509;5066.721330326831;5165.793368265265;5329.546988505982;5339;3629.7640653357976;3668.0463079599494;3682.5396825396824;3699.2231631357176;3708.5364329458816;3740.9625903741157;3752.418375151856;3752.5309336332957;3755.6244375562223;3758.229562939591;3995.4606128172904;4101.364288535282;4286.142771445661;4292.720973136736;4308.353746937922;4945.184044632667;5044.924326135111;5062.696238225718;5071.644984851025;5089.37140115167;1237.1525505028903;1243.2975368916534;1245.6138597034949;1245.6325384011739;1246.7194881151668;792.18405042806;848.6902280667512;848.8854004709285;857.1428571428571;857.1557016338901;4350.95577061503;4354.564543545684;4361.80371883266;4361.847335343311;4371.229651990949;5072.51811077947;5073.086844367976;5090.745462726849;5091.236314552847;5107.850733584988;4294.183467148301;4355.629771469397;4368.716033457815;4383.693141480066;4384.802683879233;2575.330414092312;2682.906098286551;2686.5029969455713;2692.569188929762;2706.404590989979;4709.222978208626;4727.361806156194;4729;4759.309900064472;4760.33355330254;4862.1556389511825;5112.258722485219;5129.897402051938;5130.614734021793;5146.275997540791;4747.311639812277;4749.715017098985;4774.665773395829;4780.378550788445;4795.808167673324;5036.823711170092;5048.495150484922;5077.7715002824225;5084.694918304914;5094.7962081516325;4844.297576851266;4983.377077865267;4984.155862330816;4985.825496107619;5034.723090230073;4680.7191568506;4814.566688998007;4891.364122664031;4924.187509060965;4930.630202734881;3610.8736194233074;3707.7033837293493;3709.8516059357326;3716.4239542870896;3719.2375563008977;5252.212168174804;5252.238425428368;5253.684778913277;5259.501042203106;5272.235525848807;4937.481564435682;5072.224721347498;5096.261042148942;5097.6941383517105;5109.156989096906;5018.841897983756;5057.69653820772;5073.923891141562;5079.974600127123;5086.847394578169;5018.84943451697;5025.623078269071;5032.257419706196;5032.43994361749;5046.829863158877;4930.630202734737;5076.162433198481;5093;5116.28372027909;5123.359580052494;4983.975080124576;4987.401511818605;4988.501149884983;4995.550400463976;4998.750062496788 18:38:46 INFO - PROCESS | 30038 | |5;yui.html;650.6128853332272;664.451827242525;712.1301156339952;725.5356571794051;736.4623824608036;12116.333601651906;12391.132620716542;12430.316332601726;12472.875271247285;13184.538541151062;11125.388103654295;12351.814722779165;12456.81314780279;12496.375181240925;12623.368831558431;816.9836603267931;829.9336053115767;831.4969443486694;831.9875201871946;834.2950207075012;823.069930977994;825.0717942314895;825.1130035212141;825.1954344514111;825.8513467575864;866.5883705240024;867.2108381372952;867.3928250224836;867.6963062927956;867.9305655547572;852.765489490392;857.2841677199546;861.3066481482405;862.9093945135764;863.2317237658489;626.2797782550058;626.8589567347356;630.6562923206817;632.1623848400841;632.2128949457908;11306.095512358992;11349.602763903224;11481.425928703531;11486.655400338002;11819.881801181964;10666.73333166677;11560.6531804046;11881;11999.52001919922;12168.57409990655;11725.824112638316;11805.58680446189;11955.462004209832;12009.819852702216;12096.758064838654;3885.3977633466857;3950.328444164499;3966.4248683940955;3994.560598334181;4035.878923632296;39799.4030089546;41247.175056499;41324.586754132375;45852.31221531713;59627.40372596262;6094.603850749776;9286.30352723535;10143.340682855738;10478.842817357745;10548.630797922036;18862.71705924412;19072.33246836354;19101.904490477737;19186.904065479583;19199.712004319947;6849.931500685029;6891.310868913069;6902.102726645604;6924.6537673116145;7149;3631.418972964313;3735.402335626287;3750.1187221003042;3753.474513568103;3759.3233218020473;3123.656397796286;3181.936361272808;3186.235303527183;3219.3561287742546;3220.1144685211284;556.4935908323406;557.799192290775;559.6222549778882;559.7648987425291;573.2776701356238;563.9266895303584;580.7909152705023;589.6845187824493;600.1507866369126;600.3066458240739;8108.2297181767635;8534.189252021048;8666.793286483915;8748.212660860552;8996.955015225012;558.6452602597379;580.494969376645;587.1838144978483;590.9822705318848;591.7248479457073;3777.4522694209186;3813.7521061130938;3889.8638547651262;3907.374820028782;3943.507061617298;62332.376676233565;64594.35405645977;64678.67660661667;64700;67976.32023679798;52750.472495275324;54576.181357279675;54992;55413.722931385084;55680.44319556834;45611.77194114008;49920.251196232086;50028.74985625121;50103.74948125236;50232.246516302286;8490.490570565786;9284.164859002007;9685.564149613425;9700.197474717219;9703.223742100756;33991.320173595894;34481.827590862886;35855.28289434249;36447.81776091103;36474.452883207305;40728.59271407367;43980.56019439764;44038.77980610076;44643.55356446524;45993.77003114963;9692.273079518924;9764.170045545923;9802.117809397188;9870.605175792887;10152.39085654863;12374.319412432402;12774.936125319315;13150.736985260433;13203.801942970671;13565.118267312593;12237.571684990982;12628.11603187768;12656.303903285409;12836.935815320863;13127.606171814861;11103;11508.94245528767;11510.769784604428;11516.30902145874;11605.30368177912;11877.406129693654;12024.278543287432;12347.444365003776;12363.876361236273;12507.812382814083;9271.582778774837;9484.668036618685;9657.9034209657;9730.22158227326;9791.902080979098;8552.871706924525;9184.770380740534;9500.334976551852;9502.239820814457;9558.665446709332 18:38:46 INFO - PROCESS | 30038 | __end_tp_report 18:38:46 INFO - PROCESS | 30038 | __start_cc_report 18:38:46 INFO - PROCESS | 30038 | _x_x_mozilla_cycle_collect,1128 18:38:46 INFO - PROCESS | 30038 | __end_cc_report 18:38:46 INFO - PROCESS | 30038 | __startTimestamp1486867126371__endTimestamp 18:38:46 INFO - PROCESS | 30038 | 18:38:46 INFO - PROCESS | 30038 | ------- Summary: start ------- 18:38:46 INFO - PROCESS | 30038 | Number of tests: 6 18:38:46 INFO - PROCESS | 30038 | 18:38:46 INFO - PROCESS | 30038 | [#0] dojo.html Cycles:165 Average:4691.29 Median:4833.20 stddev:492.68 (10.2%) stddev-sans-first:465.12 18:38:46 INFO - PROCESS | 30038 | Values: 2565.5 2584.1 2610.4 2618.0 2622.1 4611.4 4685.8 4774.7 4775.7 4780.5 4625.7 4664.7 4710.9 4741.2 4791.9 4215.4 4330.6 4353.6 4450.0 4481.2 4401.9 4468.3 4469.3 4481.4 4514.4 4299.1 4336.0 4337.6 4338.7 4385.3 4389.3 4402.4 4445.0 4448.6 4453.0 4358.1 4363.7 4372.0 4376.6 4434.1 4616.5 4628.6 4638.0 4753.2 4805.9 5022.2 5059.6 5065.0 5069.2 5102.6 5091.6 5097.2 5100.2 5104.9 5152.4 4653.0 4847.4 4847.6 4850.7 4892.3 5063.9 5159.0 5208.0 5251.8 5253.8 4882.5 4937.1 4963.2 4987.6 5019.3 5071.5 5100.7 5114.4 5115.8 5164.8 4896.5 5045.1 5074.8 5084.3 5097.2 4940.4 4989.0 5011.5 5017.7 5059.3 4331.5 4336.4 4345.0 4361.8 4374.8 3732.0 3747.8 3759.7 3781.8 3785.5 4347.0 4377.2 4401.4 4441.9 4463.8 5096.4 5101.4 5106.2 5142.9 5155.9 4428.9 4431.6 4433.7 4474.3 4474.8 4419.0 4458.9 4520.1 4567.0 4580.5 4768.5 4795.9 4800.4 4826.4 4842.9 5066.7 5088.6 5105.1 5116.2 5154.8 4581.9 4617.9 4780.0 4798.7 4837.7 4919.9 4923.4 4959.1 5032.8 5053.9 5116.7 5117.2 5121.8 5125.5 5128.2 4854.4 4891.0 4897.0 4904.9 4912.5 4944.9 4965.2 4966.3 4974.3 5026.1 4770.3 4790.8 4832.5 4833.2 4894.0 4854.0 4937.8 4942.4 4953.8 5001.5 4840.6 4846.6 4847.3 4849.7 4897.3 18:38:46 INFO - PROCESS | 30038 | 18:38:46 INFO - PROCESS | 30038 | [#1] ext.html Cycles:180 Average:43035.48 Median:19986.95 stddev:73159.06 (366.0%) stddev-sans-first:73294.67 18:38:46 INFO - PROCESS | 30038 | Values: 527.0 548.3 556.9 558.5 561.8 29697.9 38813.4 39269.8 39305.4 41874.6 39075.2 39320.6 39387.8 39440.6 39530.6 7491.3 7724.7 7735.4 7742.2 7750.5 7182.8 7369.6 9319.2 9540.2 9554.1 9814.0 9901.2 9901.2 9906.9 9908.6 9724.4 9815.5 9828.4 9828.7 9835.8 9620.5 9694.5 9696.2 9698.2 9699.1 36318.6 36602.3 36640.3 36656.3 36716.6 3476.2 3534.6 3551.9 3576.4 3634.3 26462.7 26617.2 26660.5 26733.7 27376.2 3383.4 3397.2 3472.3 3502.2 3628.9 235502.8 236450.0 236915.0 237123.0 237636.0 44439.6 50911.0 51220.0 51242.5 51288.0 43371.8 52523.7 53378.5 53911.0 58224.0 13885.5 14122.6 14134.3 14135.4 14145.2 10876.5 11096.6 11101.4 11115.7 11125.3 13025.6 13308.8 13335.5 13671.8 14424.6 5595.9 5844.4 5887.2 5984.0 5998.9 749.3 786.8 794.2 795.1 812.5 25832.9 26280.7 26780.3 26823.3 26833.6 938.7 947.2 952.9 959.0 960.3 13819.2 13873.2 13913.4 13957.8 14014.2 326630.0 329164.0 329531.0 330662.0 330737.0 46142.3 46336.3 46532.0 46570.5 46592.8 1136.2 1191.0 1191.8 1198.7 1207.3 23971.5 25061.0 25568.7 25613.0 25752.2 38597.7 38708.6 39112.0 39250.4 39272.8 263226.0 263992.0 264251.0 264317.0 265865.0 21757.0 22411.7 24320.1 24644.7 24668.0 30909.7 30995.0 31864.7 34381.0 43088.4 35369.8 36234.0 36372.8 37254.8 37965.8 35582.8 35633.5 36484.6 36792.0 36812.0 35994.1 36339.6 36512.1 37049.3 37137.3 29494.7 31736.7 32734.2 32883.3 32914.3 24064.3 24333.9 24797.3 25453.4 27547.7 18:38:46 INFO - PROCESS | 30038 | 18:38:46 INFO - PROCESS | 30038 | [#2] jquery.html Cycles:180 Average:26339.43 Median:453300.50 stddev:74075.84 (16.3%) stddev-sans-first:74257.98 18:38:46 INFO - PROCESS | 30038 | Values: 373.9 382.9 392.6 394.9 417.3 15313.3 16982.8 17047.7 17050.0 17266.8 17491.3 17597.4 17726.7 17778.6 18056.0 5040.8 5261.1 5261.1 5262.2 5264.8 5063.3 5095.0 5354.0 5384.3 5456.7 5446.0 5454.2 5456.5 5456.6 5465.1 5419.1 5876.7 5910.0 5935.2 5944.6 5150.9 5281.2 5294.7 5300.9 5342.6 12658.6 12911.4 12984.8 12994.6 13002.0 2353.4 2393.7 2402.3 2415.5 2448.6 9302.0 9416.5 9517.0 9679.9 11131.3 1669.2 1705.7 1710.7 1726.8 1737.1 71406.0 73769.0 74034.6 75107.6 76342.6 10714.0 10830.9 10851.7 10948.8 11064.1 15115.0 15153.9 15163.9 15168.5 15207.2 6657.9 6799.7 6888.1 6982.2 6997.5 6085.3 6107.4 6284.8 6291.7 6300.7 4451.2 4587.6 4683.8 4722.1 4837.8 1876.9 1914.3 1940.3 1942.6 1946.1 714.1 730.5 738.9 744.5 750.5 17222.4 17228.5 17949.2 18018.0 18294.5 717.2 732.1 743.2 749.4 751.5 9629.7 9953.4 10022.6 10028.6 10106.0 435227.0 445334.0 450360.0 456241.0 458968.0 83089.0 83346.0 83967.0 84183.2 85667.1 906.2 907.6 928.0 931.4 932.6 14766.9 14810.4 15138.9 16203.8 16469.8 37670.6 38116.0 38678.0 39089.8 39475.4 50839.2 50936.7 50979.5 51340.5 52080.7 7946.9 7957.2 7979.7 7982.6 8336.0 8763.0 11426.3 11732.1 12421.9 12580.8 10485.0 10505.4 10524.9 10894.3 11172.3 10201.0 10458.2 11219.3 11238.7 11252.5 10591.4 10958.5 11026.6 11100.9 11496.4 8053.2 8105.0 8257.9 8266.2 8300.4 9240.9 10944.8 11047.1 11115.9 11316.9 18:38:46 INFO - PROCESS | 30038 | 18:38:46 INFO - PROCESS | 30038 | [#3] mootools.html Cycles:180 Average:4834.32 Median:4954.15 stddev:2646.99 (53.4%) stddev-sans-first:2640.25 18:38:46 INFO - PROCESS | 30038 | Values: 1191.2 1325.4 1367.7 1368.7 1372.9 6166.7 7110.6 7285.8 7355.6 7591.7 7365.7 7421.4 7440.3 7444.7 7445.7 2085.9 2121.7 2121.8 2122.7 2122.8 1706.9 1769.3 2071.1 2133.8 2136.4 1986.0 1997.6 1998.6 1999.8 2000.2 2011.9 2050.4 2051.1 2055.8 2062.4 1989.4 2027.8 2046.6 2051.2 2080.6 7293.5 7385.4 7392.9 7393.0 7394.1 4455.6 4577.8 4589.7 4591.9 4594.1 2775.1 2943.7 2963.2 3025.7 3030.2 1077.5 1145.6 1152.8 1196.4 1235.2 9946.2 10000.5 10009.1 10017.4 10029.6 3890.6 4063.3 4170.8 4178.5 4200.8 8570.2 8570.9 8576.7 8578.3 8581.2 4631.0 4631.6 4632.3 4632.4 4639.4 3992.1 4113.8 4180.8 4187.6 4195.2 3446.3 3488.8 3572.5 3615.2 3627.2 1142.5 1155.7 1183.0 1196.2 1198.3 801.1 801.2 811.3 814.8 822.8 4954.4 5087.5 5097.9 5111.1 5114.4 529.3 534.5 537.3 554.7 556.1 3286.9 3325.6 3338.7 3339.8 3459.1 8549.6 8908.0 8918.8 8945.8 8960.8 8812.4 8867.3 8867.5 8972.9 8977.6 6659.4 6729.7 6749.7 6752.7 6759.9 4909.9 4953.9 4991.2 5022.9 5237.2 7989.7 8003.7 8102.5 8177.5 8199.0 8138.4 8266.8 8281.2 8295.6 8368.1 5549.1 5742.6 5974.6 6084.2 6428.2 6901.9 6960.3 6963.9 6968.9 6976.4 6234.5 6243.3 6321.6 6332.7 6461.8 6056.2 6071.0 6120.8 6122.0 6198.4 5734.6 5878.1 5880.7 5890.9 5894.7 4308.5 4375.1 4443.3 4459.5 4483.4 4399.8 4490.6 4561.4 4617.7 4682.5 18:38:46 INFO - PROCESS | 30038 | 18:38:46 INFO - PROCESS | 30038 | [#4] prototype.html Cycles:180 Average:4175.98 Median:4748.51 stddev:1200.77 (25.3%) stddev-sans-first:1169.43 18:38:46 INFO - PROCESS | 30038 | Values: 357.1 360.5 362.6 367.0 369.7 4782.9 4810.2 4814.4 4849.9 4854.9 4644.4 4788.4 4790.2 4808.7 4814.2 3817.2 3830.6 3833.0 3833.5 3850.4 3808.8 3810.2 3821.8 3825.4 3862.7 3799.8 3804.9 3811.6 3827.2 3848.0 3589.5 3768.3 3798.2 3837.8 3842.3 3326.8 3333.1 3336.6 3351.8 3353.3 4720.8 4728.6 4732.4 4734.3 4734.9 4196.6 4320.3 4329.9 4334.3 4337.7 5006.6 5039.3 5044.2 5068.4 5102.2 3639.3 3640.1 3662.0 3666.4 3676.2 5063.3 5066.7 5165.8 5329.5 5339.0 3629.8 3668.0 3682.5 3699.2 3708.5 3741.0 3752.4 3752.5 3755.6 3758.2 3995.5 4101.4 4286.1 4292.7 4308.4 4945.2 5044.9 5062.7 5071.6 5089.4 1237.2 1243.3 1245.6 1245.6 1246.7 792.2 848.7 848.9 857.1 857.2 4351.0 4354.6 4361.8 4361.8 4371.2 5072.5 5073.1 5090.7 5091.2 5107.9 4294.2 4355.6 4368.7 4383.7 4384.8 2575.3 2682.9 2686.5 2692.6 2706.4 4709.2 4727.4 4729.0 4759.3 4760.3 4862.2 5112.3 5129.9 5130.6 5146.3 4747.3 4749.7 4774.7 4780.4 4795.8 5036.8 5048.5 5077.8 5084.7 5094.8 4844.3 4983.4 4984.2 4985.8 5034.7 4680.7 4814.6 4891.4 4924.2 4930.6 3610.9 3707.7 3709.9 3716.4 3719.2 5252.2 5252.2 5253.7 5259.5 5272.2 4937.5 5072.2 5096.3 5097.7 5109.2 5018.8 5057.7 5073.9 5080.0 5086.8 5018.8 5025.6 5032.3 5032.4 5046.8 4930.6 5076.2 5093.0 5116.3 5123.4 4984.0 4987.4 4988.5 4995.6 4998.8 18:38:46 INFO - PROCESS | 30038 | 18:38:46 INFO - PROCESS | 30038 | [#5] yui.html Cycles:180 Average:14055.59 Median:50066.25 stddev:16840.75 (33.6%) stddev-sans-first:16857.91 18:38:46 INFO - PROCESS | 30038 | Values: 650.6 664.5 712.1 725.5 736.5 12116.3 12391.1 12430.3 12472.9 13184.5 11125.4 12351.8 12456.8 12496.4 12623.4 817.0 829.9 831.5 832.0 834.3 823.1 825.1 825.1 825.2 825.9 866.6 867.2 867.4 867.7 867.9 852.8 857.3 861.3 862.9 863.2 626.3 626.9 630.7 632.2 632.2 11306.1 11349.6 11481.4 11486.7 11819.9 10666.7 11560.7 11881.0 11999.5 12168.6 11725.8 11805.6 11955.5 12009.8 12096.8 3885.4 3950.3 3966.4 3994.6 4035.9 39799.4 41247.2 41324.6 45852.3 59627.4 6094.6 9286.3 10143.3 10478.8 10548.6 18862.7 19072.3 19101.9 19186.9 19199.7 6849.9 6891.3 6902.1 6924.7 7149.0 3631.4 3735.4 3750.1 3753.5 3759.3 3123.7 3181.9 3186.2 3219.4 3220.1 556.5 557.8 559.6 559.8 573.3 563.9 580.8 589.7 600.2 600.3 8108.2 8534.2 8666.8 8748.2 8997.0 558.6 580.5 587.2 591.0 591.7 3777.5 3813.8 3889.9 3907.4 3943.5 62332.4 64594.4 64678.7 64700.0 67976.3 52750.5 54576.2 54992.0 55413.7 55680.4 45611.8 49920.3 50028.7 50103.7 50232.2 8490.5 9284.2 9685.6 9700.2 9703.2 33991.3 34481.8 35855.3 36447.8 36474.5 40728.6 43980.6 44038.8 44643.6 45993.8 9692.3 9764.2 9802.1 9870.6 10152.4 12374.3 12774.9 13150.7 13203.8 13565.1 12237.6 12628.1 12656.3 12836.9 13127.6 11103.0 11508.9 11510.8 11516.3 11605.3 11877.4 12024.3 12347.4 12363.9 12507.8 9271.6 9484.7 9657.9 9730.2 9791.9 8552.9 9184.8 9500.3 9502.2 9558.7 18:38:46 INFO - PROCESS | 30038 | -------- Summary: end -------- 18:38:46 INFO - PROCESS | 30038 | 18:38:47 INFO - TEST-INFO | 30038: exit 0 18:38:47 INFO - TEST-OK | dromaeo_css | took 1123947ms 18:38:47 INFO - TEST-START | kraken 18:38:47 INFO - operating with platform_type : linux_ 18:38:47 INFO - Initialising browser for kraken test... 18:38:47 INFO - TEST-INFO | started process 30339 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbgUhdh/profile http://localhost:40051/getInfo.html) 18:38:51 INFO - PROCESS | 30339 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 18:38:51 INFO - PROCESS | 30339 | __metrics Screen width/height:1600/1200 18:38:51 INFO - PROCESS | 30339 | colorDepth:24 18:38:51 INFO - PROCESS | 30339 | Browser inner width/height: 1024/697 18:38:51 INFO - PROCESS | 30339 | __metrics 18:38:53 INFO - PROCESS | 30339 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:38:53 INFO - PROCESS | 30339 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:38:53 INFO - PROCESS | 30339 | console.error: PushService: 18:38:53 INFO - PROCESS | 30339 | stateChangeProcessEnqueue: Error transitioning state 18:38:53 INFO - PROCESS | 30339 | UnknownError 18:38:54 INFO - TEST-INFO | 30339: exit 0 18:38:54 INFO - Browser initialized. 18:38:54 INFO - Running cycle 1/1 for kraken test... 18:38:54 INFO - TEST-INFO | started process 30421 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbgUhdh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:39:06 INFO - PROCESS | 30421 | RSS: Main: 153493504 18:39:06 INFO - PROCESS | 30421 | 18:39:09 INFO - PROCESS | 30421 | Cycle 1(1): loaded http://localhost:40051/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40051/tests/kraken/driver.html?testName=audio-beat-detection) 18:39:10 INFO - PROCESS | 30421 | RSS: Main: 206872576 18:39:10 INFO - PROCESS | 30421 | 18:39:12 INFO - PROCESS | 30421 | Cycle 1(1): loaded http://localhost:40051/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40051/tests/kraken/driver.html?testName=audio-dft) 18:39:13 INFO - PROCESS | 30421 | RSS: Main: 187748352 18:39:13 INFO - PROCESS | 30421 | 18:39:16 INFO - PROCESS | 30421 | Cycle 1(1): loaded http://localhost:40051/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40051/tests/kraken/driver.html?testName=audio-fft) 18:39:17 INFO - PROCESS | 30421 | RSS: Main: 269529088 18:39:17 INFO - PROCESS | 30421 | 18:39:19 INFO - PROCESS | 30421 | Cycle 1(1): loaded http://localhost:40051/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40051/tests/kraken/driver.html?testName=audio-oscillator) 18:39:20 INFO - PROCESS | 30421 | RSS: Main: 180924416 18:39:20 INFO - PROCESS | 30421 | 18:39:22 INFO - PROCESS | 30421 | Cycle 1(1): loaded http://localhost:40051/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40051/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:39:22 INFO - PROCESS | 30421 | RSS: Main: 184332288 18:39:22 INFO - PROCESS | 30421 | 18:39:26 INFO - PROCESS | 30421 | Cycle 1(1): loaded http://localhost:40051/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40051/tests/kraken/driver.html?testName=imaging-darkroom) 18:39:26 INFO - PROCESS | 30421 | RSS: Main: 224067584 18:39:26 INFO - PROCESS | 30421 | 18:39:30 INFO - PROCESS | 30421 | Cycle 1(1): loaded http://localhost:40051/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40051/tests/kraken/driver.html?testName=imaging-desaturate) 18:39:30 INFO - PROCESS | 30421 | RSS: Main: 217198592 18:39:30 INFO - PROCESS | 30421 | 18:39:33 INFO - PROCESS | 30421 | Cycle 1(1): loaded http://localhost:40051/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40051/tests/kraken/driver.html?testName=json-parse-financial) 18:39:34 INFO - PROCESS | 30421 | RSS: Main: 218660864 18:39:34 INFO - PROCESS | 30421 | 18:39:36 INFO - PROCESS | 30421 | Cycle 1(1): loaded http://localhost:40051/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40051/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:39:36 INFO - PROCESS | 30421 | RSS: Main: 182681600 18:39:36 INFO - PROCESS | 30421 | 18:39:38 INFO - PROCESS | 30421 | Cycle 1(1): loaded http://localhost:40051/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40051/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:39:39 INFO - PROCESS | 30421 | RSS: Main: 190009344 18:39:39 INFO - PROCESS | 30421 | 18:39:41 INFO - PROCESS | 30421 | Cycle 1(1): loaded http://localhost:40051/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40051/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:39:42 INFO - PROCESS | 30421 | RSS: Main: 198311936 18:39:42 INFO - PROCESS | 30421 | 18:39:44 INFO - PROCESS | 30421 | Cycle 1(1): loaded http://localhost:40051/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40051/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:39:45 INFO - PROCESS | 30421 | RSS: Main: 207671296 18:39:45 INFO - PROCESS | 30421 | 18:39:48 INFO - PROCESS | 30421 | Cycle 1(1): loaded http://localhost:40051/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40051/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:39:49 INFO - PROCESS | 30421 | RSS: Main: 204976128 18:39:49 INFO - PROCESS | 30421 | 18:39:51 INFO - PROCESS | 30421 | Cycle 1(1): loaded http://localhost:40051/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40051/tests/kraken/driver.html?testName=ai-astar) 18:39:51 INFO - PROCESS | 30421 | RSS: Main: 256045056 18:39:51 INFO - PROCESS | 30421 | 18:39:51 INFO - PROCESS | 30421 | __start_tp_report 18:39:51 INFO - PROCESS | 30421 | _x_x_mozilla_page_load 18:39:51 INFO - PROCESS | 30421 | _x_x_mozilla_page_load_details 18:39:51 INFO - PROCESS | 30421 | |i|pagename|runs| 18:39:51 INFO - PROCESS | 30421 | |0;ai-astar;113;114;114;115;114;113;113;116;113;114 18:39:51 INFO - PROCESS | 30421 | |1;audio-beat-detection;150;128;128;172;129;128;126;127;149;127 18:39:51 INFO - PROCESS | 30421 | |2;audio-dft;163;162;163;162;169;163;163;163;162;162 18:39:51 INFO - PROCESS | 30421 | |3;audio-fft;77;77;76;124;77;78;77;76;92;76 18:39:51 INFO - PROCESS | 30421 | |4;audio-oscillator;85;85;108;84;85;84;100;85;84;115 18:39:51 INFO - PROCESS | 30421 | |5;imaging-gaussian-blur;113;113;114;114;114;113;115;114;114;113 18:39:51 INFO - PROCESS | 30421 | |6;imaging-darkroom;149;148;150;149;150;149;149;149;149;148 18:39:51 INFO - PROCESS | 30421 | |7;imaging-desaturate;96;95;95;95;96;95;96;96;95;95 18:39:51 INFO - PROCESS | 30421 | |8;json-parse-financial;61;62;63;63;63;64;63;63;64;63 18:39:51 INFO - PROCESS | 30421 | |9;json-stringify-tinderbox;65;65;65;64;65;65;65;65;65;65 18:39:51 INFO - PROCESS | 30421 | |10;stanford-crypto-aes;88;88;89;89;89;89;89;87;88;89 18:39:51 INFO - PROCESS | 30421 | |11;stanford-crypto-ccm;141;138;138;147;136;138;137;138;177;160 18:39:51 INFO - PROCESS | 30421 | |12;stanford-crypto-pbkdf2;190;194;195;194;186;190;186;184;184;191 18:39:51 INFO - PROCESS | 30421 | |13;stanford-crypto-sha256-iterative;76;74;76;71;71;70;74;71;70;72 18:39:51 INFO - PROCESS | 30421 | __end_tp_report 18:39:51 INFO - PROCESS | 30421 | __start_cc_report 18:39:51 INFO - PROCESS | 30421 | _x_x_mozilla_cycle_collect,1965 18:39:51 INFO - PROCESS | 30421 | __end_cc_report 18:39:51 INFO - PROCESS | 30421 | __startTimestamp1486867191464__endTimestamp 18:39:51 INFO - PROCESS | 30421 | 18:39:51 INFO - PROCESS | 30421 | ------- Summary: start ------- 18:39:51 INFO - PROCESS | 30421 | Number of tests: 14 18:39:51 INFO - PROCESS | 30421 | 18:39:51 INFO - PROCESS | 30421 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.00 stddev:0.99 (0.9%) stddev-sans-first:1.00 18:39:51 INFO - PROCESS | 30421 | Values: 113.0 114.0 114.0 115.0 114.0 113.0 113.0 116.0 113.0 114.0 18:39:51 INFO - PROCESS | 30421 | 18:39:51 INFO - PROCESS | 30421 | [#1] audio-beat-detection Cycles:10 Average:136.40 Median:128.50 stddev:15.50 (12.1%) stddev-sans-first:15.64 18:39:51 INFO - PROCESS | 30421 | Values: 150.0 128.0 128.0 172.0 129.0 128.0 126.0 127.0 149.0 127.0 18:39:51 INFO - PROCESS | 30421 | 18:39:51 INFO - PROCESS | 30421 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:2.10 (1.3%) stddev-sans-first:2.22 18:39:51 INFO - PROCESS | 30421 | Values: 163.0 162.0 163.0 162.0 169.0 163.0 163.0 163.0 162.0 162.0 18:39:51 INFO - PROCESS | 30421 | 18:39:51 INFO - PROCESS | 30421 | [#3] audio-fft Cycles:10 Average:83.00 Median:77.00 stddev:15.20 (19.7%) stddev-sans-first:15.96 18:39:51 INFO - PROCESS | 30421 | Values: 77.0 77.0 76.0 124.0 77.0 78.0 77.0 76.0 92.0 76.0 18:39:51 INFO - PROCESS | 30421 | 18:39:51 INFO - PROCESS | 30421 | [#4] audio-oscillator Cycles:10 Average:91.50 Median:84.50 stddev:11.71 (13.9%) stddev-sans-first:12.18 18:39:51 INFO - PROCESS | 30421 | Values: 85.0 85.0 108.0 84.0 85.0 84.0 100.0 85.0 84.0 115.0 18:39:51 INFO - PROCESS | 30421 | 18:39:51 INFO - PROCESS | 30421 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 18:39:51 INFO - PROCESS | 30421 | Values: 113.0 113.0 114.0 114.0 114.0 113.0 115.0 114.0 114.0 113.0 18:39:51 INFO - PROCESS | 30421 | 18:39:51 INFO - PROCESS | 30421 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 18:39:51 INFO - PROCESS | 30421 | Values: 149.0 148.0 150.0 149.0 150.0 149.0 149.0 149.0 149.0 148.0 18:39:51 INFO - PROCESS | 30421 | 18:39:51 INFO - PROCESS | 30421 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 18:39:51 INFO - PROCESS | 30421 | Values: 96.0 95.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 95.0 18:39:51 INFO - PROCESS | 30421 | 18:39:51 INFO - PROCESS | 30421 | [#8] json-parse-financial Cycles:10 Average:62.90 Median:63.00 stddev:0.88 (1.4%) stddev-sans-first:0.60 18:39:51 INFO - PROCESS | 30421 | Values: 61.0 62.0 63.0 63.0 63.0 64.0 63.0 63.0 64.0 63.0 18:39:51 INFO - PROCESS | 30421 | 18:39:51 INFO - PROCESS | 30421 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 18:39:51 INFO - PROCESS | 30421 | Values: 65.0 65.0 65.0 64.0 65.0 65.0 65.0 65.0 65.0 65.0 18:39:51 INFO - PROCESS | 30421 | 18:39:51 INFO - PROCESS | 30421 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:89.00 stddev:0.71 (0.8%) stddev-sans-first:0.73 18:39:51 INFO - PROCESS | 30421 | Values: 88.0 88.0 89.0 89.0 89.0 89.0 89.0 87.0 88.0 89.0 18:39:51 INFO - PROCESS | 30421 | 18:39:51 INFO - PROCESS | 30421 | [#11] stanford-crypto-ccm Cycles:10 Average:145.00 Median:139.50 stddev:13.37 (9.6%) stddev-sans-first:14.11 18:39:51 INFO - PROCESS | 30421 | Values: 141.0 138.0 138.0 147.0 136.0 138.0 137.0 138.0 177.0 160.0 18:39:51 INFO - PROCESS | 30421 | 18:39:51 INFO - PROCESS | 30421 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.40 Median:190.50 stddev:4.20 (2.2%) stddev-sans-first:4.44 18:39:51 INFO - PROCESS | 30421 | Values: 190.0 194.0 195.0 194.0 186.0 190.0 186.0 184.0 184.0 191.0 18:39:51 INFO - PROCESS | 30421 | 18:39:51 INFO - PROCESS | 30421 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:73.00 stddev:2.32 (3.2%) stddev-sans-first:2.09 18:39:51 INFO - PROCESS | 30421 | Values: 76.0 74.0 76.0 71.0 71.0 70.0 74.0 71.0 70.0 72.0 18:39:51 INFO - PROCESS | 30421 | -------- Summary: end -------- 18:39:51 INFO - PROCESS | 30421 | 18:39:52 INFO - TEST-INFO | 30421: exit 0 18:39:52 INFO - TEST-OK | kraken | took 65399ms 18:39:52 INFO - SUITE-END | took 1189s 18:39:53 INFO - Completed test suite (00:19:49) 18:39:53 INFO - javascript benchmark 18:39:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6280.887534788631, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2565.5382031234376, 2584.1472314136336, 2610.3604616868865, 2618.0444137889663, 2622.1346955504687, 4611.3774640423535, 4685.765711714409, 4774.665773395859, 4775.737334446604, 4780.4980477049885, 4625.653076019295, 4664.743439110847, 4710.858674239778, 4741.193997020515, 4791.856244312677, 4215.388768628547, 4330.610245077943, 4353.608175264226, 4450.0, 4481.170983368087, 4401.911961760763, 4468.307412351074, 4469.3296005599095, 4481.417415735966, 4514.435695538058, 4299.14017196562, 4335.981044454551, 4337.587929146757, 4338.674599405057, 4385.320275357293, 4389.341598760179, 4402.427684401039, 4444.955550444486, 4448.621867141297, 4453.042595841877, 4358.0848021915435, 4363.694541382105, 4372.0, 4376.584224498668, 4434.091011342667, 4616.5152658970665, 4628.606568441686, 4637.953620463786, 4753.168195565762, 4805.903881922377, 5022.196448568212, 5059.569936555397, 5065.0, 5069.239614057884, 5102.6173037022, 5091.592672586185, 5097.184450487941, 5100.183970564729, 5104.897902041976, 5152.407473140599, 4653.046125544255, 4847.369841920563, 4847.61219102478, 4850.733209673502, 4892.290617860391, 5063.87340316495, 5158.993996170786, 5207.973960130175, 5251.842444726664, 5253.763580638881, 4882.487338829443, 4937.061958227925, 4963.230699241623, 4987.551120399182, 5019.272205530177, 5071.492850714899, 5100.6684565503865, 5114.360704911886, 5115.769790359443, 5164.8192313268855, 4896.46138924718, 5045.091883461012, 5074.771635276347, 5084.2627818966785, 5097.235414687826, 4940.357753492023, 4989.027139707722, 5011.498850114959, 5017.67385119966, 5059.2916991621205, 4331.480222373335, 4336.436263285816, 4345.044090300129, 4361.80371883266, 4374.825006999748, 3732.0, 3747.775133491945, 3759.736818422739, 3781.7541859779026, 3785.545734511821, 4346.978265108654, 4377.1683380157665, 4401.449818772653, 4441.888952776142, 4463.821447142078, 5096.362954630671, 5101.413337466165, 5106.208537676666, 5142.948570514247, 5155.948440515622, 4428.867133985986, 4431.556844315607, 4433.667474939392, 4474.306482495218, 4474.7762611869275, 4419.049904270597, 4458.86623401292, 4520.0507893341455, 4567.040921406542, 4580.496145424001, 4768.451628062817, 4795.9280610790165, 4800.3759511263315, 4826.372571565674, 4842.927356089591, 5066.721330326867, 5088.641496612218, 5105.081085404663, 5116.1814109743755, 5154.819581314636, 4581.908361832811, 4617.930731039104, 4779.976100119477, 4798.73606951621, 4837.661363704507, 4919.901601967869, 4923.384576927884, 4959.057779021974, 5032.773525191302, 5053.898922021613, 5116.692998420107, 5117.232415137759, 5121.769520371667, 5125.461826508163, 5128.205128205134, 4854.393200849894, 4891.021795640957, 4897.0, 4904.901901961869, 4912.508749125059, 4944.851654450372, 4965.230389289666, 4966.255061740768, 4974.253861920741, 5026.120428924996, 4770.308305295782, 4790.760461976957, 4832.468428472936, 4833.202521583899, 4894.0, 4853.956399374151, 4937.77779999908, 4942.357493525962, 4953.777080031479, 5001.549860512426, 4840.588549973291, 4846.600932538416, 4847.321375007572, 4849.660523763444, 4897.338859253955], "value": 4659.313170351196, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [526.9552088072513, 548.3036543589639, 556.8858384031274, 558.5252535344957, 561.7528287553479, 29697.851510742443, 38813.417798733004, 39269.803650981776, 39305.41041884374, 41874.58125418745, 39075.21849563007, 39320.60679393205, 39387.80306098473, 39440.60559394405, 39530.60469395305, 7491.25087491252, 7724.691012359499, 7735.419843511731, 7742.187070357616, 7750.5349679019155, 7182.784516464514, 7369.594672293022, 9319.161275485205, 9540.236781057498, 9554.140127388533, 9814.018598140165, 9901.158401535879, 9901.20790336775, 9906.851397229048, 9908.603655853793, 9724.416535007887, 9815.460149691764, 9828.4102953823, 9828.705138845846, 9835.803283934352, 9620.518974051269, 9694.466804325759, 9696.17582505488, 9698.224142068617, 9699.078587534173, 36318.63681363205, 36602.26795464102, 36640.26719465596, 36656.26687466236, 36716.63283367186, 3476.200473890994, 3534.5935217450065, 3551.94672079919, 3576.409892367756, 3634.254977729559, 26462.73537264622, 26617.20148395532, 26660.46679066427, 26733.732662673512, 27376.178714638594, 3383.374075795986, 3397.167693914982, 3472.340255351475, 3502.176988407722, 3628.872989445357, 235502.82248588817, 236450.0, 236915.0, 237123.0, 237636.0, 44439.55560444419, 50911.0, 51220.0, 51242.48757512452, 51288.0, 43371.783141084095, 52523.73738131285, 53378.46621533813, 53911.0, 58224.0, 13885.514007009908, 14122.576322710334, 14134.293285335692, 14135.363908624136, 14145.222012789189, 10876.456177191109, 11096.5561377544, 11101.38942358178, 11115.666530004113, 11125.332480051224, 13025.609231723063, 13308.800367994489, 13335.466581336832, 13671.794923076162, 14424.567262982127, 5595.916061259084, 5844.357120716718, 5887.2052272943465, 5984.0, 5998.910016349758, 749.3031480722871, 786.7915002524336, 794.2216627704881, 795.0975642645639, 812.4515951732675, 25832.870835645703, 26280.73719262821, 26780.330491737863, 26823.329416764736, 26833.597496037575, 938.6949241496404, 947.1901524196712, 952.8570714392758, 958.9568469418892, 960.3085778239656, 13819.239941803296, 13873.167609943435, 13913.373898174606, 13957.79063314051, 14014.159150451005, 326630.0, 329164.0, 329531.0, 330662.0, 330737.0, 46142.30786538205, 46336.304955425694, 46532.0, 46570.5342946573, 46592.7670361646, 1136.2046567402851, 1191.0352614382377, 1191.8033524468365, 1198.6703656494533, 1207.3178654060603, 23971.500119246888, 25061.0, 25568.744312556635, 25613.0, 25752.227433177035, 38597.68413895175, 38708.61291387163, 39112.0, 39250.411243831935, 39272.80363598164, 263226.0, 263992.0, 264251.0, 264317.03524446767, 265865.0, 21757.0, 22411.663825042964, 24320.148794792098, 24644.658757418016, 24668.0, 30909.69090309158, 30995.0, 31864.68135318617, 34381.0, 43088.35367469428, 35369.82315088408, 36234.0, 36372.818135909154, 37254.8137259312, 37965.81017095008, 35582.822085889406, 35633.46549801807, 36484.63515364812, 36792.0, 36812.0, 35994.10014749652, 36339.63660363468, 36512.08719782027, 37049.25901482009, 37137.25725485421, 29494.705052949197, 31736.682633173372, 32734.181645459055, 32883.34233315368, 32914.34171316608, 24064.278071657878, 24333.878330608943, 24797.25608231756, 25453.3636659085, 27547.724522754517], "value": 16991.164783610195, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.88222709846394, 382.902359898226, 392.550529643558, 394.92693851637443, 417.3218519905154, 15313.310901009454, 16982.830171698293, 17047.659046819088, 17050.0, 17266.82733172668, 17491.300347986064, 17597.3840915568, 17726.734098988527, 17778.64442711145, 18056.0, 5040.773165207565, 5261.1056120459425, 5261.1319132343115, 5262.184361423985, 5264.8157314494, 5063.31645227895, 5094.974525127369, 5353.973230133844, 5384.326959130109, 5456.727163641822, 5446.046941785192, 5454.181872719084, 5456.48163424474, 5456.590755693319, 5465.125579907216, 5419.132938729804, 5876.676782776945, 5909.999999999978, 5935.198748168985, 5944.643321400687, 5150.896982060338, 5281.181416880389, 5294.655847369947, 5300.886813769113, 5342.572594192456, 12658.620241392773, 12911.418986145645, 12984.805227921493, 12994.610161695164, 13002.0, 2353.376355265856, 2393.6529203265604, 2402.267308470916, 2415.516896620665, 2448.6082226843796, 9301.953490232574, 9416.529173541296, 9517.048295170496, 9679.90320096797, 11131.276467029698, 1669.2071266148603, 1705.7100292950229, 1710.7006273902018, 1726.7841519810024, 1737.1487970894298, 71406.0, 73769.0, 74034.62982685052, 75107.62446187733, 76342.61828690821, 10714.0, 10830.945845270724, 10851.728706782395, 10948.835767463494, 11064.05955493776, 15115.0, 15153.924230378778, 15163.924180379028, 15168.469103581321, 15207.239638018054, 6657.866842663119, 6799.728010879509, 6888.070110535114, 6982.2319544850025, 6997.545159564612, 6085.300190478151, 6107.358727333566, 6284.780032698834, 6291.748330066746, 6300.7479700811455, 4451.1765323415275, 4587.587117159472, 4683.7892294846815, 4722.126406614719, 4837.782299796518, 1876.9061546922599, 1914.3491212987371, 1940.262700173925, 1942.5823447958473, 1946.0756140833273, 714.125196634119, 730.455810421229, 738.9150247721474, 744.5346658338539, 750.4709180028067, 17222.397216097375, 17228.483145505656, 17949.192286347145, 18018.0, 18294.451166465027, 717.1752484642702, 732.0995175933632, 743.2121950732242, 749.3518106837655, 751.5265382808795, 9629.711108666612, 9953.353032053039, 10022.649207277856, 10028.598856045823, 10105.987680490873, 435227.0, 445334.0, 450360.0, 456241.0, 458968.0, 83089.0, 83346.0, 83967.0, 84183.15816841875, 85667.14332856591, 906.1572737354323, 907.5870478932202, 927.9768005799909, 931.4457897550947, 932.5710173320213, 14766.926165369105, 14810.444903285432, 15138.924305378403, 16203.75694364609, 16469.752953705465, 37670.62329376671, 38116.0, 38678.0, 39089.80455097706, 39475.40786888256, 50839.2374114396, 50936.74531627318, 50979.49020509747, 51340.486595133574, 52080.73959630178, 7946.8807967879375, 7957.244061814118, 7979.72070977513, 7982.560959147303, 8336.041355243982, 8763.0, 11426.314421134759, 11732.12009099304, 12421.93789031049, 12580.811287830873, 10485.0, 10505.422201778976, 10524.894751052392, 10894.346339219672, 11172.273802202832, 10201.0, 10458.163346932379, 11219.326840389604, 11238.66284011481, 11252.549898003988, 10591.364518128938, 10958.506867190836, 11026.558937642725, 11100.944495277472, 11496.367699776258, 8053.234942680436, 8104.959475202586, 8257.917420825715, 8266.173382661686, 8300.418970672237, 9240.907590924005, 10944.835827462754, 11047.116230701686, 11115.944420277847, 11316.94341528287], "value": 8329.403953161598, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1191.1602320364145, 1325.3638253638253, 1367.6717587778933, 1368.7330970460757, 1372.8833049190819, 6166.691665416728, 7110.5733655980675, 7285.781426557199, 7355.595442250681, 7591.658375373107, 7365.742199023022, 7421.369183619398, 7440.330370266688, 7444.739434119807, 7445.739399121032, 2085.906134223956, 2121.692354608581, 2121.7666056733747, 2122.670985997165, 2122.8301735861173, 1706.940257091002, 1769.27459741506, 2071.140476702167, 2133.7866213378616, 2136.433845031068, 1986.0, 1997.5904939487443, 1998.560316730317, 1999.8000199979958, 2000.249906285143, 2011.859169858103, 2050.39513343564, 2051.138521820839, 2055.7738648748627, 2062.4431403521116, 1989.4031790462802, 2027.8174964253287, 2046.6213750456213, 2051.2307884543297, 2080.573482436097, 7293.4894557381, 7385.409167266659, 7392.926070739278, 7393.0, 7394.112706475204, 4455.554444555551, 4577.771111444415, 4589.678722489427, 4591.885202869921, 4594.081183763261, 2775.084222206667, 2943.7350638442645, 2963.155500682317, 3025.667176610571, 3030.1818509002665, 1077.5312738958578, 1145.6448500964643, 1152.8443660105863, 1196.3539688568162, 1235.234154824015, 9946.20430365569, 10000.549975251131, 10009.099181073738, 10017.449040302781, 10029.59881604735, 3890.5720370759195, 4063.329550624173, 4170.791460426966, 4178.540360560336, 4200.831966721297, 8570.228679418882, 8570.914290857012, 8576.742697719079, 8578.313734901192, 8581.227689507974, 4631.0, 4631.560001799824, 4632.258838585877, 4632.444106707217, 4639.37368455261, 3992.1416895367634, 4113.753174809462, 4180.811863466151, 4187.581241875788, 4195.202911446815, 3446.293509830479, 3488.8255587220538, 3572.4819901114192, 3615.222727113683, 3627.238279961185, 1142.520141540555, 1155.7052951497483, 1182.9704257393462, 1196.1806162778526, 1198.3109711915683, 801.1187693537179, 801.1787917384611, 811.3144392987916, 814.7596459044596, 822.7535284044677, 4954.430240522314, 5087.465816089331, 5097.923531147036, 5111.05445492585, 5114.43741188469, 529.2669652531272, 534.5162627821827, 537.3149234725756, 554.7032337699311, 556.1407625219047, 3286.868525258963, 3325.617553981275, 3338.7329013678846, 3339.833008349573, 3459.08334291413, 8549.615267312985, 8908.0, 8918.777030574287, 8945.821083578292, 8960.849396144878, 8812.369711603375, 8867.334949878656, 8867.467951922905, 8972.910270897339, 8977.596008179647, 6659.433948114368, 6729.6971636276485, 6749.662516874137, 6752.729890804411, 6759.932400675931, 4909.9018019640125, 4953.876153096201, 4991.201407774739, 5022.949770502249, 5237.188235823453, 7989.680412783424, 8003.679852806055, 8102.473339232931, 8177.509349439053, 8198.959005204935, 8138.389620778347, 8266.751997440086, 8281.21328473794, 8295.58522073906, 8368.12134725845, 5549.112142057252, 5742.626729262584, 5974.581779275409, 6084.209052823105, 6428.19647544057, 6901.89647155283, 6960.303969602999, 6963.895541566982, 6968.895466568107, 6976.441884649114, 6234.470070044097, 6243.250809902841, 6321.589096708699, 6332.746690132343, 6461.838454038687, 6056.242969628796, 6070.969645151746, 6120.846978825387, 6122.0, 6198.380161983766, 5734.569907256889, 5878.147668587945, 5880.735366908585, 5890.9116363253725, 5894.6736984178215, 4308.5260621331, 4375.124975004948, 4443.3334999749, 4459.48715897663, 4483.394741709827, 4399.802008909671, 4490.640748740027, 4561.429821272341, 4617.653675974382, 4682.484926657997], "value": 3903.883406237467, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.1392943007353, 360.4629102637071, 362.62468345262624, 366.99082522936925, 369.6617594900665, 4782.880427989302, 4810.230363141898, 4814.374131362927, 4849.8545043648655, 4854.902901941963, 4644.396228490292, 4788.371953535797, 4790.2096154134615, 4808.663393562452, 4814.229723244282, 3817.236552689459, 3830.636089571486, 3832.9808350958274, 3833.4824798652244, 3850.3839385698293, 3808.7905165215902, 3810.2379524095154, 3821.7579286731784, 3825.387937929932, 3862.671672907792, 3799.7910114943807, 3804.885853424402, 3811.561670407897, 3827.1771569112634, 3847.9615203847884, 3589.4974703541525, 3768.2651882882847, 3798.2213646202463, 3837.750546214501, 3842.3275926712995, 3326.76712630116, 3333.116853921365, 3336.6496517865517, 3351.7988920664593, 3353.2622822978906, 4720.811167553294, 4728.6453515986095, 4732.385923724376, 4734.313524538922, 4734.905301893943, 4196.58034196581, 4320.308750599889, 4329.935050974238, 4334.263175260214, 4337.7397356158735, 5006.6245031622775, 5039.344885164942, 5044.192929131322, 5068.4424713281505, 5102.209157580581, 3639.253952939641, 3640.10817349751, 3661.963380366189, 3666.3767159582935, 3676.191237927652, 5063.291139240509, 5066.721330326831, 5165.793368265265, 5329.546988505982, 5339.0, 3629.7640653357976, 3668.0463079599494, 3682.5396825396824, 3699.2231631357176, 3708.5364329458816, 3740.9625903741157, 3752.418375151856, 3752.5309336332957, 3755.6244375562223, 3758.229562939591, 3995.4606128172904, 4101.364288535282, 4286.142771445661, 4292.720973136736, 4308.353746937922, 4945.184044632667, 5044.924326135111, 5062.696238225718, 5071.644984851025, 5089.37140115167, 1237.1525505028903, 1243.2975368916534, 1245.6138597034949, 1245.6325384011739, 1246.7194881151668, 792.18405042806, 848.6902280667512, 848.8854004709285, 857.1428571428571, 857.1557016338901, 4350.95577061503, 4354.564543545684, 4361.80371883266, 4361.847335343311, 4371.229651990949, 5072.51811077947, 5073.086844367976, 5090.745462726849, 5091.236314552847, 5107.850733584988, 4294.183467148301, 4355.629771469397, 4368.716033457815, 4383.693141480066, 4384.802683879233, 2575.330414092312, 2682.906098286551, 2686.5029969455713, 2692.569188929762, 2706.404590989979, 4709.222978208626, 4727.361806156194, 4729.0, 4759.309900064472, 4760.33355330254, 4862.1556389511825, 5112.258722485219, 5129.897402051938, 5130.614734021793, 5146.275997540791, 4747.311639812277, 4749.715017098985, 4774.665773395829, 4780.378550788445, 4795.808167673324, 5036.823711170092, 5048.495150484922, 5077.7715002824225, 5084.694918304914, 5094.7962081516325, 4844.297576851266, 4983.377077865267, 4984.155862330816, 4985.825496107619, 5034.723090230073, 4680.7191568506, 4814.566688998007, 4891.364122664031, 4924.187509060965, 4930.630202734881, 3610.8736194233074, 3707.7033837293493, 3709.8516059357326, 3716.4239542870896, 3719.2375563008977, 5252.212168174804, 5252.238425428368, 5253.684778913277, 5259.501042203106, 5272.235525848807, 4937.481564435682, 5072.224721347498, 5096.261042148942, 5097.6941383517105, 5109.156989096906, 5018.841897983756, 5057.69653820772, 5073.923891141562, 5079.974600127123, 5086.847394578169, 5018.84943451697, 5025.623078269071, 5032.257419706196, 5032.43994361749, 5046.829863158877, 4930.630202734737, 5076.162433198481, 5093.0, 5116.28372027909, 5123.359580052494, 4983.975080124576, 4987.401511818605, 4988.501149884983, 4995.550400463976, 4998.750062496788], "value": 3808.2150572725486, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [650.6128853332272, 664.451827242525, 712.1301156339952, 725.5356571794051, 736.4623824608036, 12116.333601651906, 12391.132620716542, 12430.316332601726, 12472.875271247285, 13184.538541151062, 11125.388103654295, 12351.814722779165, 12456.81314780279, 12496.375181240925, 12623.368831558431, 816.9836603267931, 829.9336053115767, 831.4969443486694, 831.9875201871946, 834.2950207075012, 823.069930977994, 825.0717942314895, 825.1130035212141, 825.1954344514111, 825.8513467575864, 866.5883705240024, 867.2108381372952, 867.3928250224836, 867.6963062927956, 867.9305655547572, 852.765489490392, 857.2841677199546, 861.3066481482405, 862.9093945135764, 863.2317237658489, 626.2797782550058, 626.8589567347356, 630.6562923206817, 632.1623848400841, 632.2128949457908, 11306.095512358992, 11349.602763903224, 11481.425928703531, 11486.655400338002, 11819.881801181964, 10666.73333166677, 11560.6531804046, 11881.0, 11999.52001919922, 12168.57409990655, 11725.824112638316, 11805.58680446189, 11955.462004209832, 12009.819852702216, 12096.758064838654, 3885.3977633466857, 3950.328444164499, 3966.4248683940955, 3994.560598334181, 4035.878923632296, 39799.4030089546, 41247.175056499, 41324.586754132375, 45852.31221531713, 59627.40372596262, 6094.603850749776, 9286.30352723535, 10143.340682855738, 10478.842817357745, 10548.630797922036, 18862.71705924412, 19072.33246836354, 19101.904490477737, 19186.904065479583, 19199.712004319947, 6849.931500685029, 6891.310868913069, 6902.102726645604, 6924.6537673116145, 7149.0, 3631.418972964313, 3735.402335626287, 3750.1187221003042, 3753.474513568103, 3759.3233218020473, 3123.656397796286, 3181.936361272808, 3186.235303527183, 3219.3561287742546, 3220.1144685211284, 556.4935908323406, 557.799192290775, 559.6222549778882, 559.7648987425291, 573.2776701356238, 563.9266895303584, 580.7909152705023, 589.6845187824493, 600.1507866369126, 600.3066458240739, 8108.2297181767635, 8534.189252021048, 8666.793286483915, 8748.212660860552, 8996.955015225012, 558.6452602597379, 580.494969376645, 587.1838144978483, 590.9822705318848, 591.7248479457073, 3777.4522694209186, 3813.7521061130938, 3889.8638547651262, 3907.374820028782, 3943.507061617298, 62332.376676233565, 64594.35405645977, 64678.67660661667, 64700.0, 67976.32023679798, 52750.472495275324, 54576.181357279675, 54992.0, 55413.722931385084, 55680.44319556834, 45611.77194114008, 49920.251196232086, 50028.74985625121, 50103.74948125236, 50232.246516302286, 8490.490570565786, 9284.164859002007, 9685.564149613425, 9700.197474717219, 9703.223742100756, 33991.320173595894, 34481.827590862886, 35855.28289434249, 36447.81776091103, 36474.452883207305, 40728.59271407367, 43980.56019439764, 44038.77980610076, 44643.55356446524, 45993.77003114963, 9692.273079518924, 9764.170045545923, 9802.117809397188, 9870.605175792887, 10152.39085654863, 12374.319412432402, 12774.936125319315, 13150.736985260433, 13203.801942970671, 13565.118267312593, 12237.571684990982, 12628.11603187768, 12656.303903285409, 12836.935815320863, 13127.606171814861, 11103.0, 11508.94245528767, 11510.769784604428, 11516.30902145874, 11605.30368177912, 11877.406129693654, 12024.278543287432, 12347.444365003776, 12363.876361236273, 12507.812382814083, 9271.582778774837, 9484.668036618685, 9657.9034209657, 9730.22158227326, 9791.902080979098, 8552.871706924525, 9184.770380740534, 9500.334976551852, 9502.239820814457, 9558.665446709332], "value": 6261.785012115974, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1569.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 115.0, 114.0, 113.0, 113.0, 116.0, 113.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 128.0, 128.0, 172.0, 129.0, 128.0, 126.0, 127.0, 149.0, 127.0], "value": 136.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 162.0, 169.0, 163.0, 163.0, 163.0, 162.0, 162.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 124.0, 77.0, 78.0, 77.0, 76.0, 92.0, 76.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 108.0, 84.0, 85.0, 84.0, 100.0, 85.0, 84.0, 115.0], "value": 91.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 114.0, 114.0, 113.0, 115.0, 114.0, 114.0, 113.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 150.0, 149.0, 150.0, 149.0, 149.0, 149.0, 149.0, 148.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 63.0, 63.0, 63.0, 64.0, 63.0, 63.0, 64.0, 63.0], "value": 62.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 89.0, 89.0, 89.0, 89.0, 89.0, 87.0, 88.0, 89.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 138.0, 138.0, 147.0, 136.0, 138.0, 137.0, 138.0, 177.0, 160.0], "value": 145.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 194.0, 195.0, 194.0, 186.0, 190.0, 186.0, 184.0, 184.0, 191.0], "value": 189.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 76.0, 71.0, 71.0, 70.0, 74.0, 71.0, 70.0, 72.0], "value": 72.5, "unit": "score"}]}]} 18:39:53 INFO - Return code: 0 18:39:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:39:53 ERROR - # TBPL SUCCESS # 18:39:53 INFO - Running post-action listener: _resource_record_post_action 18:39:53 INFO - [mozharness: 2017-02-12 02:39:53.279785Z] Finished run-tests step (success) 18:39:53 INFO - Running post-run listener: _resource_record_post_run 18:39:53 INFO - Total resource usage - Wall time: 1206s; CPU: 13.0%; Read bytes: 8192; Write bytes: 394526720; Read time: 20; Write time: 437704 18:39:53 INFO - TinderboxPrint: CPU usage
13.1% 18:39:53 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 18:39:53 INFO - TinderboxPrint: I/O write bytes / time
394,526,720 / 437,704 18:39:53 INFO - TinderboxPrint: CPU idle
8,361.6 (86.9%) 18:39:53 INFO - TinderboxPrint: CPU user
1,214.6 (12.6%) 18:39:53 INFO - TinderboxPrint: Swap in / out
0 / 0 18:39:53 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 100151296; Read time: 0; Write time: 145916 18:39:53 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293994496; Read time: 8; Write time: 291744 18:39:53 INFO - Running post-run listener: _upload_blobber_files 18:39:53 INFO - Blob upload gear active. 18:39:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:39:53 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:39:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:39:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:39:54 INFO - (blobuploader) - INFO - Open directory for files ... 18:39:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:39:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:39:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:39:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:39:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:39:55 INFO - (blobuploader) - INFO - Done attempting. 18:39:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:39:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:39:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:39:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:39:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:39:59 INFO - (blobuploader) - INFO - Done attempting. 18:39:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:39:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:39:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:39:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:39:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:39:59 INFO - (blobuploader) - INFO - Done attempting. 18:39:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:39:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:39:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:40:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:40:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:40:00 INFO - (blobuploader) - INFO - Done attempting. 18:40:00 INFO - (blobuploader) - INFO - Iteration through files over. 18:40:00 INFO - Return code: 0 18:40:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:40:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:40:00 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d018699fdd91ba8937bc66a7d661bc629aae3f92d62407b96529afcdf5f824427458f5d18b40c8b3bde5ad102d8a03bf9c3945143ab87e4e992890c4c52ddf35", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/55042f6cb41550213121c83d61c0f9b3d573974d205d753aaf9337dfe1abd91ee377fb61e0df8ec721018f4961f5c0784b69bdeca775bef7bd377c78b9c7e4f8", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9c621f94fde3ec3cd23b620b7d2bb8a5cfec8eb4c098e3c3d5784582cbc49e282d01f6a362b2baaf2374c42f5503b9250fa98d5456d21096cc622694d919d2ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f6bcc017ed627b9cacb67f68852ce2a15e9ed01d45fc0e9864b7e9e530a6a7a2a4d0c006afdb0e6b804e02f5b3bd3e2c2cf8daca18c6002e6d49a25e0c04afb0"} 18:40:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:40:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:40:00 INFO - Contents: 18:40:00 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d018699fdd91ba8937bc66a7d661bc629aae3f92d62407b96529afcdf5f824427458f5d18b40c8b3bde5ad102d8a03bf9c3945143ab87e4e992890c4c52ddf35", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/55042f6cb41550213121c83d61c0f9b3d573974d205d753aaf9337dfe1abd91ee377fb61e0df8ec721018f4961f5c0784b69bdeca775bef7bd377c78b9c7e4f8", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9c621f94fde3ec3cd23b620b7d2bb8a5cfec8eb4c098e3c3d5784582cbc49e282d01f6a362b2baaf2374c42f5503b9250fa98d5456d21096cc622694d919d2ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f6bcc017ed627b9cacb67f68852ce2a15e9ed01d45fc0e9864b7e9e530a6a7a2a4d0c006afdb0e6b804e02f5b3bd3e2c2cf8daca18c6002e6d49a25e0c04afb0"} 18:40:00 INFO - Running post-run listener: copy_logs_to_upload_dir 18:40:00 INFO - Copying logs to upload dir... 18:40:00 INFO - mkdir: /builds/slave/test/build/upload/logs 18:40:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.990727 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-02-11 18:40:00.697253) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-11 18:40:00.702059) ========= 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=745a4373a2a16df560f216e000000264-1486861849.488943-1863273647 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/d018699fdd91ba8937bc66a7d661bc629aae3f92d62407b96529afcdf5f824427458f5d18b40c8b3bde5ad102d8a03bf9c3945143ab87e4e992890c4c52ddf35", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/55042f6cb41550213121c83d61c0f9b3d573974d205d753aaf9337dfe1abd91ee377fb61e0df8ec721018f4961f5c0784b69bdeca775bef7bd377c78b9c7e4f8", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9c621f94fde3ec3cd23b620b7d2bb8a5cfec8eb4c098e3c3d5784582cbc49e282d01f6a362b2baaf2374c42f5503b9250fa98d5456d21096cc622694d919d2ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f6bcc017ed627b9cacb67f68852ce2a15e9ed01d45fc0e9864b7e9e530a6a7a2a4d0c006afdb0e6b804e02f5b3bd3e2c2cf8daca18c6002e6d49a25e0c04afb0"} build_url:https://queue.taskcluster.net/v1/task/Zz1_d1s5T-aWQ-8dLcFa6g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011214 build_url: 'https://queue.taskcluster.net/v1/task/Zz1_d1s5T-aWQ-8dLcFa6g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d018699fdd91ba8937bc66a7d661bc629aae3f92d62407b96529afcdf5f824427458f5d18b40c8b3bde5ad102d8a03bf9c3945143ab87e4e992890c4c52ddf35", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/55042f6cb41550213121c83d61c0f9b3d573974d205d753aaf9337dfe1abd91ee377fb61e0df8ec721018f4961f5c0784b69bdeca775bef7bd377c78b9c7e4f8", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9c621f94fde3ec3cd23b620b7d2bb8a5cfec8eb4c098e3c3d5784582cbc49e282d01f6a362b2baaf2374c42f5503b9250fa98d5456d21096cc622694d919d2ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f6bcc017ed627b9cacb67f68852ce2a15e9ed01d45fc0e9864b7e9e530a6a7a2a4d0c006afdb0e6b804e02f5b3bd3e2c2cf8daca18c6002e6d49a25e0c04afb0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-11 18:40:00.727514) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-11 18:40:00.727847) ========= 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=745a4373a2a16df560f216e000000264-1486861849.488943-1863273647 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-11 18:40:00.811601) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-11 18:40:00.811905) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-11 18:40:00.812190) ========= ========= Total master_lag: 0.18 =========