builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-058 starttime: 1486649728.69 results: success (0) revision: 1419fa7ee013b44501b90487bf8f8873dbaf3727 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 06:15:28.692258) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 06:15:28.692754) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 06:15:28.693090) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 06:15:28.709740) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 06:15:28.710076) ========= 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=0e2a256762fed810e2f0f810000001b3-1486649728.569949-2137729594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-09 06:15:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.7M=0s 2017-02-09 06:15:29 (37.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.141459 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 06:15:28.865232) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 06:15:28.865585) ========= 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=0e2a256762fed810e2f0f810000001b3-1486649728.569949-2137729594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019035 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 06:15:28.914850) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-09 06:15:28.915212) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1419fa7ee013b44501b90487bf8f8873dbaf3727 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1419fa7ee013b44501b90487bf8f8873dbaf3727 --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=0e2a256762fed810e2f0f810000001b3-1486649728.569949-2137729594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-09 06:15:29,497 truncating revision to first 12 chars 2017-02-09 06:15:29,497 Setting DEBUG logging. 2017-02-09 06:15:29,497 attempt 1/10 2017-02-09 06:15:29,497 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1419fa7ee013?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-09 06:15:30,472 unpacking tar archive at: mozilla-aurora-1419fa7ee013/testing/mozharness/ program finished with exit code 0 elapsedTime=1.230272 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-09 06:15:30.158542) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 06:15:30.158859) ========= script_repo_revision: 1419fa7ee013b44501b90487bf8f8873dbaf3727 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 06:15:30.162587) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 06:15:30.162869) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 06:15:30.175272) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-02-09 06:15:30.175657) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=0e2a256762fed810e2f0f810000001b3-1486649728.569949-2137729594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:15:30 INFO - MultiFileLogger online at 20170209 06:15:30 in /builds/slave/test 06:15:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 06:15:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:15:30 INFO - {'append_to_log': False, 06:15:30 INFO - 'base_work_dir': '/builds/slave/test', 06:15:30 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:15:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:15:30 INFO - 'branch': 'Mozilla-Aurora', 06:15:30 INFO - 'buildbot_json_path': 'buildprops.json', 06:15:30 INFO - 'config_files': ('talos/linux_config.py',), 06:15:30 INFO - 'default_actions': ('clobber', 06:15:30 INFO - 'read-buildbot-config', 06:15:30 INFO - 'download-and-extract', 06:15:30 INFO - 'populate-webroot', 06:15:30 INFO - 'create-virtualenv', 06:15:30 INFO - 'install', 06:15:30 INFO - 'run-tests'), 06:15:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:15:30 INFO - 'download_minidump_stackwalk': True, 06:15:30 INFO - 'download_symbols': 'ondemand', 06:15:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:15:30 INFO - 'tooltool.py': '/tools/tooltool.py', 06:15:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:15:30 INFO - '/tools/misc-python/virtualenv.py')}, 06:15:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:15:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:15:30 INFO - 'installer_path': 'installer.exe', 06:15:30 INFO - 'log_level': 'info', 06:15:30 INFO - 'log_name': 'talos', 06:15:30 INFO - 'log_to_console': True, 06:15:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:15:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:15:30 INFO - 'opt_config_files': (), 06:15:30 INFO - 'pip_index': False, 06:15:30 INFO - 'sps_profile': False, 06:15:30 INFO - 'sps_profile_interval': 0, 06:15:30 INFO - 'suite': 'dromaeojs-e10s', 06:15:30 INFO - 'system_bits': '32', 06:15:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:15:30 INFO - 'title': 'talos-linux64-ix-058', 06:15:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:15:30 INFO - 'use_talos_json': True, 06:15:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:15:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:15:30 INFO - 'work_dir': 'build'} 06:15:30 INFO - [mozharness: 2017-02-09 14:15:30.857295Z] Running clobber step. 06:15:30 INFO - Running pre-action listener: _resource_record_pre_action 06:15:30 INFO - Running main action method: clobber 06:15:30 INFO - rmtree: /builds/slave/test/build 06:15:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:15:31 INFO - Running post-action listener: _resource_record_post_action 06:15:31 INFO - [mozharness: 2017-02-09 14:15:31.870683Z] Finished clobber step (success) 06:15:31 INFO - [mozharness: 2017-02-09 14:15:31.870781Z] Running read-buildbot-config step. 06:15:31 INFO - Running pre-action listener: _resource_record_pre_action 06:15:31 INFO - Running main action method: read_buildbot_config 06:15:31 INFO - Using buildbot properties: 06:15:31 INFO - { 06:15:31 INFO - "project": "", 06:15:31 INFO - "product": "firefox", 06:15:31 INFO - "who": "cbook@mozilla.com", 06:15:31 INFO - "installer_path": "public/build/target.tar.bz2", 06:15:31 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 06:15:31 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 06:15:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 06:15:31 INFO - "stage_platform": "linux64-pgo", 06:15:31 INFO - "basedir": "/builds/slave/test", 06:15:31 INFO - "buildnumber": 759, 06:15:31 INFO - "platform": "ubuntu64_hw", 06:15:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:15:31 INFO - "slavebuilddir": "test", 06:15:31 INFO - "taskId": "Lbh5G-psR5yVHcR9tdZKzw", 06:15:31 INFO - "branch": "mozilla-aurora", 06:15:31 INFO - "script_repo_revision": "production", 06:15:31 INFO - "revision": "1419fa7ee013b44501b90487bf8f8873dbaf3727", 06:15:31 INFO - "slavename": "talos-linux64-ix-058", 06:15:31 INFO - "repo_path": "releases/mozilla-aurora" 06:15:31 INFO - } 06:15:31 INFO - Finding installer, test and symbols from parent task. 06:15:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Lbh5G-psR5yVHcR9tdZKzw'}, attempt #1 06:15:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Lbh5G-psR5yVHcR9tdZKzw'}, attempt #1 06:15:32 INFO - Task dependencies: VlyUM44uSPCWfYMp0CV6vg 06:15:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VlyUM44uSPCWfYMp0CV6vg'}, attempt #1 06:15:33 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/VlyUM44uSPCWfYMp0CV6vg/artifacts/public/build/target.tar.bz2 06:15:33 INFO - Set test_url: https://queue.taskcluster.net/v1/task/VlyUM44uSPCWfYMp0CV6vg/artifacts/public/build/test_packages.json 06:15:33 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/VlyUM44uSPCWfYMp0CV6vg/artifacts/public/build/target.crashreporter-symbols.zip 06:15:33 INFO - Running post-action listener: _resource_record_post_action 06:15:33 INFO - [mozharness: 2017-02-09 14:15:33.291807Z] Finished read-buildbot-config step (success) 06:15:33 INFO - [mozharness: 2017-02-09 14:15:33.292023Z] Running download-and-extract step. 06:15:33 INFO - Running pre-action listener: _resource_record_pre_action 06:15:33 INFO - Running main action method: download_and_extract 06:15:33 INFO - mkdir: /builds/slave/test/build/tests 06:15:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:33 INFO - trying https://queue.taskcluster.net/v1/task/VlyUM44uSPCWfYMp0CV6vg/artifacts/public/build/target.test_packages.json 06:15:33 INFO - Downloading https://queue.taskcluster.net/v1/task/VlyUM44uSPCWfYMp0CV6vg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:15:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VlyUM44uSPCWfYMp0CV6vg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:15:33 INFO - Downloaded 896 bytes. 06:15:33 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:15:33 INFO - Using the following test package requirements: 06:15:33 INFO - {u'common': [u'target.common.tests.zip'], 06:15:33 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:15:33 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:15:33 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:15:33 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:15:33 INFO - u'mozbase': [u'target.common.tests.zip'], 06:15:33 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:15:33 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:15:33 INFO - u'web-platform': [u'target.common.tests.zip', 06:15:33 INFO - u'target.web-platform.tests.zip'], 06:15:33 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:15:33 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:15:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VlyUM44uSPCWfYMp0CV6vg/artifacts/public/build/target.common.tests.zip 06:15:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VlyUM44uSPCWfYMp0CV6vg/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:15:33 INFO - Fetch https://queue.taskcluster.net/v1/task/VlyUM44uSPCWfYMp0CV6vg/artifacts/public/build/target.common.tests.zip into memory 06:15:34 INFO - Expected file size: 21859078 06:15:34 INFO - Obtained file size: 21859078 06:15:38 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:15:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VlyUM44uSPCWfYMp0CV6vg/artifacts/public/build/target.common.tests.zip 06:15:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VlyUM44uSPCWfYMp0CV6vg/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:15:38 INFO - Fetch https://queue.taskcluster.net/v1/task/VlyUM44uSPCWfYMp0CV6vg/artifacts/public/build/target.common.tests.zip into memory 06:15:39 INFO - Expected file size: 21859078 06:15:39 INFO - Obtained file size: 21859078 06:15:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VlyUM44uSPCWfYMp0CV6vg/artifacts/public/build/target.talos.tests.zip 06:15:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VlyUM44uSPCWfYMp0CV6vg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:15:44 INFO - Fetch https://queue.taskcluster.net/v1/task/VlyUM44uSPCWfYMp0CV6vg/artifacts/public/build/target.talos.tests.zip into memory 06:15:44 INFO - Expected file size: 14403485 06:15:44 INFO - Obtained file size: 14403485 06:15:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:45 INFO - trying https://queue.taskcluster.net/v1/task/VlyUM44uSPCWfYMp0CV6vg/artifacts/public/build/target.tar.bz2 06:15:45 INFO - Downloading https://queue.taskcluster.net/v1/task/VlyUM44uSPCWfYMp0CV6vg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:15:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VlyUM44uSPCWfYMp0CV6vg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:15:46 INFO - Downloaded 66140780 bytes. 06:15:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VlyUM44uSPCWfYMp0CV6vg/artifacts/public/build/target.tar.bz2 06:15:46 INFO - mkdir: /builds/slave/test/properties 06:15:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:15:46 INFO - Writing to file /builds/slave/test/properties/build_url 06:15:46 INFO - Contents: 06:15:46 INFO - build_url:https://queue.taskcluster.net/v1/task/VlyUM44uSPCWfYMp0CV6vg/artifacts/public/build/target.tar.bz2 06:15:46 INFO - Running post-action listener: _resource_record_post_action 06:15:46 INFO - Running post-action listener: set_extra_try_arguments 06:15:46 INFO - [mozharness: 2017-02-09 14:15:46.286832Z] Finished download-and-extract step (success) 06:15:46 INFO - [mozharness: 2017-02-09 14:15:46.286929Z] Running populate-webroot step. 06:15:46 INFO - Running pre-action listener: _resource_record_pre_action 06:15:46 INFO - Running main action method: populate_webroot 06:15:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:15:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:15:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:15:46 INFO - '--tppagecycles', 06:15:46 INFO - '7'], 06:15:46 INFO - 'tests': ['tsvgm']}}, 06:15:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:15:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:15:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:15:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:15:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:15:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:15:46 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:15:46 INFO - 'talos_options': ['--disable-e10s'], 06:15:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:15:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:15:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:15:46 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:15:46 INFO - 'talos_options': ['--disable-e10s'], 06:15:46 INFO - 'tests': ['damp', 'tps']}, 06:15:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:15:46 INFO - 'tests': ['damp', 'tps']}, 06:15:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:15:46 INFO - 'tests': ['dromaeo_dom']}, 06:15:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:15:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:15:46 INFO - 'tests': ['basic_compositor_video']}, 06:15:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:15:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:15:46 INFO - 'tests': ['a11yr', 06:15:46 INFO - 'ts_paint', 06:15:46 INFO - 'tpaint', 06:15:46 INFO - 'sessionrestore', 06:15:46 INFO - 'sessionrestore_no_auto_restore', 06:15:46 INFO - 'tabpaint']}, 06:15:46 INFO - 'other-e10s': {'tests': ['a11yr', 06:15:46 INFO - 'ts_paint', 06:15:46 INFO - 'tpaint', 06:15:46 INFO - 'sessionrestore', 06:15:46 INFO - 'sessionrestore_no_auto_restore', 06:15:46 INFO - 'tabpaint']}, 06:15:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:15:46 INFO - 'ts_paint', 06:15:46 INFO - 'tpaint', 06:15:46 INFO - 'sessionrestore', 06:15:46 INFO - 'sessionrestore_no_auto_restore', 06:15:46 INFO - 'tabpaint']}, 06:15:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:15:46 INFO - 'ts_paint', 06:15:46 INFO - 'tpaint', 06:15:46 INFO - 'sessionrestore', 06:15:46 INFO - 'sessionrestore_no_auto_restore', 06:15:46 INFO - 'tabpaint']}, 06:15:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:15:46 INFO - 'tests': ['a11yr', 06:15:46 INFO - 'ts_paint', 06:15:46 INFO - 'tpaint', 06:15:46 INFO - 'sessionrestore', 06:15:46 INFO - 'sessionrestore_no_auto_restore', 06:15:46 INFO - 'tabpaint']}, 06:15:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:15:46 INFO - 'tests': ['a11yr', 06:15:46 INFO - 'ts_paint', 06:15:46 INFO - 'tpaint', 06:15:46 INFO - 'sessionrestore', 06:15:46 INFO - 'sessionrestore_no_auto_restore', 06:15:46 INFO - 'tabpaint']}, 06:15:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:15:46 INFO - 'tests': ['tsvgx', 06:15:46 INFO - 'tsvgr_opacity', 06:15:46 INFO - 'tart', 06:15:46 INFO - 'tscrollx', 06:15:46 INFO - 'cart', 06:15:46 INFO - 'tsvg_static']}, 06:15:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:15:46 INFO - 'tsvgr_opacity', 06:15:46 INFO - 'tart', 06:15:46 INFO - 'tscrollx', 06:15:46 INFO - 'cart', 06:15:46 INFO - 'tsvg_static']}, 06:15:46 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:15:46 INFO - 'talos_options': ['--disable-e10s'], 06:15:46 INFO - 'tests': ['tp5o']}, 06:15:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:15:46 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:15:46 INFO - 'talos_options': ['--disable-e10s', 06:15:46 INFO - '--xperf_path', 06:15:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:15:46 INFO - 'tests': ['tp5n']}, 06:15:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:15:46 INFO - 'talos_options': ['--xperf_path', 06:15:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:15:46 INFO - 'tests': ['tp5n']}}, 06:15:46 INFO - 'talos.zip': {'path': '', 06:15:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:15:46 INFO - Running post-action listener: _resource_record_post_action 06:15:46 INFO - [mozharness: 2017-02-09 14:15:46.300141Z] Finished populate-webroot step (success) 06:15:46 INFO - [mozharness: 2017-02-09 14:15:46.300231Z] Running create-virtualenv step. 06:15:46 INFO - Running pre-action listener: _resource_record_pre_action 06:15:46 INFO - Running main action method: create_virtualenv 06:15:46 INFO - Creating virtualenv /builds/slave/test/build/venv 06:15:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:15:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:15:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:15:46 INFO - Using real prefix '/usr' 06:15:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:15:46 INFO - Installing distribute.............................................................................................................................................................................................done. 06:15:48 INFO - Installing pip.................done. 06:15:48 INFO - Return code: 0 06:15:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:15:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:15:49 INFO - Reading from file tmpfile_stdout 06:15:49 INFO - Output received: 06:15:49 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 06:15:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:49 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 0x13681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1479a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16da480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d7820>, '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 0x16d8520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d89b0>, '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': '0e2a256762fed810e2f0f810000001b3-1486649728.569949-2137729594', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:15:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:15:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:15:49 INFO - Using env: {'DISPLAY': ':0', 06:15:49 INFO - 'HOME': '/home/cltbld', 06:15:49 INFO - 'LANG': 'en_US.UTF-8', 06:15:49 INFO - 'LANGUAGE': 'en_US:en', 06:15:49 INFO - 'LOGNAME': 'cltbld', 06:15:49 INFO - 'MAIL': '/var/mail/cltbld', 06:15:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:49 INFO - 'MOZ_NO_REMOTE': '1', 06:15:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:49 INFO - 'NO_EM_RESTART': '1', 06:15:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:49 INFO - 'PWD': '/builds/slave/test', 06:15:49 INFO - 'SHELL': '/bin/bash', 06:15:49 INFO - 'SHLVL': '1', 06:15:49 INFO - 'TERM': 'linux', 06:15:49 INFO - 'TMOUT': '86400', 06:15:49 INFO - 'USER': 'cltbld', 06:15:49 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1486649728.569949-2137729594', 06:15:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:49 INFO - '_': '/tools/buildbot/bin/python'} 06:15:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:15:49 INFO - Cleaning up... 06:15:49 INFO - Return code: 0 06:15:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:49 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 0x13681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1479a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16da480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d7820>, '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 0x16d8520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d89b0>, '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': '0e2a256762fed810e2f0f810000001b3-1486649728.569949-2137729594', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:15:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:15:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:15:49 INFO - Using env: {'DISPLAY': ':0', 06:15:49 INFO - 'HOME': '/home/cltbld', 06:15:49 INFO - 'LANG': 'en_US.UTF-8', 06:15:49 INFO - 'LANGUAGE': 'en_US:en', 06:15:49 INFO - 'LOGNAME': 'cltbld', 06:15:49 INFO - 'MAIL': '/var/mail/cltbld', 06:15:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:49 INFO - 'MOZ_NO_REMOTE': '1', 06:15:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:49 INFO - 'NO_EM_RESTART': '1', 06:15:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:49 INFO - 'PWD': '/builds/slave/test', 06:15:49 INFO - 'SHELL': '/bin/bash', 06:15:49 INFO - 'SHLVL': '1', 06:15:49 INFO - 'TERM': 'linux', 06:15:49 INFO - 'TMOUT': '86400', 06:15:49 INFO - 'USER': 'cltbld', 06:15:49 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1486649728.569949-2137729594', 06:15:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:49 INFO - '_': '/tools/buildbot/bin/python'} 06:15:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:49 INFO - Downloading/unpacking psutil>=3.1.1 06:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:15:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:15:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:15:51 INFO - Installing collected packages: psutil 06:15:51 INFO - Running setup.py install for psutil 06:15:51 INFO - building 'psutil._psutil_linux' extension 06:15:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:15:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:15:51 INFO - building 'psutil._psutil_posix' extension 06:15:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:15:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:15:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:15:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:15:52 INFO - Successfully installed psutil 06:15:52 INFO - Cleaning up... 06:15:52 INFO - Return code: 0 06:15:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:15:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:52 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 0x13681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1479a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16da480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d7820>, '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 0x16d8520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d89b0>, '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': '0e2a256762fed810e2f0f810000001b3-1486649728.569949-2137729594', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:15:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:15:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:15:52 INFO - Using env: {'DISPLAY': ':0', 06:15:52 INFO - 'HOME': '/home/cltbld', 06:15:52 INFO - 'LANG': 'en_US.UTF-8', 06:15:52 INFO - 'LANGUAGE': 'en_US:en', 06:15:52 INFO - 'LOGNAME': 'cltbld', 06:15:52 INFO - 'MAIL': '/var/mail/cltbld', 06:15:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:52 INFO - 'MOZ_NO_REMOTE': '1', 06:15:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:52 INFO - 'NO_EM_RESTART': '1', 06:15:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:52 INFO - 'PWD': '/builds/slave/test', 06:15:52 INFO - 'SHELL': '/bin/bash', 06:15:52 INFO - 'SHLVL': '1', 06:15:52 INFO - 'TERM': 'linux', 06:15:52 INFO - 'TMOUT': '86400', 06:15:52 INFO - 'USER': 'cltbld', 06:15:52 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1486649728.569949-2137729594', 06:15:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:52 INFO - '_': '/tools/buildbot/bin/python'} 06:15:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:15:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:15:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:15:54 INFO - Installing collected packages: mozsystemmonitor 06:15:54 INFO - Running setup.py install for mozsystemmonitor 06:15:54 INFO - Successfully installed mozsystemmonitor 06:15:54 INFO - Cleaning up... 06:15:54 INFO - Return code: 0 06:15:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:54 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 0x13681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1479a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16da480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d7820>, '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 0x16d8520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d89b0>, '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': '0e2a256762fed810e2f0f810000001b3-1486649728.569949-2137729594', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:15:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:15:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:15:54 INFO - Using env: {'DISPLAY': ':0', 06:15:54 INFO - 'HOME': '/home/cltbld', 06:15:54 INFO - 'LANG': 'en_US.UTF-8', 06:15:54 INFO - 'LANGUAGE': 'en_US:en', 06:15:54 INFO - 'LOGNAME': 'cltbld', 06:15:54 INFO - 'MAIL': '/var/mail/cltbld', 06:15:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:54 INFO - 'MOZ_NO_REMOTE': '1', 06:15:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:54 INFO - 'NO_EM_RESTART': '1', 06:15:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:54 INFO - 'PWD': '/builds/slave/test', 06:15:54 INFO - 'SHELL': '/bin/bash', 06:15:54 INFO - 'SHLVL': '1', 06:15:54 INFO - 'TERM': 'linux', 06:15:54 INFO - 'TMOUT': '86400', 06:15:54 INFO - 'USER': 'cltbld', 06:15:54 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1486649728.569949-2137729594', 06:15:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:54 INFO - '_': '/tools/buildbot/bin/python'} 06:15:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:54 INFO - Downloading/unpacking jsonschema==2.5.1 06:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:15:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:57 INFO - Downloading functools32-3.2.3-2.tar.gz 06:15:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:15:57 INFO - warning: no files found matching '*.txt' 06:15:57 INFO - no previously-included directories found matching 'build' 06:15:57 INFO - no previously-included directories found matching 'dist' 06:15:57 INFO - no previously-included directories found matching '.git*' 06:15:57 INFO - Installing collected packages: jsonschema, functools32 06:15:57 INFO - Running setup.py install for functools32 06:15:57 INFO - warning: no files found matching '*.txt' 06:15:57 INFO - no previously-included directories found matching 'build' 06:15:57 INFO - no previously-included directories found matching 'dist' 06:15:57 INFO - no previously-included directories found matching '.git*' 06:15:57 INFO - Successfully installed jsonschema functools32 06:15:57 INFO - Cleaning up... 06:15:57 INFO - Return code: 0 06:15:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:57 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 0x13681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1479a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16da480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d7820>, '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 0x16d8520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d89b0>, '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': '0e2a256762fed810e2f0f810000001b3-1486649728.569949-2137729594', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:15:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:15:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:15:57 INFO - Using env: {'DISPLAY': ':0', 06:15:57 INFO - 'HOME': '/home/cltbld', 06:15:57 INFO - 'LANG': 'en_US.UTF-8', 06:15:57 INFO - 'LANGUAGE': 'en_US:en', 06:15:57 INFO - 'LOGNAME': 'cltbld', 06:15:57 INFO - 'MAIL': '/var/mail/cltbld', 06:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:57 INFO - 'MOZ_NO_REMOTE': '1', 06:15:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:57 INFO - 'NO_EM_RESTART': '1', 06:15:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:57 INFO - 'PWD': '/builds/slave/test', 06:15:57 INFO - 'SHELL': '/bin/bash', 06:15:57 INFO - 'SHLVL': '1', 06:15:57 INFO - 'TERM': 'linux', 06:15:57 INFO - 'TMOUT': '86400', 06:15:57 INFO - 'USER': 'cltbld', 06:15:57 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1486649728.569949-2137729594', 06:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:57 INFO - '_': '/tools/buildbot/bin/python'} 06:15:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:15:57 INFO - Cleaning up... 06:15:57 INFO - Return code: 0 06:15:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:57 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 0x13681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1479a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16da480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d7820>, '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 0x16d8520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d89b0>, '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': '0e2a256762fed810e2f0f810000001b3-1486649728.569949-2137729594', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:15:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:15:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:15:57 INFO - Using env: {'DISPLAY': ':0', 06:15:57 INFO - 'HOME': '/home/cltbld', 06:15:57 INFO - 'LANG': 'en_US.UTF-8', 06:15:57 INFO - 'LANGUAGE': 'en_US:en', 06:15:57 INFO - 'LOGNAME': 'cltbld', 06:15:57 INFO - 'MAIL': '/var/mail/cltbld', 06:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:57 INFO - 'MOZ_NO_REMOTE': '1', 06:15:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:57 INFO - 'NO_EM_RESTART': '1', 06:15:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:57 INFO - 'PWD': '/builds/slave/test', 06:15:57 INFO - 'SHELL': '/bin/bash', 06:15:57 INFO - 'SHLVL': '1', 06:15:57 INFO - 'TERM': 'linux', 06:15:57 INFO - 'TMOUT': '86400', 06:15:57 INFO - 'USER': 'cltbld', 06:15:57 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1486649728.569949-2137729594', 06:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:57 INFO - '_': '/tools/buildbot/bin/python'} 06:15:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:57 INFO - Downloading/unpacking blobuploader==1.2.4 06:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:59 INFO - Downloading blobuploader-1.2.4.tar.gz 06:15:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:15:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:16:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:16:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:16:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:16:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:16:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:16:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:16:00 INFO - Downloading docopt-0.6.1.tar.gz 06:16:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:16:00 INFO - Installing collected packages: blobuploader, requests, docopt 06:16:00 INFO - Running setup.py install for blobuploader 06:16:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:16:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:16:00 INFO - Running setup.py install for requests 06:16:01 INFO - Running setup.py install for docopt 06:16:01 INFO - Successfully installed blobuploader requests docopt 06:16:01 INFO - Cleaning up... 06:16:01 INFO - Return code: 0 06:16:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:16:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:16:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:16:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16:01 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 0x13681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1479a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16da480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d7820>, '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 0x16d8520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d89b0>, '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': '0e2a256762fed810e2f0f810000001b3-1486649728.569949-2137729594', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:16:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:16:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:16:01 INFO - Using env: {'DISPLAY': ':0', 06:16:01 INFO - 'HOME': '/home/cltbld', 06:16:01 INFO - 'LANG': 'en_US.UTF-8', 06:16:01 INFO - 'LANGUAGE': 'en_US:en', 06:16:01 INFO - 'LOGNAME': 'cltbld', 06:16:01 INFO - 'MAIL': '/var/mail/cltbld', 06:16:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:01 INFO - 'MOZ_NO_REMOTE': '1', 06:16:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:01 INFO - 'NO_EM_RESTART': '1', 06:16:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:01 INFO - 'PWD': '/builds/slave/test', 06:16:01 INFO - 'SHELL': '/bin/bash', 06:16:01 INFO - 'SHLVL': '1', 06:16:01 INFO - 'TERM': 'linux', 06:16:01 INFO - 'TMOUT': '86400', 06:16:01 INFO - 'USER': 'cltbld', 06:16:01 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1486649728.569949-2137729594', 06:16:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:01 INFO - '_': '/tools/buildbot/bin/python'} 06:16:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:16:01 INFO - Running setup.py (path:/tmp/pip-z2PKTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:16:01 INFO - Running setup.py (path:/tmp/pip-L1cVvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:16:01 INFO - Running setup.py (path:/tmp/pip-pP6_sY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:16:01 INFO - Running setup.py (path:/tmp/pip-eE9ver-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:16:01 INFO - Running setup.py (path:/tmp/pip-neMBiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:16:01 INFO - Running setup.py (path:/tmp/pip-QeJu7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:16:01 INFO - Running setup.py (path:/tmp/pip-XdLlNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:16:01 INFO - Running setup.py (path:/tmp/pip-lNUURW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:16:01 INFO - Running setup.py (path:/tmp/pip-D9rlro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:16:02 INFO - Running setup.py (path:/tmp/pip-zvG9C2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:16:02 INFO - Running setup.py (path:/tmp/pip-wpDdeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:16:02 INFO - Running setup.py (path:/tmp/pip-gM8mJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:16:02 INFO - Running setup.py (path:/tmp/pip-lYR67M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:16:02 INFO - Running setup.py (path:/tmp/pip-KclmEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:16:02 INFO - Running setup.py (path:/tmp/pip-QxqUIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:16:02 INFO - Running setup.py (path:/tmp/pip-j5PDT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:16:02 INFO - Running setup.py (path:/tmp/pip-cc44kT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:16:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:16:02 INFO - Running setup.py install for manifestparser 06:16:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:16:02 INFO - Running setup.py install for mozcrash 06:16:02 INFO - Running setup.py install for mozdebug 06:16:02 INFO - Running setup.py install for mozdevice 06:16:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:16:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:16:03 INFO - Running setup.py install for mozfile 06:16:03 INFO - Running setup.py install for mozhttpd 06:16:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:16:03 INFO - Running setup.py install for mozinfo 06:16:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:16:03 INFO - Running setup.py install for mozInstall 06:16:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:16:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:16:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:16:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:16:03 INFO - Running setup.py install for mozleak 06:16:03 INFO - Running setup.py install for mozlog 06:16:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:16:03 INFO - Running setup.py install for moznetwork 06:16:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:16:03 INFO - Running setup.py install for mozprocess 06:16:03 INFO - Running setup.py install for mozprofile 06:16:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:16:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:16:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:16:04 INFO - Running setup.py install for mozrunner 06:16:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:16:04 INFO - Running setup.py install for mozscreenshot 06:16:04 INFO - Running setup.py install for moztest 06:16:04 INFO - Running setup.py install for mozversion 06:16:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:16:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:16:04 INFO - Cleaning up... 06:16:04 INFO - Return code: 0 06:16:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:16:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:16:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:16:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16:04 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 0x13681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1479a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16da480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d7820>, '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 0x16d8520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d89b0>, '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': '0e2a256762fed810e2f0f810000001b3-1486649728.569949-2137729594', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:16:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:16:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:16:04 INFO - Using env: {'DISPLAY': ':0', 06:16:04 INFO - 'HOME': '/home/cltbld', 06:16:04 INFO - 'LANG': 'en_US.UTF-8', 06:16:04 INFO - 'LANGUAGE': 'en_US:en', 06:16:04 INFO - 'LOGNAME': 'cltbld', 06:16:04 INFO - 'MAIL': '/var/mail/cltbld', 06:16:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:04 INFO - 'MOZ_NO_REMOTE': '1', 06:16:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:04 INFO - 'NO_EM_RESTART': '1', 06:16:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:04 INFO - 'PWD': '/builds/slave/test', 06:16:04 INFO - 'SHELL': '/bin/bash', 06:16:04 INFO - 'SHLVL': '1', 06:16:04 INFO - 'TERM': 'linux', 06:16:04 INFO - 'TMOUT': '86400', 06:16:04 INFO - 'USER': 'cltbld', 06:16:04 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1486649728.569949-2137729594', 06:16:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:04 INFO - '_': '/tools/buildbot/bin/python'} 06:16:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:16:04 INFO - Running setup.py (path:/tmp/pip-AYStN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:16:04 INFO - Running setup.py (path:/tmp/pip-PSQSZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:16:04 INFO - Running setup.py (path:/tmp/pip-9ROcUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:16:04 INFO - Running setup.py (path:/tmp/pip-AYhUXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:16:04 INFO - Running setup.py (path:/tmp/pip-Z_PeTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:16:05 INFO - Running setup.py (path:/tmp/pip-8PKKvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:16:05 INFO - Running setup.py (path:/tmp/pip-FXdkEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:16:05 INFO - Running setup.py (path:/tmp/pip-5gPkFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:16:05 INFO - Running setup.py (path:/tmp/pip-h58Rw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:16:05 INFO - Running setup.py (path:/tmp/pip-YXtQ12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:16:05 INFO - Running setup.py (path:/tmp/pip-aafD4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:16:05 INFO - Running setup.py (path:/tmp/pip-U4V9Ep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:16:05 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)) 06:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:16:05 INFO - Running setup.py (path:/tmp/pip-RryYT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:16:05 INFO - Running setup.py (path:/tmp/pip-Gz1ku5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:16:05 INFO - Running setup.py (path:/tmp/pip-OgWxXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:16:05 INFO - Running setup.py (path:/tmp/pip-W1WBwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:16:05 INFO - Running setup.py (path:/tmp/pip-xKqfct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:16:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:16:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:16:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:16:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:16:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:16:07 INFO - Downloading blessings-1.6.tar.gz 06:16:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:16:08 INFO - Installing collected packages: blessings 06:16:08 INFO - Running setup.py install for blessings 06:16:08 INFO - Successfully installed blessings 06:16:08 INFO - Cleaning up... 06:16:08 INFO - Return code: 0 06:16:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:16:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:16:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:16:08 INFO - Reading from file tmpfile_stdout 06:16:08 INFO - Current package versions: 06:16:08 INFO - argparse == 1.2.1 06:16:08 INFO - blessings == 1.6 06:16:08 INFO - blobuploader == 1.2.4 06:16:08 INFO - docopt == 0.6.1 06:16:08 INFO - functools32 == 3.2.3-2 06:16:08 INFO - jsonschema == 2.5.1 06:16:08 INFO - manifestparser == 1.1 06:16:08 INFO - mozInstall == 1.12 06:16:08 INFO - mozcrash == 1.0 06:16:08 INFO - mozdebug == 0.1 06:16:08 INFO - mozdevice == 0.49 06:16:08 INFO - mozfile == 1.2 06:16:08 INFO - mozhttpd == 0.7 06:16:08 INFO - mozinfo == 0.9 06:16:08 INFO - mozleak == 0.1 06:16:08 INFO - mozlog == 3.4 06:16:08 INFO - moznetwork == 0.27 06:16:08 INFO - mozprocess == 0.24 06:16:08 INFO - mozprofile == 0.28 06:16:08 INFO - mozrunner == 6.13 06:16:08 INFO - mozscreenshot == 0.1 06:16:08 INFO - mozsystemmonitor == 0.3 06:16:08 INFO - moztest == 0.8 06:16:08 INFO - mozversion == 1.4 06:16:08 INFO - psutil == 3.1.1 06:16:08 INFO - requests == 1.2.3 06:16:08 INFO - wsgiref == 0.1.2 06:16:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:16:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:16:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:16:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16:08 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 0x13681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1479a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16da480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d7820>, '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 0x16d8520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d89b0>, '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': '0e2a256762fed810e2f0f810000001b3-1486649728.569949-2137729594', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:16:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:16:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:16:08 INFO - Using env: {'DISPLAY': ':0', 06:16:08 INFO - 'HOME': '/home/cltbld', 06:16:08 INFO - 'LANG': 'en_US.UTF-8', 06:16:08 INFO - 'LANGUAGE': 'en_US:en', 06:16:08 INFO - 'LOGNAME': 'cltbld', 06:16:08 INFO - 'MAIL': '/var/mail/cltbld', 06:16:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:08 INFO - 'MOZ_NO_REMOTE': '1', 06:16:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:08 INFO - 'NO_EM_RESTART': '1', 06:16:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:08 INFO - 'PWD': '/builds/slave/test', 06:16:08 INFO - 'SHELL': '/bin/bash', 06:16:08 INFO - 'SHLVL': '1', 06:16:08 INFO - 'TERM': 'linux', 06:16:08 INFO - 'TMOUT': '86400', 06:16:08 INFO - 'USER': 'cltbld', 06:16:08 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1486649728.569949-2137729594', 06:16:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:08 INFO - '_': '/tools/buildbot/bin/python'} 06:16:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:16:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:16:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:16:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:16:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:16:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:16:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:16:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:16:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:16:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:16:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:16:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:16:08 INFO - Cleaning up... 06:16:08 INFO - Return code: 0 06:16:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:16:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:16:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:16:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16:08 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 0x13681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1479a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16da480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d7820>, '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 0x16d8520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d89b0>, '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': '0e2a256762fed810e2f0f810000001b3-1486649728.569949-2137729594', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:16:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:16:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:16:08 INFO - Using env: {'DISPLAY': ':0', 06:16:08 INFO - 'HOME': '/home/cltbld', 06:16:08 INFO - 'LANG': 'en_US.UTF-8', 06:16:08 INFO - 'LANGUAGE': 'en_US:en', 06:16:08 INFO - 'LOGNAME': 'cltbld', 06:16:08 INFO - 'MAIL': '/var/mail/cltbld', 06:16:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:08 INFO - 'MOZ_NO_REMOTE': '1', 06:16:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:08 INFO - 'NO_EM_RESTART': '1', 06:16:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:08 INFO - 'PWD': '/builds/slave/test', 06:16:08 INFO - 'SHELL': '/bin/bash', 06:16:08 INFO - 'SHLVL': '1', 06:16:08 INFO - 'TERM': 'linux', 06:16:08 INFO - 'TMOUT': '86400', 06:16:08 INFO - 'USER': 'cltbld', 06:16:08 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1486649728.569949-2137729594', 06:16:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:08 INFO - '_': '/tools/buildbot/bin/python'} 06:16:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:16:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:16:08 INFO - Cleaning up... 06:16:08 INFO - Return code: 0 06:16:08 INFO - Running post-action listener: _resource_record_post_action 06:16:08 INFO - Running post-action listener: _start_resource_monitoring 06:16:08 INFO - Starting resource monitoring. 06:16:08 INFO - [mozharness: 2017-02-09 14:16:08.902977Z] Finished create-virtualenv step (success) 06:16:08 INFO - [mozharness: 2017-02-09 14:16:08.903430Z] Running install step. 06:16:08 INFO - Running pre-action listener: _resource_record_pre_action 06:16:08 INFO - Running main action method: install 06:16:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:16:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:16:09 INFO - Reading from file tmpfile_stdout 06:16:09 INFO - Detecting whether we're running mozinstall >=1.0... 06:16:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:16:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:16:09 INFO - Reading from file tmpfile_stdout 06:16:09 INFO - Output received: 06:16:09 INFO - Usage: mozinstall [options] installer 06:16:09 INFO - Options: 06:16:09 INFO - -h, --help show this help message and exit 06:16:09 INFO - -d DEST, --destination=DEST 06:16:09 INFO - Directory to install application into. [default: 06:16:09 INFO - "/builds/slave/test"] 06:16:09 INFO - --app=APP Application being installed. [default: firefox] 06:16:09 INFO - mkdir: /builds/slave/test/build/application 06:16:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:16:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:16:25 INFO - Reading from file tmpfile_stdout 06:16:25 INFO - Output received: 06:16:25 INFO - /builds/slave/test/build/application/firefox/firefox 06:16:25 INFO - Running post-action listener: _resource_record_post_action 06:16:25 INFO - [mozharness: 2017-02-09 14:16:25.723829Z] Finished install step (success) 06:16:25 INFO - [mozharness: 2017-02-09 14:16:25.724102Z] Running run-tests step. 06:16:25 INFO - Running pre-action listener: _resource_record_pre_action 06:16:25 INFO - Running main action method: run_tests 06:16:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:16:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:16:25 INFO - Python 2.7.3 06:16:25 INFO - Return code: 0 06:16:25 INFO - grabbing minidump binary from tooltool 06:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:25 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 0x16d7820>, '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 0x16d8520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d89b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:16:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:16:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:16:25 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:16:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:16:25 INFO - Return code: 0 06:16:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:16:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:16:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:16:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:16:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:16:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VlyUM44uSPCWfYMp0CV6vg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:16:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VlyUM44uSPCWfYMp0CV6vg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-058 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:16:25 INFO - Using env: {'DISPLAY': ':0', 06:16:25 INFO - 'HOME': '/home/cltbld', 06:16:25 INFO - 'LANG': 'en_US.UTF-8', 06:16:25 INFO - 'LANGUAGE': 'en_US:en', 06:16:25 INFO - 'LOGNAME': 'cltbld', 06:16:25 INFO - 'MAIL': '/var/mail/cltbld', 06:16:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:16:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:16:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:25 INFO - 'MOZ_NO_REMOTE': '1', 06:16:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:16:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:25 INFO - 'NO_EM_RESTART': '1', 06:16:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:25 INFO - 'PWD': '/builds/slave/test', 06:16:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:16:25 INFO - 'SHELL': '/bin/bash', 06:16:25 INFO - 'SHLVL': '1', 06:16:25 INFO - 'TERM': 'linux', 06:16:25 INFO - 'TMOUT': '86400', 06:16:25 INFO - 'USER': 'cltbld', 06:16:25 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1486649728.569949-2137729594', 06:16:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:25 INFO - '_': '/tools/buildbot/bin/python'} 06:16:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VlyUM44uSPCWfYMp0CV6vg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:16:26 INFO - mozversion application_buildid: 20170209131207 06:16:26 INFO - mozversion application_changeset: 1419fa7ee013b44501b90487bf8f8873dbaf3727 06:16:26 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:16:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:16:26 INFO - mozversion application_name: Firefox 06:16:26 INFO - mozversion application_remotingname: firefox-dev 06:16:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:16:26 INFO - mozversion application_vendor: Mozilla 06:16:26 INFO - mozversion application_version: 53.0a2 06:16:26 INFO - mozversion platform_buildid: 20170209131207 06:16:26 INFO - mozversion platform_changeset: 1419fa7ee013b44501b90487bf8f8873dbaf3727 06:16:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:16:26 INFO - mozversion platform_version: 53.0a2 06:16:26 INFO - using testdate: 1486649786 06:16:26 INFO - actual date: 1486649786 06:16:26 INFO - starting webserver on 'localhost:38224' 06:16:26 INFO - SUITE-START | Running 2 tests 06:16:26 INFO - TEST-START | dromaeo_css 06:16:26 INFO - operating with platform_type : linux_ 06:16:26 INFO - Initialising browser for dromaeo_css test... 06:16:26 INFO - TEST-INFO | started process 573 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4kJcks/profile http://localhost:38224/getInfo.html) 06:16:30 INFO - PROCESS | 573 | __metrics Screen width/height:1600/1200 06:16:30 INFO - PROCESS | 573 | colorDepth:24 06:16:30 INFO - PROCESS | 573 | Browser inner width/height: 1024/697 06:16:30 INFO - PROCESS | 573 | __metrics 06:16:31 INFO - PROCESS | 573 | 1486649791169 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < permitUnload@remote-browser.xml:353:13 < CanCloseWindow@browser.js:6277:36 < canClose@browser.js:5143:12 < forceQuit@jar:file:///tmp/tmp4kJcks/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmp4kJcks/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmp4kJcks/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmp4kJcks/profile/extensions/talos-powers@TalosPowersService.js:55:9 06:16:31 ERROR - PROCESS | 573 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 06:16:32 INFO - TEST-INFO | 573: exit 0 06:16:32 INFO - Browser initialized. 06:16:32 INFO - Running cycle 1/1 for dromaeo_css test... 06:16:32 INFO - TEST-INFO | started process 703 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4kJcks/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:16:44 INFO - PROCESS | 703 | RSS: Main: 144670720 06:16:44 INFO - PROCESS | 703 | 06:19:43 INFO - PROCESS | 703 | Cycle 1(1): loaded http://localhost:38224/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38224/tests/dromaeo/cssquery-ext.html) 06:19:44 INFO - PROCESS | 703 | RSS: Main: 154800128 06:19:44 INFO - PROCESS | 703 | 06:21:32 INFO - PROCESS | 703 | ************************* 06:21:32 INFO - PROCESS | 703 | A coding exception was thrown and uncaught in a Task. 06:21:32 INFO - PROCESS | 703 | 06:21:32 ERROR - PROCESS | 703 | Full message: TypeError: NetworkError when attempting to fetch resource. 06:21:32 INFO - PROCESS | 703 | Full stack: 06:21:32 INFO - PROCESS | 703 | ************************* 06:22:46 INFO - PROCESS | 703 | Cycle 1(1): loaded http://localhost:38224/tests/dromaeo/cssquery-ext.html (next: http://localhost:38224/tests/dromaeo/cssquery-jquery.html) 06:22:47 INFO - PROCESS | 703 | RSS: Main: 149811200 06:22:47 INFO - PROCESS | 703 | 06:25:48 INFO - PROCESS | 703 | Cycle 1(1): loaded http://localhost:38224/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38224/tests/dromaeo/cssquery-mootools.html) 06:25:49 INFO - PROCESS | 703 | RSS: Main: 153378816 06:25:49 INFO - PROCESS | 703 | 06:28:51 INFO - PROCESS | 703 | Cycle 1(1): loaded http://localhost:38224/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38224/tests/dromaeo/cssquery-prototype.html) 06:28:51 INFO - PROCESS | 703 | RSS: Main: 149651456 06:28:51 INFO - PROCESS | 703 | 06:31:54 INFO - PROCESS | 703 | Cycle 1(1): loaded http://localhost:38224/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38224/tests/dromaeo/cssquery-yui.html) 06:31:54 INFO - PROCESS | 703 | RSS: Main: 152993792 06:31:54 INFO - PROCESS | 703 | 06:34:57 INFO - PROCESS | 703 | Cycle 1(1): loaded http://localhost:38224/tests/dromaeo/cssquery-yui.html (next: http://localhost:38224/tests/dromaeo/cssquery-dojo.html) 06:34:57 INFO - PROCESS | 703 | RSS: Main: 154001408 06:34:57 INFO - PROCESS | 703 | 06:34:57 INFO - PROCESS | 703 | __start_tp_report 06:34:57 INFO - PROCESS | 703 | _x_x_mozilla_page_load 06:34:57 INFO - PROCESS | 703 | _x_x_mozilla_page_load_details 06:34:57 INFO - PROCESS | 703 | |i|pagename|runs| 06:34:57 INFO - PROCESS | 703 | |0;dojo.html;3175.714185723285;3221.613406391233;3244.0430073128423;3246.659100794415;3270.133414645118;5455.045367060763;5512.118061110224;5549.084401073823;5558.194061861028;5566.053770858959;5540;5554.361248456429;5559.11054231323;5585.692786896719;5596.496315331619;5021.3221215135945;5048.4951504849405;5145.459726728695;5163.7159956202395;5172.456892026339;5070.797168113289;5159.664621799589;5160.948390516084;5173.042987047389;5174.844754657347;4978.601711863061;4986.825461108844;4997.375328083989;5167.302414174076;5168.173092305232;5046.5710414614805;5136.743162841843;5138.409082955433;5154.768035438396;5178.663386879878;5012.548870601627;5090.312807770941;5102.846914592568;5112.9744351278005;5147.124988751883;5180.974095129538;5197.29836472079;5446.474987003646;5462.945370546284;5560.304961879765;5780.132980052984;5781.479666830005;5812.912806307909;5885.087811389241;5932.466078052996;5918.319393269786;5925.7333419995775;5929.110633404981;5934.080217566284;5958.046712526018;5447.428020057916;5451.209574611659;5506.91739623902;5533.584981126432;5546.667199968015;5879.676617785977;5907;5909.349971503131;5942.108683697394;6022.638641681513;5716.514096301861;5776.566757493205;5779.162021506942;5787.1319302104175;5790.71046447676;5802.796902108406;5827.184194212814;5858.06270996647;5866.23738913947;5867.14926335679;5695.373508914016;5743.62666426681;5792.623479473821;5820.767169313265;5840;5809.099589563624;5891.941080589139;5894.086416605433;5907.143464197753;5936.436038576328;4577.725336479822;4585.358049873021;4601.24079526881;4602.65480088988;4608.9308660370125;3992.6207010333974;3997.9805149686645;4014.558398576154;4021.155557332993;4088.8160032798596;5683.630564013326;5690.146478028246;5694.544436445074;5717.371089180187;5731.856703582361;5816.389279125716;5871.853203669943;5876.206712093898;5876.294844618673;5879.52963762898;5523.6409633373705;5562.276904002454;5646.463585959327;5668.376478587352;5694.060480020833;5047.823326183566;5051.2423136529815;5073.923891141636;5077.644564880497;5097.6941383517105;6135.7852475164045;6161.630302181883;6163.691815409301;6172.259328880473;6179.3202747697715;5688.658680479184;5705.4579814917515;5862.267216597926;5885.646861188342;5929.555283353852;6169.352218017044;6194.38056194395;6197.597156184834;6206.255249370104;6214.720337584729;5800.7099645018425;5894.941050589439;5899.262592175978;5902.439268269508;5917.112433135064;5773.076307790901;5818.505427038749;5863.208466857091;5906.616069955439;5978.790742324171;5741.598088133791;5854.297484301911;5854.795082172103;5888.146218798336;5891.587588868738;5815.127730840239;5818.854528636818;5826.329972053268;5832.183494310715;5880.382559831156;5573.470520300565;5616.803411880564;5811.970940145441;5818.156367326798;5830.4461076197695;5610.49505544503;5682.801101961411;5730.856728581652;5808.651480911159;5838.591298609056;5663.150527420919;5676.971615141898;5680.77276908919;5684.971575142098;5699.686517241592 06:34:57 INFO - PROCESS | 703 | |1;ext.html;553.2263505373234;580.8518827698936;612.0390986151742;711.3846522757816;712.92514286;42580.14839703208;43256.35115473271;47421.28868066977;47552.28671569921;47914.520854791444;49560.752196238966;50475.49524504754;50671.49328506714;50767.49232507674;50769;9187.310951678634;10684.358938463716;11041.39272340021;11044.502997365138;11364.374959377232;10883.129349652048;10901.345919244832;10990.615328463506;11005.724856878562;11032.558697652084;11000;11039.72400689981;11082.05802506788;11104.61133860315;11118.999290063892;10988.395638239894;11001.17491188164;11027.393493357862;11080.667579972533;11087.057600104;10903.454827258605;10911.727206819814;10920.29018113828;10921;10958.726031849268;41207;41660.79169604133;41763.37354939678;41942.161156777;41947.58052419498;4435.401220835211;4439.822407103712;4536.591706746409;4603.746793926332;4630.675852690313;31630.209244768834;31785.682143178736;32159.83920080408;32279.305714427624;32912.6708732912;4356.194104090721;4520.773961301922;4550.726956382628;4571.2000399929875;4572.611328037121;373156.99999999726;376282.5929351761;376592;376848;377291;60299.69850150721;60655.393446064976;60754.69622651859;60787.69606151941;60921.695391523645;61622.075668865;61915.6904215476;61964.38035619586;61978.380216198166;62117;17129.571760705832;17626.559336016446;17918.731219031724;18553.814461855207;18605.162767675487;14335.56993290203;14377;14483.710325793425;14507.492237771627;14567.92716036413;19505.707414388795;19525.414237572895;19616.70574941377;19783.802161978198;19890.303839365843;7624.8475030500185;7744.535327880345;7816.179301173409;7835.0989636191425;7846.646900889359;991.9057689519484;994.9602015919427;1007.5667462990984;1009.9242556808268;1018.8166130096506;33233.83383083069;33712.325753484794;33791.66208337934;33809.661903381144;33992;1176.6234804862534;1183.6685727996176;1205.9819102713466;1221.9816702749465;1277.7061275906408;17066.146692665316;17134.228959696844;17509.562260943323;17512.91243543774;17737;589564;595027;595630;595853;599943;66080.33919660839;66091.33908660949;66268.33731662718;66338.33661663321;66529;1542.9228538573252;1578.455432875656;1596.4971034124446;1606.6465377616905;1620.9108499032666;32234.677653223167;32274.515882261316;32443.675563244065;32505.34989300248;33084.83457582793;57011;58782.82434351375;58852;58910.116348253956;59157;246474;246931;247257;247562;247926;28734;29111.85444072766;29196.416071678872;30475.390492190476;31706.524402133524;42225.78887105545;42677.35983960181;43213.13573728571;44098.77950610226;44733.329000064376;37698.43452348162;38268.61731382651;38743.80628096841;38769.61230387773;40184.19631607293;38963.80518097391;38977.41533876937;39175.608243917195;39468.40797388099;40438.79780601078;40230.59769402268;40288.395674064326;40617.59382406138;41194.38208426936;41268;34502.137446563036;35123.12192195113;35386;35467.64532354747;35537;27332.590011149452;27350.316242094108;27759.30601734892;27846.58230126509;28085.57871631968 06:34:57 INFO - PROCESS | 703 | |2;jquery.html;433.3607928305747;438.30966228190607;445.0609214557285;446.81457195263965;462.0666254166584;20651.793482065175;21171.68242476364;22183.334499964985;22399.216027439044;22526;22020.669689954622;22295.888520557415;22569.54860902785;22717.659235111485;22742.317730468072;6094.360092190323;6180.84547886302;6350.61896286222;6407.423331900128;6417.93582064178;6108.633481991073;6255.687215639223;6257.499400047986;6261.592996455216;6268.686565671721;6069.362716914727;6139.754409823602;6181.474574661137;6189.133521307021;6244.843878903019;6163.291221509517;6182.1345011698395;6185.16500272462;6209.87580248397;6222.097795819626;5475.288212532345;5538.501534861882;5582;5585.106382978704;5608.355039170507;25500.489990200276;25607;25684;25888.482230355286;25935.35161620956;3274.6889045540634;3424.2466657335344;3425.2635683327953;3461.584609846809;3475.530803341567;15717.685646287124;16041.598960025976;16197.51407457778;16441.26014329358;16906.492805215865;2022.888741119238;2094.5077906691913;2097.3078883968406;2128.6700561413004;2130.371540395587;91747.54126229393;92270;92357.53821230851;93541;94381.5280923591;11627.76744465106;11757;12065.879341206652;12126;12299.385030748426;16658.583535411468;16871.40950066766;16885.577860553585;16896.155192240338;16919.492415227563;9290.95354523223;9364.865539091008;9421.576029078708;9525.904740952501;9549.809003820024;9222.44665320083;9284.907150928539;9423.34036617444;9435.952820235992;9485.193758530602;7518.436117291225;7666.233376662401;7717.1896950819355;7755.650995705094;7813.218678132255;2131.083634037348;2134.7545032321173;2139.721836161289;2151.8493705440783;2164.491344534033;937.8499440089553;962.2206013129388;970.0445061614304;981.8183636027358;991.6380521109887;20245.392638220583;21447.8927605361;21852;21881.343559693236;22005.33983980483;987.3828856964398;996.5117092624706;997.7405874472544;1003.7590978165334;1007.8840933292765;12086.516539338503;12212.511499540096;12494.937525312496;12520.060995425198;12547.811782823264;657663.6752243601;695113;705512;708177;712279;89165;89339;89744.5512772432;91289.54355228182;92307;1168.0830548019765;1183.1244878789805;1184.8992835608897;1189.2804853063944;1195.3067221011966;17882;18728.25086996505;18888.52778680489;19055.428337149908;19109.904450477658;42308.788456057526;44292.778536107115;45883;46084.30873536832;50864.491355087455;61622.38377616346;70248;72183.63908180426;73255;74686.2531374701;13809.723805524034;14231.928840355731;14552.41790328375;14736.631584210481;14766.63083422923;8766.693165739169;13238.139520931109;14309.57071287863;14494.202818845064;15899.728021758463;12748.936255319035;13197.406116724578;13482.258475783927;13497.32513374347;13745.450181992608;12025.63923082309;12456.31490268044;12503.37483125822;12529.37353132358;12623.305718185587;13410.597682069554;13788.86211137916;13895.37470813836;13910.860891390956;13970;14423.49517766873;14830.851691482947;14964.700705986037;14976.700465990401;15200.087994720352;13430.261335626634;13645.658858528219;13649.454021839016;13665.31673416345;13707.931460342634 06:34:57 INFO - PROCESS | 703 | |3;mootools.html;1462.2250207390073;1485.3835658201854;1511.7278889799836;1514.2504460292157;1524.047470331043;8171.673133074684;8414.747557573268;8552.529610871406;9121.954390228047;9217.262618990482;8547.615357308921;8732.388732788708;8735.650573977033;9033.096690330964;9090.50002249876;2438.7195472520666;2476.319012271622;2478.628205769131;2484.291976786616;2488.9377765555823;2412.8311018228733;2475.616279476684;2476.393283645509;2480.8263421560496;2481.813863960201;2447.486027934136;2453.288546321565;2463.0763463701114;2463.88912498938;2470.407102295445;2339.8843471176306;2370.371851459356;2392.9401764956015;2393.74865639108;2398.436367453647;2344.5193735284224;2378.060666036923;2402.759724027601;2409.3133456964856;2443.8900249488815;8962.417442866194;9073.183413492818;9101.499417532033;9103.499307538083;9152.039035901202;5409.350877894639;5563.693996830173;5574.554035677136;5578.721063946787;5579.8605034874045;3607.4047782115917;3607.8196090195647;3671.687906527948;3707.1102935295603;3824.541055073409;1394.0729414939156;1412.4350259896123;1412.7103943691518;1431.6206205355588;1458.3879569211565;12168.634940951786;12191.878081219164;12205.267683938991;12350.75298494034;12381.133320667557;4780.426348838162;4832.299316599074;4903.387076615423;4935.728534930541;4985.52637499437;10695.465226738632;10723.785524289471;10731.2488125832;10771.946140269405;10785.191110666732;5709.8287051388525;5736.885262294731;5749.367569567345;5753.165790960287;5754.88490230193;4919.631027672867;5053.9494605054215;5115.462876397999;5116.692998420107;5158.38099428071;3892.3577609694084;4009.358502639622;4020.4773379461067;4066.8576599819457;4102.384642303678;1176.5587904535798;1182.3792508932706;1183.0358258019687;1188.6849984754047;1198.191220925889;845.8435189489965;847.584683505078;858.3433673239977;875.8948926128778;880.0803160697087;5839.270091238595;5860.384659610765;5901.58688891782;5927.496162826122;5964.522838172936;652.5856081388353;657.181808648236;667.506045526307;668.2815972829131;682.0553533356239;4087.3664581989838;4331.675124365622;4369.104333611602;4406.581374769392;4416.580424859633;10740.248182627298;11067.72330691723;11089.33463992163;11121;11135.94432027851;10216.744581385525;10629.362238265729;10638.308509946828;10964.780704385868;10997.395143267036;8494.235518803338;8625.482471051757;8636.568171591396;8651.52416617092;8695.173958473935;5783.739731712168;5912.290525136839;6037.78867739627;6141.631502109888;6161.168242287234;9985.301028927905;10042;10065.84901226497;10088.646897358558;10168.745781355525;10064.194864410683;10085.394876307151;10166.949165254422;10174.949125254327;10319.329243599143;7816.84366312682;7893.921060789318;7978.481398709066;8053.597320133853;8132.552709601029;8803.60383782744;8870.15733505316;8905.866412003954;8914.465132092095;8926.509042002752;7626.656800443882;7652.081750190013;7654.349380302737;7864.174261702439;7932.801679958047;7725.459217854696;7744.225577442211;7745.148033716399;7773.650185741542;7852.371810255052;7123.964380178273;7140.214576396488;7174.533655312388;7187.748428804966;7190.604516751629;5113.667611605234;5116.74416279192;5133.07604631155;5183.740812959412;5223.373195216598;5177.741112944263;5297.5232229099565;5305.257263983122;5376.032314183484;5441.7279136043835 06:34:57 INFO - PROCESS | 703 | |4;prototype.html;404.02428136051435;406.89624145842805;416.3401009400101;418.74038096380247;422.25682798275034;5384.9192262116;5491.780328786844;5491.890162196753;5502.862428439286;5525.364583072943;5352.197170424438;5447.365790262915;5462.781488740456;5473.808416705416;5485.314335708036;4294.8496802611835;4306.20335237982;4332.39701310514;4371.033035134186;4380.364847097169;4125.628693417591;4287.185434767384;4325.329573916048;4332.97833510832;4344.717593356438;4289.914201715964;4310.913781724364;4310.935335969963;4311.3101903695415;4312.159128969852;4282.7858607069675;4318.654507639381;4338.414314067592;4341.2836881914445;4342.696011279212;3777.8866634001024;3785.753925994829;3881.146147847469;3881.6312450317173;3883.4369016492733;5251.159814429711;5302.178162384798;5303.23103150045;5314.681119132864;5339.41266460689;4909.239067944474;4921.434035085975;4934.753262336904;4943.728094954776;4956.727379994099;5505.807296744595;5686.232358631614;5748;5752.453516915886;5768.538516918637;4202.936955945664;4203.579642035772;4205.831766729358;4209.831606735727;4229.830806767725;5985.281766188042;5998.880022399528;6027.9095813562835;6062.302835173968;6074.422929821704;4236.216299984513;4246.639035682002;4308.6983911126545;4326.956730432656;4364.8472303469225;4312.180685669776;4330.761808100522;4361.694681372337;4362.192994296065;4373.059792144704;4918.385201849769;4937.23472861707;4945.480724523945;4962.925556116661;4975.328330675385;5652.8976849514775;5738.426157384228;5766.972339521701;5826;5844.45122042659;1426;1427.8286605607393;1434.9282535873165;1437.5759151050256;1448.4061534770694;982.756812632021;997.670768646345;1006.1749365520203;1015.4212099103588;1018.3075508654186;5504.559635229172;5517.641353312022;5528.502434780889;5540.279763630783;5555.111182210827;5734.598578099576;5746.5977381583725;5783.59514833966;5790.536757059425;5794.62334948227;5439.60657310782;5514.105094825169;5522.156089613772;5559.497516564619;5571.66570005801;3030.5908702324905;3031.5301128324704;3051.5727798108283;3053.343531140771;3067.2363391050235;5788.971055144697;5937.673427961504;6033.155358249848;6055.909161362583;6067.939320606825;5986.161937328778;6001.459868611846;6018.518518518508;6038.396160383926;6050.788222412194;6145.893739127;6156.199694039746;6167.167432396569;6185.907211391833;6204.627722336674;5678.346990096192;5797.608573942308;5886.911696324644;5907.704614769158;5913.172155898264;5824.970875145597;5861.882762344814;5892.381299963442;5911.438413350725;5927.140564618193;5866.149408335853;6088.543359247986;6156.336979497192;6182.752689892533;6252.343503932204;4429.645628349789;4545.386387832272;4577.198990176772;4595.149897269016;4613.861584152481;5975.16347711312;5986.3115741688525;5997.490213331916;5997.55018373615;6002;5662.971685141712;5792.94207057924;5871.357888950075;5875.059990401515;5932.1694962706115;5748.281464816898;5761.913571296518;5776.162456443708;5789.015867302484;5824.504917082096;5755.827325180251;5775.1914731938405;5787.177039232628;5811.79658711943;5813.447722466359;5559.888802223852;5806.6806325650805;5829.737661805314;5833.970830145992;5894.440028197314;5670.773169073356;5702.857428564319;5726.4273572642405;5738.110592858114;5747.9137812932 06:34:57 INFO - PROCESS | 703 | |5;yui.html;820.0897004325197;836.8033512124649;838.0613712641834;900.2662829793718;915.1534830281992;15081.849181508182;15414.075155490678;15418;15510.30203640836;16574.91712541437;15551.455699050535;15608.375664973388;15730.213489325517;15810.84189158108;15952;829.3986859526855;842.0821304777791;845.045099038086;845.1970627903486;846.318713435684;823.1685997142899;839.0099682374795;847.6143354773594;848.2111636178352;855.0338117926765;852.6205838401913;860.4235162441148;862.6592495964122;864.2783275964546;868.1622234543664;851.8083431227924;859.6174702257498;860.0152825015385;860.3031544449017;861.6251930410292;629.9338569450233;631.7504585688628;632.9430351268408;633.6641579962627;635.4090695653041;16053.117078560674;16145.11201883896;16314.428994985119;16828;16942.745858812126;14353.71292574153;15910.76133857993;16013.839861601351;16096.195190240442;16427.83572164275;14231.857681423156;14269.357878895475;14443.566692999228;14888.478903238334;14899.404023839033;3972.2254160438724;4007.438958545806;4022.4971878515184;4073.226087043482;4168.3955826405;79969;81323;82435.5878220611;84027.99999999939;84881.57559212226;11504.539818407336;11642.76714465723;11804.822927656092;12030.518779248732;12178.269303841798;23607.29178124659;23792.167274145322;23900.760992390202;23980;24064.15775447851;8640.26557742599;8652.610632521426;8680.8697869532;8792.42849214799;8794.472331660121;4512.81948722054;4580.908381832344;4595.058013107305;4624.745638989821;4692.95307046932;3849.287881741887;3965.504311961005;3998.34027385484;4006.7996600169877;4015.9799201003807;656.471540409965;658.90116482528;666.8632930249287;674.7638326585655;687.295522089862;851.199872120205;854.5385491834339;872.3239489395769;875.3566128895256;891.4473026723473;10522.894771052192;10832.59176307075;11218.214724969173;12113.273203607812;12409.689757756129;692.8995295682098;694.1496666583395;717.2218143314562;717.7236763845852;722.5772922840198;5373.441701906481;5381.892362152735;5549.2242482405245;5584.52531534816;5943.732532036069;81505.34106781516;84887.57556212303;85686.57156714301;85911;88581;72410.63794680993;73389;73527.26472735312;74005;74696.62651686707;67954;69032.6548367255;69500.30499694939;70766;71165;10857.457127143452;11327.943360283145;11488.494607624008;11527.538898444303;11533.365664888512;43932.560674392844;44022.77988610165;44329;44599;45205.54794452145;53099.73450132879;53678.73160634172;56193.157102642675;57261.42738572728;58453.415465844795;14364.569062928129;14747.852521474648;14765.557033289018;14857.034292770935;14885;14841.703165936406;16535.83464165343;16714;16736.034612527925;17019.23413446373;14299;15143.545693629208;15866.127362994685;16171.110588917723;16339.754903676692;14343.354549045527;14911.627209319853;15089.094654320776;15881.205939703199;16582.419615313407;13954.23251721165;14108.36512356926;14767.335469904096;14816.185109818633;15226.23868806533;11182.776344473228;11242.83135752948;11267.098632109575;11405.657830265105;11933;10383;10425.270231083752;10546.683599492027;10590.576376944837;10675.199360047873 06:34:57 INFO - PROCESS | 703 | __end_tp_report 06:34:57 INFO - PROCESS | 703 | __start_cc_report 06:34:57 INFO - PROCESS | 703 | _x_x_mozilla_cycle_collect,308 06:34:57 INFO - PROCESS | 703 | __end_cc_report 06:34:57 INFO - PROCESS | 703 | __startTimestamp1486650897698__endTimestamp 06:34:57 INFO - PROCESS | 703 | 06:34:57 INFO - PROCESS | 703 | ------- Summary: start ------- 06:34:57 INFO - PROCESS | 703 | Number of tests: 6 06:34:57 INFO - PROCESS | 703 | 06:34:57 INFO - PROCESS | 703 | [#0] dojo.html Cycles:165 Average:5495.29 Median:5695.37 stddev:604.90 (10.6%) stddev-sans-first:578.74 06:34:57 INFO - PROCESS | 703 | Values: 3175.7 3221.6 3244.0 3246.7 3270.1 5455.0 5512.1 5549.1 5558.2 5566.1 5540.0 5554.4 5559.1 5585.7 5596.5 5021.3 5048.5 5145.5 5163.7 5172.5 5070.8 5159.7 5160.9 5173.0 5174.8 4978.6 4986.8 4997.4 5167.3 5168.2 5046.6 5136.7 5138.4 5154.8 5178.7 5012.5 5090.3 5102.8 5113.0 5147.1 5181.0 5197.3 5446.5 5462.9 5560.3 5780.1 5781.5 5812.9 5885.1 5932.5 5918.3 5925.7 5929.1 5934.1 5958.0 5447.4 5451.2 5506.9 5533.6 5546.7 5879.7 5907.0 5909.3 5942.1 6022.6 5716.5 5776.6 5779.2 5787.1 5790.7 5802.8 5827.2 5858.1 5866.2 5867.1 5695.4 5743.6 5792.6 5820.8 5840.0 5809.1 5891.9 5894.1 5907.1 5936.4 4577.7 4585.4 4601.2 4602.7 4608.9 3992.6 3998.0 4014.6 4021.2 4088.8 5683.6 5690.1 5694.5 5717.4 5731.9 5816.4 5871.9 5876.2 5876.3 5879.5 5523.6 5562.3 5646.5 5668.4 5694.1 5047.8 5051.2 5073.9 5077.6 5097.7 6135.8 6161.6 6163.7 6172.3 6179.3 5688.7 5705.5 5862.3 5885.6 5929.6 6169.4 6194.4 6197.6 6206.3 6214.7 5800.7 5894.9 5899.3 5902.4 5917.1 5773.1 5818.5 5863.2 5906.6 5978.8 5741.6 5854.3 5854.8 5888.1 5891.6 5815.1 5818.9 5826.3 5832.2 5880.4 5573.5 5616.8 5812.0 5818.2 5830.4 5610.5 5682.8 5730.9 5808.7 5838.6 5663.2 5677.0 5680.8 5685.0 5699.7 06:34:57 INFO - PROCESS | 703 | 06:34:57 INFO - PROCESS | 703 | [#1] ext.html Cycles:180 Average:58402.91 Median:35502.32 stddev:114625.53 (322.9%) stddev-sans-first:114864.80 06:34:57 INFO - PROCESS | 703 | Values: 553.2 580.9 612.0 711.4 712.9 42580.1 43256.4 47421.3 47552.3 47914.5 49560.8 50475.5 50671.5 50767.5 50769.0 9187.3 10684.4 11041.4 11044.5 11364.4 10883.1 10901.3 10990.6 11005.7 11032.6 11000.0 11039.7 11082.1 11104.6 11119.0 10988.4 11001.2 11027.4 11080.7 11087.1 10903.5 10911.7 10920.3 10921.0 10958.7 41207.0 41660.8 41763.4 41942.2 41947.6 4435.4 4439.8 4536.6 4603.7 4630.7 31630.2 31785.7 32159.8 32279.3 32912.7 4356.2 4520.8 4550.7 4571.2 4572.6 373157.0 376282.6 376592.0 376848.0 377291.0 60299.7 60655.4 60754.7 60787.7 60921.7 61622.1 61915.7 61964.4 61978.4 62117.0 17129.6 17626.6 17918.7 18553.8 18605.2 14335.6 14377.0 14483.7 14507.5 14567.9 19505.7 19525.4 19616.7 19783.8 19890.3 7624.8 7744.5 7816.2 7835.1 7846.6 991.9 995.0 1007.6 1009.9 1018.8 33233.8 33712.3 33791.7 33809.7 33992.0 1176.6 1183.7 1206.0 1222.0 1277.7 17066.1 17134.2 17509.6 17512.9 17737.0 589564.0 595027.0 595630.0 595853.0 599943.0 66080.3 66091.3 66268.3 66338.3 66529.0 1542.9 1578.5 1596.5 1606.6 1620.9 32234.7 32274.5 32443.7 32505.3 33084.8 57011.0 58782.8 58852.0 58910.1 59157.0 246474.0 246931.0 247257.0 247562.0 247926.0 28734.0 29111.9 29196.4 30475.4 31706.5 42225.8 42677.4 43213.1 44098.8 44733.3 37698.4 38268.6 38743.8 38769.6 40184.2 38963.8 38977.4 39175.6 39468.4 40438.8 40230.6 40288.4 40617.6 41194.4 41268.0 34502.1 35123.1 35386.0 35467.6 35537.0 27332.6 27350.3 27759.3 27846.6 28085.6 06:34:57 INFO - PROCESS | 703 | 06:34:57 INFO - PROCESS | 703 | [#2] jquery.html Cycles:180 Average:36858.67 Median:24121.40 stddev:113907.68 (472.2%) stddev-sans-first:114194.38 06:34:57 INFO - PROCESS | 703 | Values: 433.4 438.3 445.1 446.8 462.1 20651.8 21171.7 22183.3 22399.2 22526.0 22020.7 22295.9 22569.5 22717.7 22742.3 6094.4 6180.8 6350.6 6407.4 6417.9 6108.6 6255.7 6257.5 6261.6 6268.7 6069.4 6139.8 6181.5 6189.1 6244.8 6163.3 6182.1 6185.2 6209.9 6222.1 5475.3 5538.5 5582.0 5585.1 5608.4 25500.5 25607.0 25684.0 25888.5 25935.4 3274.7 3424.2 3425.3 3461.6 3475.5 15717.7 16041.6 16197.5 16441.3 16906.5 2022.9 2094.5 2097.3 2128.7 2130.4 91747.5 92270.0 92357.5 93541.0 94381.5 11627.8 11757.0 12065.9 12126.0 12299.4 16658.6 16871.4 16885.6 16896.2 16919.5 9291.0 9364.9 9421.6 9525.9 9549.8 9222.4 9284.9 9423.3 9436.0 9485.2 7518.4 7666.2 7717.2 7755.7 7813.2 2131.1 2134.8 2139.7 2151.8 2164.5 937.8 962.2 970.0 981.8 991.6 20245.4 21447.9 21852.0 21881.3 22005.3 987.4 996.5 997.7 1003.8 1007.9 12086.5 12212.5 12494.9 12520.1 12547.8 657663.7 695113.0 705512.0 708177.0 712279.0 89165.0 89339.0 89744.6 91289.5 92307.0 1168.1 1183.1 1184.9 1189.3 1195.3 17882.0 18728.3 18888.5 19055.4 19109.9 42308.8 44292.8 45883.0 46084.3 50864.5 61622.4 70248.0 72183.6 73255.0 74686.3 13809.7 14231.9 14552.4 14736.6 14766.6 8766.7 13238.1 14309.6 14494.2 15899.7 12748.9 13197.4 13482.3 13497.3 13745.5 12025.6 12456.3 12503.4 12529.4 12623.3 13410.6 13788.9 13895.4 13910.9 13970.0 14423.5 14830.9 14964.7 14976.7 15200.1 13430.3 13645.7 13649.5 13665.3 13707.9 06:34:57 INFO - PROCESS | 703 | 06:34:57 INFO - PROCESS | 703 | [#3] mootools.html Cycles:180 Average:5921.30 Median:5083.81 stddev:3312.93 (65.2%) stddev-sans-first:3305.27 06:34:57 INFO - PROCESS | 703 | Values: 1462.2 1485.4 1511.7 1514.3 1524.0 8171.7 8414.7 8552.5 9122.0 9217.3 8547.6 8732.4 8735.7 9033.1 9090.5 2438.7 2476.3 2478.6 2484.3 2488.9 2412.8 2475.6 2476.4 2480.8 2481.8 2447.5 2453.3 2463.1 2463.9 2470.4 2339.9 2370.4 2392.9 2393.7 2398.4 2344.5 2378.1 2402.8 2409.3 2443.9 8962.4 9073.2 9101.5 9103.5 9152.0 5409.4 5563.7 5574.6 5578.7 5579.9 3607.4 3607.8 3671.7 3707.1 3824.5 1394.1 1412.4 1412.7 1431.6 1458.4 12168.6 12191.9 12205.3 12350.8 12381.1 4780.4 4832.3 4903.4 4935.7 4985.5 10695.5 10723.8 10731.2 10771.9 10785.2 5709.8 5736.9 5749.4 5753.2 5754.9 4919.6 5053.9 5115.5 5116.7 5158.4 3892.4 4009.4 4020.5 4066.9 4102.4 1176.6 1182.4 1183.0 1188.7 1198.2 845.8 847.6 858.3 875.9 880.1 5839.3 5860.4 5901.6 5927.5 5964.5 652.6 657.2 667.5 668.3 682.1 4087.4 4331.7 4369.1 4406.6 4416.6 10740.2 11067.7 11089.3 11121.0 11135.9 10216.7 10629.4 10638.3 10964.8 10997.4 8494.2 8625.5 8636.6 8651.5 8695.2 5783.7 5912.3 6037.8 6141.6 6161.2 9985.3 10042.0 10065.8 10088.6 10168.7 10064.2 10085.4 10166.9 10174.9 10319.3 7816.8 7893.9 7978.5 8053.6 8132.6 8803.6 8870.2 8905.9 8914.5 8926.5 7626.7 7652.1 7654.3 7864.2 7932.8 7725.5 7744.2 7745.1 7773.7 7852.4 7124.0 7140.2 7174.5 7187.7 7190.6 5113.7 5116.7 5133.1 5183.7 5223.4 5177.7 5297.5 5305.3 5376.0 5441.7 06:34:57 INFO - PROCESS | 703 | 06:34:57 INFO - PROCESS | 703 | [#4] prototype.html Cycles:180 Average:4880.63 Median:5515.87 stddev:1418.11 (25.7%) stddev-sans-first:1381.71 06:34:57 INFO - PROCESS | 703 | Values: 404.0 406.9 416.3 418.7 422.3 5384.9 5491.8 5491.9 5502.9 5525.4 5352.2 5447.4 5462.8 5473.8 5485.3 4294.8 4306.2 4332.4 4371.0 4380.4 4125.6 4287.2 4325.3 4333.0 4344.7 4289.9 4310.9 4310.9 4311.3 4312.2 4282.8 4318.7 4338.4 4341.3 4342.7 3777.9 3785.8 3881.1 3881.6 3883.4 5251.2 5302.2 5303.2 5314.7 5339.4 4909.2 4921.4 4934.8 4943.7 4956.7 5505.8 5686.2 5748.0 5752.5 5768.5 4202.9 4203.6 4205.8 4209.8 4229.8 5985.3 5998.9 6027.9 6062.3 6074.4 4236.2 4246.6 4308.7 4327.0 4364.8 4312.2 4330.8 4361.7 4362.2 4373.1 4918.4 4937.2 4945.5 4962.9 4975.3 5652.9 5738.4 5767.0 5826.0 5844.5 1426.0 1427.8 1434.9 1437.6 1448.4 982.8 997.7 1006.2 1015.4 1018.3 5504.6 5517.6 5528.5 5540.3 5555.1 5734.6 5746.6 5783.6 5790.5 5794.6 5439.6 5514.1 5522.2 5559.5 5571.7 3030.6 3031.5 3051.6 3053.3 3067.2 5789.0 5937.7 6033.2 6055.9 6067.9 5986.2 6001.5 6018.5 6038.4 6050.8 6145.9 6156.2 6167.2 6185.9 6204.6 5678.3 5797.6 5886.9 5907.7 5913.2 5825.0 5861.9 5892.4 5911.4 5927.1 5866.1 6088.5 6156.3 6182.8 6252.3 4429.6 4545.4 4577.2 4595.1 4613.9 5975.2 5986.3 5997.5 5997.6 6002.0 5663.0 5792.9 5871.4 5875.1 5932.2 5748.3 5761.9 5776.2 5789.0 5824.5 5755.8 5775.2 5787.2 5811.8 5813.4 5559.9 5806.7 5829.7 5834.0 5894.4 5670.8 5702.9 5726.4 5738.1 5747.9 06:34:57 INFO - PROCESS | 703 | 06:34:57 INFO - PROCESS | 703 | [#5] yui.html Cycles:180 Average:18900.37 Median:43977.67 stddev:23855.77 (54.2%) stddev-sans-first:23884.06 06:34:57 INFO - PROCESS | 703 | Values: 820.1 836.8 838.1 900.3 915.2 15081.8 15414.1 15418.0 15510.3 16574.9 15551.5 15608.4 15730.2 15810.8 15952.0 829.4 842.1 845.0 845.2 846.3 823.2 839.0 847.6 848.2 855.0 852.6 860.4 862.7 864.3 868.2 851.8 859.6 860.0 860.3 861.6 629.9 631.8 632.9 633.7 635.4 16053.1 16145.1 16314.4 16828.0 16942.7 14353.7 15910.8 16013.8 16096.2 16427.8 14231.9 14269.4 14443.6 14888.5 14899.4 3972.2 4007.4 4022.5 4073.2 4168.4 79969.0 81323.0 82435.6 84028.0 84881.6 11504.5 11642.8 11804.8 12030.5 12178.3 23607.3 23792.2 23900.8 23980.0 24064.2 8640.3 8652.6 8680.9 8792.4 8794.5 4512.8 4580.9 4595.1 4624.7 4693.0 3849.3 3965.5 3998.3 4006.8 4016.0 656.5 658.9 666.9 674.8 687.3 851.2 854.5 872.3 875.4 891.4 10522.9 10832.6 11218.2 12113.3 12409.7 692.9 694.1 717.2 717.7 722.6 5373.4 5381.9 5549.2 5584.5 5943.7 81505.3 84887.6 85686.6 85911.0 88581.0 72410.6 73389.0 73527.3 74005.0 74696.6 67954.0 69032.7 69500.3 70766.0 71165.0 10857.5 11327.9 11488.5 11527.5 11533.4 43932.6 44022.8 44329.0 44599.0 45205.5 53099.7 53678.7 56193.2 57261.4 58453.4 14364.6 14747.9 14765.6 14857.0 14885.0 14841.7 16535.8 16714.0 16736.0 17019.2 14299.0 15143.5 15866.1 16171.1 16339.8 14343.4 14911.6 15089.1 15881.2 16582.4 13954.2 14108.4 14767.3 14816.2 15226.2 11182.8 11242.8 11267.1 11405.7 11933.0 10383.0 10425.3 10546.7 10590.6 10675.2 06:34:57 INFO - PROCESS | 703 | -------- Summary: end -------- 06:34:57 INFO - PROCESS | 703 | 06:34:58 INFO - TEST-INFO | 703: exit 0 06:34:58 INFO - TEST-OK | dromaeo_css | took 1112442ms 06:34:58 INFO - TEST-START | kraken 06:34:58 INFO - operating with platform_type : linux_ 06:34:58 INFO - Initialising browser for kraken test... 06:34:58 INFO - TEST-INFO | started process 1100 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfRGfU1/profile http://localhost:38224/getInfo.html) 06:35:02 INFO - PROCESS | 1100 | __metrics Screen width/height:1600/1200 06:35:02 INFO - PROCESS | 1100 | colorDepth:24 06:35:02 INFO - PROCESS | 1100 | Browser inner width/height: 1024/697 06:35:02 INFO - PROCESS | 1100 | __metrics 06:35:03 INFO - PROCESS | 1100 | 1486650903584 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < permitUnload@remote-browser.xml:353:13 < CanCloseWindow@browser.js:6277:36 < canClose@browser.js:5143:12 < forceQuit@jar:file:///tmp/tmpfRGfU1/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmpfRGfU1/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmpfRGfU1/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmpfRGfU1/profile/extensions/talos-powers@TalosPowersService.js:55:9 06:35:03 ERROR - PROCESS | 1100 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 06:35:04 INFO - TEST-INFO | 1100: exit 0 06:35:04 INFO - Browser initialized. 06:35:04 INFO - Running cycle 1/1 for kraken test... 06:35:04 INFO - TEST-INFO | started process 1299 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfRGfU1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:35:16 INFO - PROCESS | 1299 | RSS: Main: 144855040 06:35:16 INFO - PROCESS | 1299 | 06:35:18 INFO - PROCESS | 1299 | Cycle 1(1): loaded http://localhost:38224/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38224/tests/kraken/driver.html?testName=audio-beat-detection) 06:35:19 INFO - PROCESS | 1299 | RSS: Main: 151506944 06:35:19 INFO - PROCESS | 1299 | 06:35:22 INFO - PROCESS | 1299 | Cycle 1(1): loaded http://localhost:38224/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38224/tests/kraken/driver.html?testName=audio-dft) 06:35:22 INFO - PROCESS | 1299 | RSS: Main: 150978560 06:35:22 INFO - PROCESS | 1299 | 06:35:25 INFO - PROCESS | 1299 | Cycle 1(1): loaded http://localhost:38224/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38224/tests/kraken/driver.html?testName=audio-fft) 06:35:26 INFO - PROCESS | 1299 | RSS: Main: 150749184 06:35:26 INFO - PROCESS | 1299 | 06:35:28 INFO - PROCESS | 1299 | Cycle 1(1): loaded http://localhost:38224/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38224/tests/kraken/driver.html?testName=audio-oscillator) 06:35:28 INFO - PROCESS | 1299 | RSS: Main: 150421504 06:35:28 INFO - PROCESS | 1299 | 06:35:30 INFO - PROCESS | 1299 | Cycle 1(1): loaded http://localhost:38224/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38224/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:35:31 INFO - PROCESS | 1299 | RSS: Main: 150355968 06:35:31 INFO - PROCESS | 1299 | 06:35:34 INFO - PROCESS | 1299 | Cycle 1(1): loaded http://localhost:38224/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38224/tests/kraken/driver.html?testName=imaging-darkroom) 06:35:35 INFO - PROCESS | 1299 | RSS: Main: 154296320 06:35:35 INFO - PROCESS | 1299 | 06:35:38 INFO - PROCESS | 1299 | Cycle 1(1): loaded http://localhost:38224/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38224/tests/kraken/driver.html?testName=imaging-desaturate) 06:35:39 INFO - PROCESS | 1299 | RSS: Main: 153583616 06:35:39 INFO - PROCESS | 1299 | 06:35:42 INFO - PROCESS | 1299 | Cycle 1(1): loaded http://localhost:38224/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38224/tests/kraken/driver.html?testName=json-parse-financial) 06:35:42 INFO - PROCESS | 1299 | RSS: Main: 153120768 06:35:42 INFO - PROCESS | 1299 | 06:35:44 INFO - PROCESS | 1299 | Cycle 1(1): loaded http://localhost:38224/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38224/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:35:44 INFO - PROCESS | 1299 | RSS: Main: 153124864 06:35:44 INFO - PROCESS | 1299 | 06:35:46 INFO - PROCESS | 1299 | Cycle 1(1): loaded http://localhost:38224/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38224/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:35:47 INFO - PROCESS | 1299 | RSS: Main: 152702976 06:35:47 INFO - PROCESS | 1299 | 06:35:49 INFO - PROCESS | 1299 | Cycle 1(1): loaded http://localhost:38224/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38224/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:35:49 INFO - PROCESS | 1299 | RSS: Main: 152977408 06:35:49 INFO - PROCESS | 1299 | 06:35:52 INFO - PROCESS | 1299 | Cycle 1(1): loaded http://localhost:38224/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38224/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:35:53 INFO - PROCESS | 1299 | RSS: Main: 153141248 06:35:53 INFO - PROCESS | 1299 | 06:35:56 INFO - PROCESS | 1299 | Cycle 1(1): loaded http://localhost:38224/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38224/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:35:56 INFO - PROCESS | 1299 | RSS: Main: 153460736 06:35:56 INFO - PROCESS | 1299 | 06:35:58 INFO - PROCESS | 1299 | Cycle 1(1): loaded http://localhost:38224/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38224/tests/kraken/driver.html?testName=ai-astar) 06:35:58 INFO - PROCESS | 1299 | RSS: Main: 154861568 06:35:58 INFO - PROCESS | 1299 | 06:35:58 INFO - PROCESS | 1299 | __start_tp_report 06:35:58 INFO - PROCESS | 1299 | _x_x_mozilla_page_load 06:35:58 INFO - PROCESS | 1299 | _x_x_mozilla_page_load_details 06:35:58 INFO - PROCESS | 1299 | |i|pagename|runs| 06:35:58 INFO - PROCESS | 1299 | |0;ai-astar;105;112;113;112;114;114;113;112;116;111 06:35:58 INFO - PROCESS | 1299 | |1;audio-beat-detection;148;120;121;153;121;119;122;122;136;120 06:35:58 INFO - PROCESS | 1299 | |2;audio-dft;162;165;163;162;163;161;164;163;163;162 06:35:58 INFO - PROCESS | 1299 | |3;audio-fft;75;77;75;104;75;76;78;75;97;76 06:35:58 INFO - PROCESS | 1299 | |4;audio-oscillator;83;82;106;85;83;83;98;82;82;97 06:35:58 INFO - PROCESS | 1299 | |5;imaging-gaussian-blur;120;120;117;117;117;117;118;117;118;117 06:35:58 INFO - PROCESS | 1299 | |6;imaging-darkroom;148;147;148;147;149;148;148;149;148;146 06:35:58 INFO - PROCESS | 1299 | |7;imaging-desaturate;96;97;96;96;96;97;96;96;101;99 06:35:58 INFO - PROCESS | 1299 | |8;json-parse-financial;54;56;55;56;55;55;59;55;55;60 06:35:58 INFO - PROCESS | 1299 | |9;json-stringify-tinderbox;65;65;65;65;65;64;64;65;64;66 06:35:58 INFO - PROCESS | 1299 | |10;stanford-crypto-aes;77;76;78;77;90;82;77;80;78;77 06:35:58 INFO - PROCESS | 1299 | |11;stanford-crypto-ccm;133;138;136;122;122;123;125;135;169;123 06:35:58 INFO - PROCESS | 1299 | |12;stanford-crypto-pbkdf2;159;159;158;158;155;164;163;162;161;158 06:35:58 INFO - PROCESS | 1299 | |13;stanford-crypto-sha256-iterative;62;62;61;61;61;61;62;62;61;60 06:35:58 INFO - PROCESS | 1299 | __end_tp_report 06:35:58 INFO - PROCESS | 1299 | __start_cc_report 06:35:58 INFO - PROCESS | 1299 | _x_x_mozilla_cycle_collect,736 06:35:58 INFO - PROCESS | 1299 | __end_cc_report 06:35:58 INFO - PROCESS | 1299 | __startTimestamp1486650958494__endTimestamp 06:35:58 INFO - PROCESS | 1299 | 06:35:58 INFO - PROCESS | 1299 | ------- Summary: start ------- 06:35:58 INFO - PROCESS | 1299 | Number of tests: 14 06:35:58 INFO - PROCESS | 1299 | 06:35:58 INFO - PROCESS | 1299 | [#0] ai-astar Cycles:10 Average:112.20 Median:113.00 stddev:2.90 (2.6%) stddev-sans-first:1.50 06:35:58 INFO - PROCESS | 1299 | Values: 105.0 112.0 113.0 112.0 114.0 114.0 113.0 112.0 116.0 111.0 06:35:58 INFO - PROCESS | 1299 | 06:35:58 INFO - PROCESS | 1299 | [#1] audio-beat-detection Cycles:10 Average:128.20 Median:122.00 stddev:12.77 (10.5%) stddev-sans-first:11.36 06:35:58 INFO - PROCESS | 1299 | Values: 148.0 120.0 121.0 153.0 121.0 119.0 122.0 122.0 136.0 120.0 06:35:58 INFO - PROCESS | 1299 | 06:35:58 INFO - PROCESS | 1299 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:1.14 (0.7%) stddev-sans-first:1.17 06:35:58 INFO - PROCESS | 1299 | Values: 162.0 165.0 163.0 162.0 163.0 161.0 164.0 163.0 163.0 162.0 06:35:58 INFO - PROCESS | 1299 | 06:35:58 INFO - PROCESS | 1299 | [#3] audio-fft Cycles:10 Average:80.80 Median:76.00 stddev:10.56 (13.9%) stddev-sans-first:10.99 06:35:58 INFO - PROCESS | 1299 | Values: 75.0 77.0 75.0 104.0 75.0 76.0 78.0 75.0 97.0 76.0 06:35:58 INFO - PROCESS | 1299 | 06:35:58 INFO - PROCESS | 1299 | [#4] audio-oscillator Cycles:10 Average:88.10 Median:83.00 stddev:8.80 (10.6%) stddev-sans-first:9.14 06:35:58 INFO - PROCESS | 1299 | Values: 83.0 82.0 106.0 85.0 83.0 83.0 98.0 82.0 82.0 97.0 06:35:58 INFO - PROCESS | 1299 | 06:35:58 INFO - PROCESS | 1299 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:117.50 stddev:1.23 (1.0%) stddev-sans-first:1.01 06:35:58 INFO - PROCESS | 1299 | Values: 120.0 120.0 117.0 117.0 117.0 117.0 118.0 117.0 118.0 117.0 06:35:58 INFO - PROCESS | 1299 | 06:35:58 INFO - PROCESS | 1299 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 06:35:58 INFO - PROCESS | 1299 | Values: 148.0 147.0 148.0 147.0 149.0 148.0 148.0 149.0 148.0 146.0 06:35:58 INFO - PROCESS | 1299 | 06:35:58 INFO - PROCESS | 1299 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:96.00 stddev:1.70 (1.8%) stddev-sans-first:1.76 06:35:58 INFO - PROCESS | 1299 | Values: 96.0 97.0 96.0 96.0 96.0 97.0 96.0 96.0 101.0 99.0 06:35:58 INFO - PROCESS | 1299 | 06:35:58 INFO - PROCESS | 1299 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:55.50 stddev:1.94 (3.5%) stddev-sans-first:1.92 06:35:58 INFO - PROCESS | 1299 | Values: 54.0 56.0 55.0 56.0 55.0 55.0 59.0 55.0 55.0 60.0 06:35:58 INFO - PROCESS | 1299 | 06:35:58 INFO - PROCESS | 1299 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 06:35:58 INFO - PROCESS | 1299 | Values: 65.0 65.0 65.0 65.0 65.0 64.0 64.0 65.0 64.0 66.0 06:35:58 INFO - PROCESS | 1299 | 06:35:58 INFO - PROCESS | 1299 | [#10] stanford-crypto-aes Cycles:10 Average:79.20 Median:78.00 stddev:4.18 (5.4%) stddev-sans-first:4.36 06:35:58 INFO - PROCESS | 1299 | Values: 77.0 76.0 78.0 77.0 90.0 82.0 77.0 80.0 78.0 77.0 06:35:58 INFO - PROCESS | 1299 | 06:35:58 INFO - PROCESS | 1299 | [#11] stanford-crypto-ccm Cycles:10 Average:132.60 Median:134.00 stddev:14.29 (10.7%) stddev-sans-first:15.16 06:35:58 INFO - PROCESS | 1299 | Values: 133.0 138.0 136.0 122.0 122.0 123.0 125.0 135.0 169.0 123.0 06:35:58 INFO - PROCESS | 1299 | 06:35:58 INFO - PROCESS | 1299 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.70 Median:160.00 stddev:2.75 (1.7%) stddev-sans-first:2.91 06:35:58 INFO - PROCESS | 1299 | Values: 159.0 159.0 158.0 158.0 155.0 164.0 163.0 162.0 161.0 158.0 06:35:58 INFO - PROCESS | 1299 | 06:35:58 INFO - PROCESS | 1299 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.30 Median:61.50 stddev:0.67 (1.1%) stddev-sans-first:0.67 06:35:58 INFO - PROCESS | 1299 | Values: 62.0 62.0 61.0 61.0 61.0 61.0 62.0 62.0 61.0 60.0 06:35:58 INFO - PROCESS | 1299 | -------- Summary: end -------- 06:35:58 INFO - PROCESS | 1299 | 06:35:59 INFO - TEST-INFO | 1299: exit 0 06:35:59 INFO - TEST-OK | kraken | took 61054ms 06:35:59 INFO - SUITE-END | took 1173s 06:35:59 INFO - Completed test suite (00:19:33) 06:35:59 INFO - javascript benchmark 06:35:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7674.107547906494, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3175.714185723285, 3221.613406391233, 3244.0430073128423, 3246.659100794415, 3270.133414645118, 5455.045367060763, 5512.118061110224, 5549.084401073823, 5558.194061861028, 5566.053770858959, 5540.0, 5554.361248456429, 5559.11054231323, 5585.692786896719, 5596.496315331619, 5021.3221215135945, 5048.4951504849405, 5145.459726728695, 5163.7159956202395, 5172.456892026339, 5070.797168113289, 5159.664621799589, 5160.948390516084, 5173.042987047389, 5174.844754657347, 4978.601711863061, 4986.825461108844, 4997.375328083989, 5167.302414174076, 5168.173092305232, 5046.5710414614805, 5136.743162841843, 5138.409082955433, 5154.768035438396, 5178.663386879878, 5012.548870601627, 5090.312807770941, 5102.846914592568, 5112.9744351278005, 5147.124988751883, 5180.974095129538, 5197.29836472079, 5446.474987003646, 5462.945370546284, 5560.304961879765, 5780.132980052984, 5781.479666830005, 5812.912806307909, 5885.087811389241, 5932.466078052996, 5918.319393269786, 5925.7333419995775, 5929.110633404981, 5934.080217566284, 5958.046712526018, 5447.428020057916, 5451.209574611659, 5506.91739623902, 5533.584981126432, 5546.667199968015, 5879.676617785977, 5907.0, 5909.349971503131, 5942.108683697394, 6022.638641681513, 5716.514096301861, 5776.566757493205, 5779.162021506942, 5787.1319302104175, 5790.71046447676, 5802.796902108406, 5827.184194212814, 5858.06270996647, 5866.23738913947, 5867.14926335679, 5695.373508914016, 5743.62666426681, 5792.623479473821, 5820.767169313265, 5840.0, 5809.099589563624, 5891.941080589139, 5894.086416605433, 5907.143464197753, 5936.436038576328, 4577.725336479822, 4585.358049873021, 4601.24079526881, 4602.65480088988, 4608.9308660370125, 3992.6207010333974, 3997.9805149686645, 4014.558398576154, 4021.155557332993, 4088.8160032798596, 5683.630564013326, 5690.146478028246, 5694.544436445074, 5717.371089180187, 5731.856703582361, 5816.389279125716, 5871.853203669943, 5876.206712093898, 5876.294844618673, 5879.52963762898, 5523.6409633373705, 5562.276904002454, 5646.463585959327, 5668.376478587352, 5694.060480020833, 5047.823326183566, 5051.2423136529815, 5073.923891141636, 5077.644564880497, 5097.6941383517105, 6135.7852475164045, 6161.630302181883, 6163.691815409301, 6172.259328880473, 6179.3202747697715, 5688.658680479184, 5705.4579814917515, 5862.267216597926, 5885.646861188342, 5929.555283353852, 6169.352218017044, 6194.38056194395, 6197.597156184834, 6206.255249370104, 6214.720337584729, 5800.7099645018425, 5894.941050589439, 5899.262592175978, 5902.439268269508, 5917.112433135064, 5773.076307790901, 5818.505427038749, 5863.208466857091, 5906.616069955439, 5978.790742324171, 5741.598088133791, 5854.297484301911, 5854.795082172103, 5888.146218798336, 5891.587588868738, 5815.127730840239, 5818.854528636818, 5826.329972053268, 5832.183494310715, 5880.382559831156, 5573.470520300565, 5616.803411880564, 5811.970940145441, 5818.156367326798, 5830.4461076197695, 5610.49505544503, 5682.801101961411, 5730.856728581652, 5808.651480911159, 5838.591298609056, 5663.150527420919, 5676.971615141898, 5680.77276908919, 5684.971575142098, 5699.686517241592], "value": 5455.616601660156, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.2263505373234, 580.8518827698936, 612.0390986151742, 711.3846522757816, 712.92514286, 42580.14839703208, 43256.35115473271, 47421.28868066977, 47552.28671569921, 47914.520854791444, 49560.752196238966, 50475.49524504754, 50671.49328506714, 50767.49232507674, 50769.0, 9187.310951678634, 10684.358938463716, 11041.39272340021, 11044.502997365138, 11364.374959377232, 10883.129349652048, 10901.345919244832, 10990.615328463506, 11005.724856878562, 11032.558697652084, 11000.0, 11039.72400689981, 11082.05802506788, 11104.61133860315, 11118.999290063892, 10988.395638239894, 11001.17491188164, 11027.393493357862, 11080.667579972533, 11087.057600104, 10903.454827258605, 10911.727206819814, 10920.29018113828, 10921.0, 10958.726031849268, 41207.0, 41660.79169604133, 41763.37354939678, 41942.161156777, 41947.58052419498, 4435.401220835211, 4439.822407103712, 4536.591706746409, 4603.746793926332, 4630.675852690313, 31630.209244768834, 31785.682143178736, 32159.83920080408, 32279.305714427624, 32912.6708732912, 4356.194104090721, 4520.773961301922, 4550.726956382628, 4571.2000399929875, 4572.611328037121, 373156.99999999726, 376282.5929351761, 376592.0, 376848.0, 377291.0, 60299.69850150721, 60655.393446064976, 60754.69622651859, 60787.69606151941, 60921.695391523645, 61622.075668865, 61915.6904215476, 61964.38035619586, 61978.380216198166, 62117.0, 17129.571760705832, 17626.559336016446, 17918.731219031724, 18553.814461855207, 18605.162767675487, 14335.56993290203, 14377.0, 14483.710325793425, 14507.492237771627, 14567.92716036413, 19505.707414388795, 19525.414237572895, 19616.70574941377, 19783.802161978198, 19890.303839365843, 7624.8475030500185, 7744.535327880345, 7816.179301173409, 7835.0989636191425, 7846.646900889359, 991.9057689519484, 994.9602015919427, 1007.5667462990984, 1009.9242556808268, 1018.8166130096506, 33233.83383083069, 33712.325753484794, 33791.66208337934, 33809.661903381144, 33992.0, 1176.6234804862534, 1183.6685727996176, 1205.9819102713466, 1221.9816702749465, 1277.7061275906408, 17066.146692665316, 17134.228959696844, 17509.562260943323, 17512.91243543774, 17737.0, 589564.0, 595027.0, 595630.0, 595853.0, 599943.0, 66080.33919660839, 66091.33908660949, 66268.33731662718, 66338.33661663321, 66529.0, 1542.9228538573252, 1578.455432875656, 1596.4971034124446, 1606.6465377616905, 1620.9108499032666, 32234.677653223167, 32274.515882261316, 32443.675563244065, 32505.34989300248, 33084.83457582793, 57011.0, 58782.82434351375, 58852.0, 58910.116348253956, 59157.0, 246474.0, 246931.0, 247257.0, 247562.0, 247926.0, 28734.0, 29111.85444072766, 29196.416071678872, 30475.390492190476, 31706.524402133524, 42225.78887105545, 42677.35983960181, 43213.13573728571, 44098.77950610226, 44733.329000064376, 37698.43452348162, 38268.61731382651, 38743.80628096841, 38769.61230387773, 40184.19631607293, 38963.80518097391, 38977.41533876937, 39175.608243917195, 39468.40797388099, 40438.79780601078, 40230.59769402268, 40288.395674064326, 40617.59382406138, 41194.38208426936, 41268.0, 34502.137446563036, 35123.12192195113, 35386.0, 35467.64532354747, 35537.0, 27332.590011149452, 27350.316242094108, 27759.30601734892, 27846.58230126509, 28085.57871631968], "value": 21223.185090883413, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [433.3607928305747, 438.30966228190607, 445.0609214557285, 446.81457195263965, 462.0666254166584, 20651.793482065175, 21171.68242476364, 22183.334499964985, 22399.216027439044, 22526.0, 22020.669689954622, 22295.888520557415, 22569.54860902785, 22717.659235111485, 22742.317730468072, 6094.360092190323, 6180.84547886302, 6350.61896286222, 6407.423331900128, 6417.93582064178, 6108.633481991073, 6255.687215639223, 6257.499400047986, 6261.592996455216, 6268.686565671721, 6069.362716914727, 6139.754409823602, 6181.474574661137, 6189.133521307021, 6244.843878903019, 6163.291221509517, 6182.1345011698395, 6185.16500272462, 6209.87580248397, 6222.097795819626, 5475.288212532345, 5538.501534861882, 5582.0, 5585.106382978704, 5608.355039170507, 25500.489990200276, 25607.0, 25684.0, 25888.482230355286, 25935.35161620956, 3274.6889045540634, 3424.2466657335344, 3425.2635683327953, 3461.584609846809, 3475.530803341567, 15717.685646287124, 16041.598960025976, 16197.51407457778, 16441.26014329358, 16906.492805215865, 2022.888741119238, 2094.5077906691913, 2097.3078883968406, 2128.6700561413004, 2130.371540395587, 91747.54126229393, 92270.0, 92357.53821230851, 93541.0, 94381.5280923591, 11627.76744465106, 11757.0, 12065.879341206652, 12126.0, 12299.385030748426, 16658.583535411468, 16871.40950066766, 16885.577860553585, 16896.155192240338, 16919.492415227563, 9290.95354523223, 9364.865539091008, 9421.576029078708, 9525.904740952501, 9549.809003820024, 9222.44665320083, 9284.907150928539, 9423.34036617444, 9435.952820235992, 9485.193758530602, 7518.436117291225, 7666.233376662401, 7717.1896950819355, 7755.650995705094, 7813.218678132255, 2131.083634037348, 2134.7545032321173, 2139.721836161289, 2151.8493705440783, 2164.491344534033, 937.8499440089553, 962.2206013129388, 970.0445061614304, 981.8183636027358, 991.6380521109887, 20245.392638220583, 21447.8927605361, 21852.0, 21881.343559693236, 22005.33983980483, 987.3828856964398, 996.5117092624706, 997.7405874472544, 1003.7590978165334, 1007.8840933292765, 12086.516539338503, 12212.511499540096, 12494.937525312496, 12520.060995425198, 12547.811782823264, 657663.6752243601, 695113.0, 705512.0, 708177.0, 712279.0, 89165.0, 89339.0, 89744.5512772432, 91289.54355228182, 92307.0, 1168.0830548019765, 1183.1244878789805, 1184.8992835608897, 1189.2804853063944, 1195.3067221011966, 17882.0, 18728.25086996505, 18888.52778680489, 19055.428337149908, 19109.904450477658, 42308.788456057526, 44292.778536107115, 45883.0, 46084.30873536832, 50864.491355087455, 61622.38377616346, 70248.0, 72183.63908180426, 73255.0, 74686.2531374701, 13809.723805524034, 14231.928840355731, 14552.41790328375, 14736.631584210481, 14766.63083422923, 8766.693165739169, 13238.139520931109, 14309.57071287863, 14494.202818845064, 15899.728021758463, 12748.936255319035, 13197.406116724578, 13482.258475783927, 13497.32513374347, 13745.450181992608, 12025.63923082309, 12456.31490268044, 12503.37483125822, 12529.37353132358, 12623.305718185587, 13410.597682069554, 13788.86211137916, 13895.37470813836, 13910.860891390956, 13970.0, 14423.49517766873, 14830.851691482947, 14964.700705986037, 14976.700465990401, 15200.087994720352, 13430.261335626634, 13645.658858528219, 13649.454021839016, 13665.31673416345, 13707.931460342634], "value": 10788.356291059894, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1462.2250207390073, 1485.3835658201854, 1511.7278889799836, 1514.2504460292157, 1524.047470331043, 8171.673133074684, 8414.747557573268, 8552.529610871406, 9121.954390228047, 9217.262618990482, 8547.615357308921, 8732.388732788708, 8735.650573977033, 9033.096690330964, 9090.50002249876, 2438.7195472520666, 2476.319012271622, 2478.628205769131, 2484.291976786616, 2488.9377765555823, 2412.8311018228733, 2475.616279476684, 2476.393283645509, 2480.8263421560496, 2481.813863960201, 2447.486027934136, 2453.288546321565, 2463.0763463701114, 2463.88912498938, 2470.407102295445, 2339.8843471176306, 2370.371851459356, 2392.9401764956015, 2393.74865639108, 2398.436367453647, 2344.5193735284224, 2378.060666036923, 2402.759724027601, 2409.3133456964856, 2443.8900249488815, 8962.417442866194, 9073.183413492818, 9101.499417532033, 9103.499307538083, 9152.039035901202, 5409.350877894639, 5563.693996830173, 5574.554035677136, 5578.721063946787, 5579.8605034874045, 3607.4047782115917, 3607.8196090195647, 3671.687906527948, 3707.1102935295603, 3824.541055073409, 1394.0729414939156, 1412.4350259896123, 1412.7103943691518, 1431.6206205355588, 1458.3879569211565, 12168.634940951786, 12191.878081219164, 12205.267683938991, 12350.75298494034, 12381.133320667557, 4780.426348838162, 4832.299316599074, 4903.387076615423, 4935.728534930541, 4985.52637499437, 10695.465226738632, 10723.785524289471, 10731.2488125832, 10771.946140269405, 10785.191110666732, 5709.8287051388525, 5736.885262294731, 5749.367569567345, 5753.165790960287, 5754.88490230193, 4919.631027672867, 5053.9494605054215, 5115.462876397999, 5116.692998420107, 5158.38099428071, 3892.3577609694084, 4009.358502639622, 4020.4773379461067, 4066.8576599819457, 4102.384642303678, 1176.5587904535798, 1182.3792508932706, 1183.0358258019687, 1188.6849984754047, 1198.191220925889, 845.8435189489965, 847.584683505078, 858.3433673239977, 875.8948926128778, 880.0803160697087, 5839.270091238595, 5860.384659610765, 5901.58688891782, 5927.496162826122, 5964.522838172936, 652.5856081388353, 657.181808648236, 667.506045526307, 668.2815972829131, 682.0553533356239, 4087.3664581989838, 4331.675124365622, 4369.104333611602, 4406.581374769392, 4416.580424859633, 10740.248182627298, 11067.72330691723, 11089.33463992163, 11121.0, 11135.94432027851, 10216.744581385525, 10629.362238265729, 10638.308509946828, 10964.780704385868, 10997.395143267036, 8494.235518803338, 8625.482471051757, 8636.568171591396, 8651.52416617092, 8695.173958473935, 5783.739731712168, 5912.290525136839, 6037.78867739627, 6141.631502109888, 6161.168242287234, 9985.301028927905, 10042.0, 10065.84901226497, 10088.646897358558, 10168.745781355525, 10064.194864410683, 10085.394876307151, 10166.949165254422, 10174.949125254327, 10319.329243599143, 7816.84366312682, 7893.921060789318, 7978.481398709066, 8053.597320133853, 8132.552709601029, 8803.60383782744, 8870.15733505316, 8905.866412003954, 8914.465132092095, 8926.509042002752, 7626.656800443882, 7652.081750190013, 7654.349380302737, 7864.174261702439, 7932.801679958047, 7725.459217854696, 7744.225577442211, 7745.148033716399, 7773.650185741542, 7852.371810255052, 7123.964380178273, 7140.214576396488, 7174.533655312388, 7187.748428804966, 7190.604516751629, 5113.667611605234, 5116.74416279192, 5133.07604631155, 5183.740812959412, 5223.373195216598, 5177.741112944263, 5297.5232229099565, 5305.257263983122, 5376.032314183484, 5441.7279136043835], "value": 4716.300304638184, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.02428136051435, 406.89624145842805, 416.3401009400101, 418.74038096380247, 422.25682798275034, 5384.9192262116, 5491.780328786844, 5491.890162196753, 5502.862428439286, 5525.364583072943, 5352.197170424438, 5447.365790262915, 5462.781488740456, 5473.808416705416, 5485.314335708036, 4294.8496802611835, 4306.20335237982, 4332.39701310514, 4371.033035134186, 4380.364847097169, 4125.628693417591, 4287.185434767384, 4325.329573916048, 4332.97833510832, 4344.717593356438, 4289.914201715964, 4310.913781724364, 4310.935335969963, 4311.3101903695415, 4312.159128969852, 4282.7858607069675, 4318.654507639381, 4338.414314067592, 4341.2836881914445, 4342.696011279212, 3777.8866634001024, 3785.753925994829, 3881.146147847469, 3881.6312450317173, 3883.4369016492733, 5251.159814429711, 5302.178162384798, 5303.23103150045, 5314.681119132864, 5339.41266460689, 4909.239067944474, 4921.434035085975, 4934.753262336904, 4943.728094954776, 4956.727379994099, 5505.807296744595, 5686.232358631614, 5748.0, 5752.453516915886, 5768.538516918637, 4202.936955945664, 4203.579642035772, 4205.831766729358, 4209.831606735727, 4229.830806767725, 5985.281766188042, 5998.880022399528, 6027.9095813562835, 6062.302835173968, 6074.422929821704, 4236.216299984513, 4246.639035682002, 4308.6983911126545, 4326.956730432656, 4364.8472303469225, 4312.180685669776, 4330.761808100522, 4361.694681372337, 4362.192994296065, 4373.059792144704, 4918.385201849769, 4937.23472861707, 4945.480724523945, 4962.925556116661, 4975.328330675385, 5652.8976849514775, 5738.426157384228, 5766.972339521701, 5826.0, 5844.45122042659, 1426.0, 1427.8286605607393, 1434.9282535873165, 1437.5759151050256, 1448.4061534770694, 982.756812632021, 997.670768646345, 1006.1749365520203, 1015.4212099103588, 1018.3075508654186, 5504.559635229172, 5517.641353312022, 5528.502434780889, 5540.279763630783, 5555.111182210827, 5734.598578099576, 5746.5977381583725, 5783.59514833966, 5790.536757059425, 5794.62334948227, 5439.60657310782, 5514.105094825169, 5522.156089613772, 5559.497516564619, 5571.66570005801, 3030.5908702324905, 3031.5301128324704, 3051.5727798108283, 3053.343531140771, 3067.2363391050235, 5788.971055144697, 5937.673427961504, 6033.155358249848, 6055.909161362583, 6067.939320606825, 5986.161937328778, 6001.459868611846, 6018.518518518508, 6038.396160383926, 6050.788222412194, 6145.893739127, 6156.199694039746, 6167.167432396569, 6185.907211391833, 6204.627722336674, 5678.346990096192, 5797.608573942308, 5886.911696324644, 5907.704614769158, 5913.172155898264, 5824.970875145597, 5861.882762344814, 5892.381299963442, 5911.438413350725, 5927.140564618193, 5866.149408335853, 6088.543359247986, 6156.336979497192, 6182.752689892533, 6252.343503932204, 4429.645628349789, 4545.386387832272, 4577.198990176772, 4595.149897269016, 4613.861584152481, 5975.16347711312, 5986.3115741688525, 5997.490213331916, 5997.55018373615, 6002.0, 5662.971685141712, 5792.94207057924, 5871.357888950075, 5875.059990401515, 5932.1694962706115, 5748.281464816898, 5761.913571296518, 5776.162456443708, 5789.015867302484, 5824.504917082096, 5755.827325180251, 5775.1914731938405, 5787.177039232628, 5811.79658711943, 5813.447722466359, 5559.888802223852, 5806.6806325650805, 5829.737661805314, 5833.970830145992, 5894.440028197314, 5670.773169073356, 5702.857428564319, 5726.4273572642405, 5738.110592858114, 5747.9137812932], "value": 4444.596520763408, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [820.0897004325197, 836.8033512124649, 838.0613712641834, 900.2662829793718, 915.1534830281992, 15081.849181508182, 15414.075155490678, 15418.0, 15510.30203640836, 16574.91712541437, 15551.455699050535, 15608.375664973388, 15730.213489325517, 15810.84189158108, 15952.0, 829.3986859526855, 842.0821304777791, 845.045099038086, 845.1970627903486, 846.318713435684, 823.1685997142899, 839.0099682374795, 847.6143354773594, 848.2111636178352, 855.0338117926765, 852.6205838401913, 860.4235162441148, 862.6592495964122, 864.2783275964546, 868.1622234543664, 851.8083431227924, 859.6174702257498, 860.0152825015385, 860.3031544449017, 861.6251930410292, 629.9338569450233, 631.7504585688628, 632.9430351268408, 633.6641579962627, 635.4090695653041, 16053.117078560674, 16145.11201883896, 16314.428994985119, 16828.0, 16942.745858812126, 14353.71292574153, 15910.76133857993, 16013.839861601351, 16096.195190240442, 16427.83572164275, 14231.857681423156, 14269.357878895475, 14443.566692999228, 14888.478903238334, 14899.404023839033, 3972.2254160438724, 4007.438958545806, 4022.4971878515184, 4073.226087043482, 4168.3955826405, 79969.0, 81323.0, 82435.5878220611, 84027.99999999939, 84881.57559212226, 11504.539818407336, 11642.76714465723, 11804.822927656092, 12030.518779248732, 12178.269303841798, 23607.29178124659, 23792.167274145322, 23900.760992390202, 23980.0, 24064.15775447851, 8640.26557742599, 8652.610632521426, 8680.8697869532, 8792.42849214799, 8794.472331660121, 4512.81948722054, 4580.908381832344, 4595.058013107305, 4624.745638989821, 4692.95307046932, 3849.287881741887, 3965.504311961005, 3998.34027385484, 4006.7996600169877, 4015.9799201003807, 656.471540409965, 658.90116482528, 666.8632930249287, 674.7638326585655, 687.295522089862, 851.199872120205, 854.5385491834339, 872.3239489395769, 875.3566128895256, 891.4473026723473, 10522.894771052192, 10832.59176307075, 11218.214724969173, 12113.273203607812, 12409.689757756129, 692.8995295682098, 694.1496666583395, 717.2218143314562, 717.7236763845852, 722.5772922840198, 5373.441701906481, 5381.892362152735, 5549.2242482405245, 5584.52531534816, 5943.732532036069, 81505.34106781516, 84887.57556212303, 85686.57156714301, 85911.0, 88581.0, 72410.63794680993, 73389.0, 73527.26472735312, 74005.0, 74696.62651686707, 67954.0, 69032.6548367255, 69500.30499694939, 70766.0, 71165.0, 10857.457127143452, 11327.943360283145, 11488.494607624008, 11527.538898444303, 11533.365664888512, 43932.560674392844, 44022.77988610165, 44329.0, 44599.0, 45205.54794452145, 53099.73450132879, 53678.73160634172, 56193.157102642675, 57261.42738572728, 58453.415465844795, 14364.569062928129, 14747.852521474648, 14765.557033289018, 14857.034292770935, 14885.0, 14841.703165936406, 16535.83464165343, 16714.0, 16736.034612527925, 17019.23413446373, 14299.0, 15143.545693629208, 15866.127362994685, 16171.110588917723, 16339.754903676692, 14343.354549045527, 14911.627209319853, 15089.094654320776, 15881.205939703199, 16582.419615313407, 13954.23251721165, 14108.36512356926, 14767.335469904096, 14816.185109818633, 15226.23868806533, 11182.776344473228, 11242.83135752948, 11267.098632109575, 11405.657830265105, 11933.0, 10383.0, 10425.270231083752, 10546.683599492027, 10590.576376944837, 10675.199360047873], "value": 7799.694162841536, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1488.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 113.0, 112.0, 114.0, 114.0, 113.0, 112.0, 116.0, 111.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 120.0, 121.0, 153.0, 121.0, 119.0, 122.0, 122.0, 136.0, 120.0], "value": 128.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 163.0, 162.0, 163.0, 161.0, 164.0, 163.0, 163.0, 162.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 75.0, 104.0, 75.0, 76.0, 78.0, 75.0, 97.0, 76.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 106.0, 85.0, 83.0, 83.0, 98.0, 82.0, 82.0, 97.0], "value": 88.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 120.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 147.0, 149.0, 148.0, 148.0, 149.0, 148.0, 146.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 101.0, 99.0], "value": 97.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 55.0, 56.0, 55.0, 55.0, 59.0, 55.0, 55.0, 60.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 64.0, 65.0, 64.0, 66.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 78.0, 77.0, 90.0, 82.0, 77.0, 80.0, 78.0, 77.0], "value": 79.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 138.0, 136.0, 122.0, 122.0, 123.0, 125.0, 135.0, 169.0, 123.0], "value": 132.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 158.0, 158.0, 155.0, 164.0, 163.0, 162.0, 161.0, 158.0], "value": 159.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 61.0, 61.0, 61.0, 62.0, 62.0, 61.0, 60.0], "value": 61.3, "unit": "score"}]}]} 06:35:59 INFO - Return code: 0 06:35:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:35:59 ERROR - # TBPL SUCCESS # 06:35:59 INFO - Running post-action listener: _resource_record_post_action 06:35:59 INFO - [mozharness: 2017-02-09 14:35:59.832576Z] Finished run-tests step (success) 06:35:59 INFO - Running post-run listener: _resource_record_post_run 06:35:59 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8192; Write bytes: 364507136; Read time: 256; Write time: 262568 06:35:59 INFO - TinderboxPrint: CPU usage
13.3% 06:35:59 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 256 06:35:59 INFO - TinderboxPrint: I/O write bytes / time
364,507,136 / 262,568 06:35:59 INFO - TinderboxPrint: CPU idle
8,230.8 (86.7%) 06:35:59 INFO - TinderboxPrint: CPU user
1,206.3 (12.7%) 06:35:59 INFO - TinderboxPrint: Swap in / out
0 / 0 06:35:59 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 109436928; Read time: 0; Write time: 89060 06:35:59 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8192; Write bytes: 255070208; Read time: 256; Write time: 173508 06:36:00 INFO - Running post-run listener: _upload_blobber_files 06:36:00 INFO - Blob upload gear active. 06:36:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:36:00 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 06:36:00 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:36:00 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:36:00 INFO - (blobuploader) - INFO - Open directory for files ... 06:36:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:36:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:36:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:36:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:36:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:36:01 INFO - (blobuploader) - INFO - Done attempting. 06:36:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:36:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:36:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:36:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:36:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:36:05 INFO - (blobuploader) - INFO - Done attempting. 06:36:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:36:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:36:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:36:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:36:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:36:06 INFO - (blobuploader) - INFO - Done attempting. 06:36:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:36:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:36:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:36:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:36:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:36:06 INFO - (blobuploader) - INFO - Done attempting. 06:36:06 INFO - (blobuploader) - INFO - Iteration through files over. 06:36:06 INFO - Return code: 0 06:36:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:36:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:36:06 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/063cead8e183de24366ccd026e20afd1bb07d44d8b8636698b3017f8aafad4d494e01463b077c4cef52dcf5c2315581ff66652a28ad0212269ee11d7ca6e8a4f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bc715fbe16afac78219bc76cbe8f02b28ca716c0b92fdfdb1ea57bd803bb588579a70470808535c19a887560b7a1cb5d902d195a1ae59016f8ccac6335962c96", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13e35d1f72f812701521c3b1c6d3b53d119e59be385b937ad550538fce7a4ef1d87f3646ce3ec486e2e41b92f6fe887dd954e4ee312976bc5d08558b6ac5e49d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/97756a24b02cf34ed302c3628b88850919ebaaefc147455046f9ed15ff9eabb3c454f870dfab96f54183e9e15febf75f4a20d77997c7adf27edf707c7d4971be"} 06:36:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:36:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:36:06 INFO - Contents: 06:36:06 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/063cead8e183de24366ccd026e20afd1bb07d44d8b8636698b3017f8aafad4d494e01463b077c4cef52dcf5c2315581ff66652a28ad0212269ee11d7ca6e8a4f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bc715fbe16afac78219bc76cbe8f02b28ca716c0b92fdfdb1ea57bd803bb588579a70470808535c19a887560b7a1cb5d902d195a1ae59016f8ccac6335962c96", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13e35d1f72f812701521c3b1c6d3b53d119e59be385b937ad550538fce7a4ef1d87f3646ce3ec486e2e41b92f6fe887dd954e4ee312976bc5d08558b6ac5e49d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/97756a24b02cf34ed302c3628b88850919ebaaefc147455046f9ed15ff9eabb3c454f870dfab96f54183e9e15febf75f4a20d77997c7adf27edf707c7d4971be"} 06:36:06 INFO - Running post-run listener: copy_logs_to_upload_dir 06:36:06 INFO - Copying logs to upload dir... 06:36:06 INFO - mkdir: /builds/slave/test/build/upload/logs 06:36:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.167530 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-02-09 06:36:06.353203) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 06:36:06.356405) ========= 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=0e2a256762fed810e2f0f810000001b3-1486649728.569949-2137729594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/063cead8e183de24366ccd026e20afd1bb07d44d8b8636698b3017f8aafad4d494e01463b077c4cef52dcf5c2315581ff66652a28ad0212269ee11d7ca6e8a4f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bc715fbe16afac78219bc76cbe8f02b28ca716c0b92fdfdb1ea57bd803bb588579a70470808535c19a887560b7a1cb5d902d195a1ae59016f8ccac6335962c96", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13e35d1f72f812701521c3b1c6d3b53d119e59be385b937ad550538fce7a4ef1d87f3646ce3ec486e2e41b92f6fe887dd954e4ee312976bc5d08558b6ac5e49d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/97756a24b02cf34ed302c3628b88850919ebaaefc147455046f9ed15ff9eabb3c454f870dfab96f54183e9e15febf75f4a20d77997c7adf27edf707c7d4971be"} build_url:https://queue.taskcluster.net/v1/task/VlyUM44uSPCWfYMp0CV6vg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011395 build_url: 'https://queue.taskcluster.net/v1/task/VlyUM44uSPCWfYMp0CV6vg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/063cead8e183de24366ccd026e20afd1bb07d44d8b8636698b3017f8aafad4d494e01463b077c4cef52dcf5c2315581ff66652a28ad0212269ee11d7ca6e8a4f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bc715fbe16afac78219bc76cbe8f02b28ca716c0b92fdfdb1ea57bd803bb588579a70470808535c19a887560b7a1cb5d902d195a1ae59016f8ccac6335962c96", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13e35d1f72f812701521c3b1c6d3b53d119e59be385b937ad550538fce7a4ef1d87f3646ce3ec486e2e41b92f6fe887dd954e4ee312976bc5d08558b6ac5e49d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/97756a24b02cf34ed302c3628b88850919ebaaefc147455046f9ed15ff9eabb3c454f870dfab96f54183e9e15febf75f4a20d77997c7adf27edf707c7d4971be"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 06:36:06.381288) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 06:36:06.381612) ========= 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=0e2a256762fed810e2f0f810000001b3-1486649728.569949-2137729594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004556 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 06:36:06.468764) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 06:36:06.469093) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 06:36:06.469383) ========= ========= Total master_lag: 0.16 =========