builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-015 starttime: 1468505793.64 results: success (0) buildid: 20160714064843 builduid: e85601e9cfed4acda909725d98bdc68d revision: 6b9dae7e278dcd38d0b1c221ca9420931dfac7fd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 07:16:33.641296) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 07:16:33.641756) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 07:16:33.642053) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 07:16:33.657093) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 07:16:33.657448) ========= 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=20e666a3d4cfbb71505a330e000001b4-1468505792.906124-411778537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-14 07:16:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 33.4M=0s 2016-07-14 07:16:33 (33.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.138028 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 07:16:33.809653) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 07:16:33.810000) ========= 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=20e666a3d4cfbb71505a330e000001b4-1468505792.906124-411778537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017846 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 07:16:33.860123) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 07:16:33.860477) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6b9dae7e278dcd38d0b1c221ca9420931dfac7fd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 6b9dae7e278dcd38d0b1c221ca9420931dfac7fd --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=20e666a3d4cfbb71505a330e000001b4-1468505792.906124-411778537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-14 07:16:33,954 truncating revision to first 12 chars 2016-07-14 07:16:33,954 Setting DEBUG logging. 2016-07-14 07:16:33,954 attempt 1/10 2016-07-14 07:16:33,954 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6b9dae7e278d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-14 07:16:34,281 unpacking tar archive at: fx-team-6b9dae7e278d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.653612 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 07:16:34.527871) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 07:16:34.528229) ========= script_repo_revision: 6b9dae7e278dcd38d0b1c221ca9420931dfac7fd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 07:16:34.528637) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 07:16:34.528909) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 07:16:34.538388) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-14 07:16:34.538721) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1468505792.906124-411778537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:16:34 INFO - MultiFileLogger online at 20160714 07:16:34 in /builds/slave/test 07:16:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 07:16:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:16:34 INFO - {'append_to_log': False, 07:16:34 INFO - 'base_work_dir': '/builds/slave/test', 07:16:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:16:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:16:34 INFO - 'branch': 'Fx-Team-Non-PGO', 07:16:34 INFO - 'buildbot_json_path': 'buildprops.json', 07:16:34 INFO - 'config_files': ('talos/linux_config.py',), 07:16:34 INFO - 'default_actions': ('clobber', 07:16:34 INFO - 'read-buildbot-config', 07:16:34 INFO - 'download-and-extract', 07:16:34 INFO - 'populate-webroot', 07:16:34 INFO - 'create-virtualenv', 07:16:34 INFO - 'install', 07:16:34 INFO - 'run-tests'), 07:16:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:16:34 INFO - 'download_minidump_stackwalk': True, 07:16:34 INFO - 'download_symbols': 'ondemand', 07:16:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:16:34 INFO - 'tooltool.py': '/tools/tooltool.py', 07:16:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:16:34 INFO - '/tools/misc-python/virtualenv.py')}, 07:16:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:16:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:16:34 INFO - 'installer_path': 'installer.exe', 07:16:34 INFO - 'log_level': 'info', 07:16:34 INFO - 'log_name': 'talos', 07:16:34 INFO - 'log_to_console': True, 07:16:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:16:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:16:34 INFO - 'opt_config_files': (), 07:16:34 INFO - 'pip_index': False, 07:16:34 INFO - 'sps_profile': False, 07:16:34 INFO - 'sps_profile_interval': 0, 07:16:34 INFO - 'suite': 'dromaeojs', 07:16:34 INFO - 'system_bits': '32', 07:16:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:16:34 INFO - 'title': 'talos-linux64-ix-015', 07:16:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:16:34 INFO - 'use_talos_json': True, 07:16:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:16:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:16:34 INFO - 'work_dir': 'build'} 07:16:34 INFO - ##### 07:16:34 INFO - ##### Running clobber step. 07:16:34 INFO - ##### 07:16:34 INFO - Running pre-action listener: _resource_record_pre_action 07:16:34 INFO - Running main action method: clobber 07:16:34 INFO - rmtree: /builds/slave/test/build 07:16:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:16:35 INFO - Running post-action listener: _resource_record_post_action 07:16:35 INFO - ##### 07:16:35 INFO - ##### Finished clobber step (success) 07:16:35 INFO - ##### 07:16:35 INFO - ##### 07:16:35 INFO - ##### Running read-buildbot-config step. 07:16:35 INFO - ##### 07:16:35 INFO - Running pre-action listener: _resource_record_pre_action 07:16:35 INFO - Running main action method: read_buildbot_config 07:16:35 INFO - Using buildbot properties: 07:16:35 INFO - { 07:16:35 INFO - "project": "", 07:16:35 INFO - "product": "firefox", 07:16:35 INFO - "script_repo_revision": "production", 07:16:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:16:35 INFO - "repository": "", 07:16:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 07:16:35 INFO - "buildid": "20160714064843", 07:16:35 INFO - "pgo_build": "False", 07:16:35 INFO - "basedir": "/builds/slave/test", 07:16:35 INFO - "buildnumber": 3158, 07:16:35 INFO - "slavename": "talos-linux64-ix-015", 07:16:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:16:35 INFO - "platform": "ubuntu64_hw", 07:16:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:16:35 INFO - "branch": "fx-team", 07:16:35 INFO - "repo_path": "integration/fx-team", 07:16:35 INFO - "revision": "6b9dae7e278dcd38d0b1c221ca9420931dfac7fd", 07:16:35 INFO - "stage_platform": "linux64", 07:16:35 INFO - "builduid": "e85601e9cfed4acda909725d98bdc68d", 07:16:35 INFO - "slavebuilddir": "test" 07:16:35 INFO - } 07:16:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/IK-HY0PhQNSg4Zd-3dypZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:16:35 INFO - Running post-action listener: _resource_record_post_action 07:16:35 INFO - ##### 07:16:35 INFO - ##### Finished read-buildbot-config step (success) 07:16:35 INFO - ##### 07:16:35 INFO - ##### 07:16:35 INFO - ##### Running download-and-extract step. 07:16:35 INFO - ##### 07:16:35 INFO - Running pre-action listener: _resource_record_pre_action 07:16:35 INFO - Running main action method: download_and_extract 07:16:35 INFO - mkdir: /builds/slave/test/build/tests 07:16:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:35 INFO - https://queue.taskcluster.net/v1/task/IK-HY0PhQNSg4Zd-3dypZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:16:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK-HY0PhQNSg4Zd-3dypZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:16:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK-HY0PhQNSg4Zd-3dypZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:16:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK-HY0PhQNSg4Zd-3dypZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:16:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK-HY0PhQNSg4Zd-3dypZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:16:35 INFO - Downloaded 1361 bytes. 07:16:35 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:16:35 INFO - Using the following test package requirements: 07:16:35 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:16:35 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:16:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:16:35 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:16:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:16:35 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:16:35 INFO - u'jsshell-linux-x86_64.zip'], 07:16:35 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:16:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:16:35 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:16:35 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:16:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:16:35 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:16:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:16:35 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:16:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:16:35 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:16:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:16:35 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:16:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:35 INFO - https://queue.taskcluster.net/v1/task/IK-HY0PhQNSg4Zd-3dypZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:16:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK-HY0PhQNSg4Zd-3dypZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:16:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK-HY0PhQNSg4Zd-3dypZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:16:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK-HY0PhQNSg4Zd-3dypZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:16:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK-HY0PhQNSg4Zd-3dypZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:16:37 INFO - Downloaded 22756551 bytes. 07:16:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:16:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:16:38 INFO - Return code: 0 07:16:38 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:16:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:38 INFO - https://queue.taskcluster.net/v1/task/IK-HY0PhQNSg4Zd-3dypZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:16:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK-HY0PhQNSg4Zd-3dypZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:16:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK-HY0PhQNSg4Zd-3dypZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:16:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK-HY0PhQNSg4Zd-3dypZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:16:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK-HY0PhQNSg4Zd-3dypZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:16:39 INFO - Downloaded 22756551 bytes. 07:16:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:16:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:16:40 INFO - Return code: 0 07:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:40 INFO - https://queue.taskcluster.net/v1/task/IK-HY0PhQNSg4Zd-3dypZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:16:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK-HY0PhQNSg4Zd-3dypZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:16:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK-HY0PhQNSg4Zd-3dypZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:16:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK-HY0PhQNSg4Zd-3dypZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:16:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK-HY0PhQNSg4Zd-3dypZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:16:41 INFO - Downloaded 14403317 bytes. 07:16:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:16:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:16:42 INFO - Return code: 0 07:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:42 INFO - https://queue.taskcluster.net/v1/task/IK-HY0PhQNSg4Zd-3dypZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:16:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK-HY0PhQNSg4Zd-3dypZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:16:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK-HY0PhQNSg4Zd-3dypZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:16:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK-HY0PhQNSg4Zd-3dypZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:16:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IK-HY0PhQNSg4Zd-3dypZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:16:43 INFO - Downloaded 57052588 bytes. 07:16:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IK-HY0PhQNSg4Zd-3dypZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:16:43 INFO - mkdir: /builds/slave/test/properties 07:16:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:16:43 INFO - Writing to file /builds/slave/test/properties/build_url 07:16:43 INFO - Contents: 07:16:43 INFO - build_url:https://queue.taskcluster.net/v1/task/IK-HY0PhQNSg4Zd-3dypZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:16:44 INFO - Running post-action listener: _resource_record_post_action 07:16:44 INFO - Running post-action listener: set_extra_try_arguments 07:16:44 INFO - ##### 07:16:44 INFO - ##### Finished download-and-extract step (success) 07:16:44 INFO - ##### 07:16:44 INFO - ##### 07:16:44 INFO - ##### Running populate-webroot step. 07:16:44 INFO - ##### 07:16:44 INFO - Running pre-action listener: _resource_record_pre_action 07:16:44 INFO - Running main action method: populate_webroot 07:16:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:16:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:16:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:16:44 INFO - '--tppagecycles', 07:16:44 INFO - '7'], 07:16:44 INFO - 'tests': ['tsvgm']}}, 07:16:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:16:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:16:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:16:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:16:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:16:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:16:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:16:44 INFO - 'talos_options': ['--disable-e10s'], 07:16:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:16:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:16:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:16:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:16:44 INFO - 'talos_options': ['--disable-e10s'], 07:16:44 INFO - 'tests': ['damp', 'tps']}, 07:16:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:16:44 INFO - 'tests': ['damp', 'tps']}, 07:16:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:16:44 INFO - 'tests': ['dromaeo_dom']}, 07:16:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:16:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:16:44 INFO - 'tests': ['basic_compositor_video']}, 07:16:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:16:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:16:44 INFO - 'tests': ['a11yr', 07:16:44 INFO - 'ts_paint', 07:16:44 INFO - 'tpaint', 07:16:44 INFO - 'sessionrestore', 07:16:44 INFO - 'sessionrestore_no_auto_restore', 07:16:44 INFO - 'tabpaint']}, 07:16:44 INFO - 'other-e10s': {'tests': ['a11yr', 07:16:44 INFO - 'ts_paint', 07:16:44 INFO - 'tpaint', 07:16:44 INFO - 'sessionrestore', 07:16:44 INFO - 'sessionrestore_no_auto_restore', 07:16:44 INFO - 'tabpaint']}, 07:16:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:16:44 INFO - 'ts_paint', 07:16:44 INFO - 'tpaint', 07:16:44 INFO - 'sessionrestore', 07:16:44 INFO - 'sessionrestore_no_auto_restore', 07:16:44 INFO - 'tabpaint']}, 07:16:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:16:44 INFO - 'ts_paint', 07:16:44 INFO - 'tpaint', 07:16:44 INFO - 'sessionrestore', 07:16:44 INFO - 'sessionrestore_no_auto_restore', 07:16:44 INFO - 'tabpaint']}, 07:16:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:16:44 INFO - 'tests': ['a11yr', 07:16:44 INFO - 'ts_paint', 07:16:44 INFO - 'tpaint', 07:16:44 INFO - 'sessionrestore', 07:16:44 INFO - 'sessionrestore_no_auto_restore', 07:16:44 INFO - 'tabpaint']}, 07:16:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:16:44 INFO - 'tests': ['a11yr', 07:16:44 INFO - 'ts_paint', 07:16:44 INFO - 'tpaint', 07:16:44 INFO - 'sessionrestore', 07:16:44 INFO - 'sessionrestore_no_auto_restore', 07:16:44 INFO - 'tabpaint']}, 07:16:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:16:44 INFO - 'tests': ['tsvgx', 07:16:44 INFO - 'tsvgr_opacity', 07:16:44 INFO - 'tart', 07:16:44 INFO - 'tscrollx', 07:16:44 INFO - 'cart']}, 07:16:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:16:44 INFO - 'tsvgr_opacity', 07:16:44 INFO - 'tart', 07:16:44 INFO - 'tscrollx', 07:16:44 INFO - 'cart']}, 07:16:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:16:44 INFO - 'talos_options': ['--disable-e10s'], 07:16:44 INFO - 'tests': ['tp5o']}, 07:16:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:16:44 INFO - 'tests': ['tp5o']}, 07:16:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:16:44 INFO - 'talos_options': ['--disable-e10s', 07:16:44 INFO - '--xperf_path', 07:16:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:16:44 INFO - 'tests': ['tp5n']}, 07:16:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:16:44 INFO - 'talos_options': ['--xperf_path', 07:16:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:16:44 INFO - 'tests': ['tp5n']}}, 07:16:44 INFO - 'talos.zip': {'path': '', 07:16:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:16:44 INFO - Running post-action listener: _resource_record_post_action 07:16:44 INFO - ##### 07:16:44 INFO - ##### Finished populate-webroot step (success) 07:16:44 INFO - ##### 07:16:44 INFO - ##### 07:16:44 INFO - ##### Running create-virtualenv step. 07:16:44 INFO - ##### 07:16:44 INFO - Running pre-action listener: _resource_record_pre_action 07:16:44 INFO - Running main action method: create_virtualenv 07:16:44 INFO - Creating virtualenv /builds/slave/test/build/venv 07:16:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:16:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:16:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:16:44 INFO - Using real prefix '/usr' 07:16:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:16:44 INFO - Installing distribute.............................................................................................................................................................................................done. 07:16:46 INFO - Installing pip.................done. 07:16:46 INFO - Return code: 0 07:16:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2137030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f63b0>, '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 0x23f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f7740>, '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': '20e666a3d4cfbb71505a330e000001b4-1468505792.906124-411778537', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:16:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:16:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:16:46 INFO - Using env: {'DISPLAY': ':0', 07:16:46 INFO - 'HOME': '/home/cltbld', 07:16:46 INFO - 'LANG': 'en_US.UTF-8', 07:16:46 INFO - 'LANGUAGE': 'en_US:en', 07:16:46 INFO - 'LOGNAME': 'cltbld', 07:16:46 INFO - 'MAIL': '/var/mail/cltbld', 07:16:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:46 INFO - 'MOZ_NO_REMOTE': '1', 07:16:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:46 INFO - 'NO_EM_RESTART': '1', 07:16:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:46 INFO - 'PWD': '/builds/slave/test', 07:16:46 INFO - 'SHELL': '/bin/bash', 07:16:46 INFO - 'SHLVL': '1', 07:16:46 INFO - 'TERM': 'linux', 07:16:46 INFO - 'TMOUT': '86400', 07:16:46 INFO - 'USER': 'cltbld', 07:16:46 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1468505792.906124-411778537', 07:16:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:46 INFO - '_': '/tools/buildbot/bin/python'} 07:16:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:16:46 INFO - Cleaning up... 07:16:46 INFO - Return code: 0 07:16:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2137030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f63b0>, '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 0x23f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f7740>, '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': '20e666a3d4cfbb71505a330e000001b4-1468505792.906124-411778537', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:16:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:16:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:16:46 INFO - Using env: {'DISPLAY': ':0', 07:16:46 INFO - 'HOME': '/home/cltbld', 07:16:46 INFO - 'LANG': 'en_US.UTF-8', 07:16:46 INFO - 'LANGUAGE': 'en_US:en', 07:16:46 INFO - 'LOGNAME': 'cltbld', 07:16:46 INFO - 'MAIL': '/var/mail/cltbld', 07:16:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:46 INFO - 'MOZ_NO_REMOTE': '1', 07:16:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:46 INFO - 'NO_EM_RESTART': '1', 07:16:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:46 INFO - 'PWD': '/builds/slave/test', 07:16:46 INFO - 'SHELL': '/bin/bash', 07:16:46 INFO - 'SHLVL': '1', 07:16:46 INFO - 'TERM': 'linux', 07:16:46 INFO - 'TMOUT': '86400', 07:16:46 INFO - 'USER': 'cltbld', 07:16:46 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1468505792.906124-411778537', 07:16:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:46 INFO - '_': '/tools/buildbot/bin/python'} 07:16:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:47 INFO - Downloading/unpacking psutil>=3.1.1 07:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:16:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:16:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:16:49 INFO - Installing collected packages: psutil 07:16:49 INFO - Running setup.py install for psutil 07:16:49 INFO - building 'psutil._psutil_linux' extension 07:16:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:16:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:16:49 INFO - building 'psutil._psutil_posix' extension 07:16:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:16:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:16:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:16:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:16:49 INFO - Successfully installed psutil 07:16:49 INFO - Cleaning up... 07:16:49 INFO - Return code: 0 07:16:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:16: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2137030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f63b0>, '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 0x23f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f7740>, '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': '20e666a3d4cfbb71505a330e000001b4-1468505792.906124-411778537', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:16: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:16: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 mozsystemmonitor==0.3 07:16:49 INFO - Using env: {'DISPLAY': ':0', 07:16:49 INFO - 'HOME': '/home/cltbld', 07:16:49 INFO - 'LANG': 'en_US.UTF-8', 07:16:49 INFO - 'LANGUAGE': 'en_US:en', 07:16:49 INFO - 'LOGNAME': 'cltbld', 07:16:49 INFO - 'MAIL': '/var/mail/cltbld', 07:16:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:49 INFO - 'MOZ_NO_REMOTE': '1', 07:16:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:49 INFO - 'NO_EM_RESTART': '1', 07:16:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:49 INFO - 'PWD': '/builds/slave/test', 07:16:49 INFO - 'SHELL': '/bin/bash', 07:16:49 INFO - 'SHLVL': '1', 07:16:49 INFO - 'TERM': 'linux', 07:16:49 INFO - 'TMOUT': '86400', 07:16:49 INFO - 'USER': 'cltbld', 07:16:49 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1468505792.906124-411778537', 07:16:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:49 INFO - '_': '/tools/buildbot/bin/python'} 07:16:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:16: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 07:16: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 07:16: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 07:16: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 07:16: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 07:16: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 07:16:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:16:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:16:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:16:51 INFO - Installing collected packages: mozsystemmonitor 07:16:51 INFO - Running setup.py install for mozsystemmonitor 07:16:52 INFO - Successfully installed mozsystemmonitor 07:16:52 INFO - Cleaning up... 07:16:52 INFO - Return code: 0 07:16:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:16: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16: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', '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 0x2137030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f63b0>, '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 0x23f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f7740>, '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': '20e666a3d4cfbb71505a330e000001b4-1468505792.906124-411778537', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:16: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:16: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 jsonschema==2.5.1 07:16:52 INFO - Using env: {'DISPLAY': ':0', 07:16:52 INFO - 'HOME': '/home/cltbld', 07:16:52 INFO - 'LANG': 'en_US.UTF-8', 07:16:52 INFO - 'LANGUAGE': 'en_US:en', 07:16:52 INFO - 'LOGNAME': 'cltbld', 07:16:52 INFO - 'MAIL': '/var/mail/cltbld', 07:16:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:52 INFO - 'MOZ_NO_REMOTE': '1', 07:16:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:52 INFO - 'NO_EM_RESTART': '1', 07:16:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:52 INFO - 'PWD': '/builds/slave/test', 07:16:52 INFO - 'SHELL': '/bin/bash', 07:16:52 INFO - 'SHLVL': '1', 07:16:52 INFO - 'TERM': 'linux', 07:16:52 INFO - 'TMOUT': '86400', 07:16:52 INFO - 'USER': 'cltbld', 07:16:52 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1468505792.906124-411778537', 07:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:52 INFO - '_': '/tools/buildbot/bin/python'} 07:16:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:52 INFO - Downloading/unpacking jsonschema==2.5.1 07:16: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 07:16: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 07:16: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 07:16: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 07:16: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 07:16: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 07:16:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:16:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:16: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 07:16: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 07:16: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 07:16: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 07:16: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 07:16: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 07:16:54 INFO - Downloading functools32-3.2.3-2.tar.gz 07:16:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:16:54 INFO - warning: no files found matching '*.txt' 07:16:54 INFO - no previously-included directories found matching 'build' 07:16:54 INFO - no previously-included directories found matching 'dist' 07:16:54 INFO - no previously-included directories found matching '.git*' 07:16:54 INFO - Installing collected packages: jsonschema, functools32 07:16:54 INFO - Running setup.py install for functools32 07:16:54 INFO - warning: no files found matching '*.txt' 07:16:54 INFO - no previously-included directories found matching 'build' 07:16:54 INFO - no previously-included directories found matching 'dist' 07:16:54 INFO - no previously-included directories found matching '.git*' 07:16:54 INFO - Successfully installed jsonschema functools32 07:16:54 INFO - Cleaning up... 07:16:54 INFO - Return code: 0 07:16:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:16: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16: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', '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 0x2137030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f63b0>, '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 0x23f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f7740>, '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': '20e666a3d4cfbb71505a330e000001b4-1468505792.906124-411778537', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:16: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:16: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 blobuploader==1.2.4 07:16:54 INFO - Using env: {'DISPLAY': ':0', 07:16:54 INFO - 'HOME': '/home/cltbld', 07:16:54 INFO - 'LANG': 'en_US.UTF-8', 07:16:54 INFO - 'LANGUAGE': 'en_US:en', 07:16:54 INFO - 'LOGNAME': 'cltbld', 07:16:54 INFO - 'MAIL': '/var/mail/cltbld', 07:16:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:54 INFO - 'MOZ_NO_REMOTE': '1', 07:16:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:54 INFO - 'NO_EM_RESTART': '1', 07:16:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:54 INFO - 'PWD': '/builds/slave/test', 07:16:54 INFO - 'SHELL': '/bin/bash', 07:16:54 INFO - 'SHLVL': '1', 07:16:54 INFO - 'TERM': 'linux', 07:16:54 INFO - 'TMOUT': '86400', 07:16:54 INFO - 'USER': 'cltbld', 07:16:54 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1468505792.906124-411778537', 07:16:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:54 INFO - '_': '/tools/buildbot/bin/python'} 07:16:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:55 INFO - Downloading/unpacking blobuploader==1.2.4 07:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:57 INFO - Downloading blobuploader-1.2.4.tar.gz 07:16:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:16:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:16: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 07:16: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 07:16: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 07:16: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 07:16: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 07:16: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 07:16:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:16:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:16: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 07:16: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 07:16: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 07:16: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 07:16: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 07:16: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 07:16:57 INFO - Downloading docopt-0.6.1.tar.gz 07:16:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:16:57 INFO - Installing collected packages: blobuploader, requests, docopt 07:16:57 INFO - Running setup.py install for blobuploader 07:16:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:16:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:16:57 INFO - Running setup.py install for requests 07:16:58 INFO - Running setup.py install for docopt 07:16:58 INFO - Successfully installed blobuploader requests docopt 07:16:58 INFO - Cleaning up... 07:16:58 INFO - Return code: 0 07:16:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:16:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:58 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 0x2137030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f63b0>, '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 0x23f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f7740>, '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': '20e666a3d4cfbb71505a330e000001b4-1468505792.906124-411778537', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:16:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:16:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:16:58 INFO - Using env: {'DISPLAY': ':0', 07:16:58 INFO - 'HOME': '/home/cltbld', 07:16:58 INFO - 'LANG': 'en_US.UTF-8', 07:16:58 INFO - 'LANGUAGE': 'en_US:en', 07:16:58 INFO - 'LOGNAME': 'cltbld', 07:16:58 INFO - 'MAIL': '/var/mail/cltbld', 07:16:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:58 INFO - 'MOZ_NO_REMOTE': '1', 07:16:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:58 INFO - 'NO_EM_RESTART': '1', 07:16:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:58 INFO - 'PWD': '/builds/slave/test', 07:16:58 INFO - 'SHELL': '/bin/bash', 07:16:58 INFO - 'SHLVL': '1', 07:16:58 INFO - 'TERM': 'linux', 07:16:58 INFO - 'TMOUT': '86400', 07:16:58 INFO - 'USER': 'cltbld', 07:16:58 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1468505792.906124-411778537', 07:16:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:58 INFO - '_': '/tools/buildbot/bin/python'} 07:16:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:16:58 INFO - Running setup.py (path:/tmp/pip-BrKSX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:16:58 INFO - Running setup.py (path:/tmp/pip-i5gbON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:16:58 INFO - Running setup.py (path:/tmp/pip-f7z_rZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:16:58 INFO - Running setup.py (path:/tmp/pip-qfr4uL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:16:59 INFO - Running setup.py (path:/tmp/pip-pTnVEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:16:59 INFO - Running setup.py (path:/tmp/pip-LCYdJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:16:59 INFO - Running setup.py (path:/tmp/pip-n23Lvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:16:59 INFO - Running setup.py (path:/tmp/pip-JEztq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:16:59 INFO - Running setup.py (path:/tmp/pip-Z_PtdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:16:59 INFO - Running setup.py (path:/tmp/pip-BhG_uT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:16:59 INFO - Running setup.py (path:/tmp/pip-czynAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:16:59 INFO - Running setup.py (path:/tmp/pip-wvF25E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:16:59 INFO - Running setup.py (path:/tmp/pip-EXEuwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:16:59 INFO - Running setup.py (path:/tmp/pip-YT9My7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:16:59 INFO - Running setup.py (path:/tmp/pip-EZlbDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:16:59 INFO - Running setup.py (path:/tmp/pip-4puV61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:16:59 INFO - Running setup.py (path:/tmp/pip-tz0NXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:16:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:16:59 INFO - Running setup.py install for manifestparser 07:17:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:17:00 INFO - Running setup.py install for mozcrash 07:17:00 INFO - Running setup.py install for mozdebug 07:17:00 INFO - Running setup.py install for mozdevice 07:17:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:17:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:17:00 INFO - Running setup.py install for mozfile 07:17:00 INFO - Running setup.py install for mozhttpd 07:17:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:17:00 INFO - Running setup.py install for mozinfo 07:17:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:17:00 INFO - Running setup.py install for mozInstall 07:17:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:17:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:17:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:17:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:17:00 INFO - Running setup.py install for mozleak 07:17:00 INFO - Running setup.py install for mozlog 07:17:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:17:00 INFO - Running setup.py install for moznetwork 07:17:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:17:01 INFO - Running setup.py install for mozprocess 07:17:01 INFO - Running setup.py install for mozprofile 07:17:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:17:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:17:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:17:01 INFO - Running setup.py install for mozrunner 07:17:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:17:01 INFO - Running setup.py install for mozscreenshot 07:17:01 INFO - Running setup.py install for moztest 07:17:01 INFO - Running setup.py install for mozversion 07:17:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:17:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:17:01 INFO - Cleaning up... 07:17:01 INFO - Return code: 0 07:17:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:17: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:01 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 0x2137030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f63b0>, '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 0x23f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f7740>, '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': '20e666a3d4cfbb71505a330e000001b4-1468505792.906124-411778537', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:17:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:17:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:17:01 INFO - Using env: {'DISPLAY': ':0', 07:17:01 INFO - 'HOME': '/home/cltbld', 07:17:01 INFO - 'LANG': 'en_US.UTF-8', 07:17:01 INFO - 'LANGUAGE': 'en_US:en', 07:17:01 INFO - 'LOGNAME': 'cltbld', 07:17:01 INFO - 'MAIL': '/var/mail/cltbld', 07:17:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:01 INFO - 'MOZ_NO_REMOTE': '1', 07:17:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:01 INFO - 'NO_EM_RESTART': '1', 07:17:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:01 INFO - 'PWD': '/builds/slave/test', 07:17:01 INFO - 'SHELL': '/bin/bash', 07:17:01 INFO - 'SHLVL': '1', 07:17:01 INFO - 'TERM': 'linux', 07:17:01 INFO - 'TMOUT': '86400', 07:17:01 INFO - 'USER': 'cltbld', 07:17:01 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1468505792.906124-411778537', 07:17:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:01 INFO - '_': '/tools/buildbot/bin/python'} 07:17:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:17:01 INFO - Running setup.py (path:/tmp/pip-gqTecp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:17:02 INFO - Running setup.py (path:/tmp/pip-GYYbeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:17:02 INFO - Running setup.py (path:/tmp/pip-McPdZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:17:02 INFO - Running setup.py (path:/tmp/pip-UIufi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:17:02 INFO - Running setup.py (path:/tmp/pip-Ytcokc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:17:02 INFO - Running setup.py (path:/tmp/pip-rNh0Pb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:17:02 INFO - Running setup.py (path:/tmp/pip-Kk1otJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:17:02 INFO - Running setup.py (path:/tmp/pip-vN7Vc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:17:02 INFO - Running setup.py (path:/tmp/pip-yXLgIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:17:02 INFO - Running setup.py (path:/tmp/pip-VzGqM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:17:02 INFO - Running setup.py (path:/tmp/pip-6VFGPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:17:02 INFO - Running setup.py (path:/tmp/pip-7FZdZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:17:02 INFO - Running setup.py (path:/tmp/pip-oOwLl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:17:02 INFO - Running setup.py (path:/tmp/pip-NLBkgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:17:03 INFO - Running setup.py (path:/tmp/pip-p9Lvqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:17:03 INFO - Running setup.py (path:/tmp/pip-T5b8kG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:17:03 INFO - Running setup.py (path:/tmp/pip-MM3eTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:17:03 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:17:03 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:17:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:05 INFO - Downloading blessings-1.6.tar.gz 07:17:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:17:05 INFO - Installing collected packages: blessings 07:17:05 INFO - Running setup.py install for blessings 07:17:05 INFO - Successfully installed blessings 07:17:05 INFO - Cleaning up... 07:17:05 INFO - Return code: 0 07:17:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:17:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:17:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:17:05 INFO - Reading from file tmpfile_stdout 07:17:05 INFO - Current package versions: 07:17:05 INFO - argparse == 1.2.1 07:17:05 INFO - blessings == 1.6 07:17:05 INFO - blobuploader == 1.2.4 07:17:05 INFO - docopt == 0.6.1 07:17:05 INFO - functools32 == 3.2.3-2 07:17:05 INFO - jsonschema == 2.5.1 07:17:05 INFO - manifestparser == 1.1 07:17:05 INFO - mozInstall == 1.12 07:17:05 INFO - mozcrash == 0.17 07:17:05 INFO - mozdebug == 0.1 07:17:05 INFO - mozdevice == 0.48 07:17:05 INFO - mozfile == 1.2 07:17:05 INFO - mozhttpd == 0.7 07:17:05 INFO - mozinfo == 0.9 07:17:05 INFO - mozleak == 0.1 07:17:05 INFO - mozlog == 3.2 07:17:05 INFO - moznetwork == 0.27 07:17:05 INFO - mozprocess == 0.23 07:17:05 INFO - mozprofile == 0.28 07:17:05 INFO - mozrunner == 6.12 07:17:05 INFO - mozscreenshot == 0.1 07:17:05 INFO - mozsystemmonitor == 0.3 07:17:05 INFO - moztest == 0.7 07:17:05 INFO - mozversion == 1.4 07:17:05 INFO - psutil == 3.1.1 07:17:05 INFO - requests == 1.2.3 07:17:05 INFO - wsgiref == 0.1.2 07:17:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:17:05 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:05 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:05 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 0x2137030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f63b0>, '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 0x23f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f7740>, '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': '20e666a3d4cfbb71505a330e000001b4-1468505792.906124-411778537', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:17:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:17:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:17:05 INFO - Using env: {'DISPLAY': ':0', 07:17:05 INFO - 'HOME': '/home/cltbld', 07:17:05 INFO - 'LANG': 'en_US.UTF-8', 07:17:05 INFO - 'LANGUAGE': 'en_US:en', 07:17:05 INFO - 'LOGNAME': 'cltbld', 07:17:05 INFO - 'MAIL': '/var/mail/cltbld', 07:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:05 INFO - 'MOZ_NO_REMOTE': '1', 07:17:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:05 INFO - 'NO_EM_RESTART': '1', 07:17:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:05 INFO - 'PWD': '/builds/slave/test', 07:17:05 INFO - 'SHELL': '/bin/bash', 07:17:05 INFO - 'SHLVL': '1', 07:17:05 INFO - 'TERM': 'linux', 07:17:05 INFO - 'TMOUT': '86400', 07:17:05 INFO - 'USER': 'cltbld', 07:17:05 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1468505792.906124-411778537', 07:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:05 INFO - '_': '/tools/buildbot/bin/python'} 07:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:17:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:17:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:17:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:17:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:17:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:17:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:17:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:17:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:17:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:17:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:17:05 INFO - Cleaning up... 07:17:05 INFO - Return code: 0 07:17:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:17:05 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:05 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:05 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 0x2137030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f63b0>, '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 0x23f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f7740>, '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': '20e666a3d4cfbb71505a330e000001b4-1468505792.906124-411778537', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:17:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:17:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:17:05 INFO - Using env: {'DISPLAY': ':0', 07:17:05 INFO - 'HOME': '/home/cltbld', 07:17:05 INFO - 'LANG': 'en_US.UTF-8', 07:17:05 INFO - 'LANGUAGE': 'en_US:en', 07:17:05 INFO - 'LOGNAME': 'cltbld', 07:17:05 INFO - 'MAIL': '/var/mail/cltbld', 07:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:05 INFO - 'MOZ_NO_REMOTE': '1', 07:17:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:05 INFO - 'NO_EM_RESTART': '1', 07:17:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:05 INFO - 'PWD': '/builds/slave/test', 07:17:05 INFO - 'SHELL': '/bin/bash', 07:17:05 INFO - 'SHLVL': '1', 07:17:05 INFO - 'TERM': 'linux', 07:17:05 INFO - 'TMOUT': '86400', 07:17:05 INFO - 'USER': 'cltbld', 07:17:05 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1468505792.906124-411778537', 07:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:05 INFO - '_': '/tools/buildbot/bin/python'} 07:17:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:17:06 INFO - Cleaning up... 07:17:06 INFO - Return code: 0 07:17:06 INFO - Running post-action listener: _resource_record_post_action 07:17:06 INFO - Running post-action listener: _start_resource_monitoring 07:17:06 INFO - Starting resource monitoring. 07:17:06 INFO - ##### 07:17:06 INFO - ##### Finished create-virtualenv step (success) 07:17:06 INFO - ##### 07:17:06 INFO - ##### 07:17:06 INFO - ##### Running install step. 07:17:06 INFO - ##### 07:17:06 INFO - Running pre-action listener: _resource_record_pre_action 07:17:06 INFO - Running main action method: install 07:17:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:17:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:17:06 INFO - Reading from file tmpfile_stdout 07:17:06 INFO - Detecting whether we're running mozinstall >=1.0... 07:17:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:17:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:17:06 INFO - Reading from file tmpfile_stdout 07:17:06 INFO - Output received: 07:17:06 INFO - Usage: mozinstall [options] installer 07:17:06 INFO - Options: 07:17:06 INFO - -h, --help show this help message and exit 07:17:06 INFO - -d DEST, --destination=DEST 07:17:06 INFO - Directory to install application into. [default: 07:17:06 INFO - "/builds/slave/test"] 07:17:06 INFO - --app=APP Application being installed. [default: firefox] 07:17:06 INFO - mkdir: /builds/slave/test/build/application 07:17:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:17:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:17:22 INFO - Reading from file tmpfile_stdout 07:17:22 INFO - Output received: 07:17:22 INFO - /builds/slave/test/build/application/firefox/firefox 07:17:22 INFO - Running post-action listener: _resource_record_post_action 07:17:22 INFO - ##### 07:17:22 INFO - ##### Finished install step (success) 07:17:22 INFO - ##### 07:17:22 INFO - ##### 07:17:22 INFO - ##### Running run-tests step. 07:17:22 INFO - ##### 07:17:22 INFO - Running pre-action listener: _resource_record_pre_action 07:17:22 INFO - Running main action method: run_tests 07:17:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:17:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:17:22 INFO - Python 2.7.3 07:17:22 INFO - Return code: 0 07:17:22 INFO - grabbing minidump binary from tooltool 07:17:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:22 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 0x23f63b0>, '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 0x23f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f7740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:17:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:17:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:17:22 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:17:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:17:22 INFO - Return code: 0 07:17:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:17:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:17:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:17:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:17:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:17:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IK-HY0PhQNSg4Zd-3dypZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:17:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IK-HY0PhQNSg4Zd-3dypZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:17:22 INFO - Using env: {'DISPLAY': ':0', 07:17:22 INFO - 'HOME': '/home/cltbld', 07:17:22 INFO - 'LANG': 'en_US.UTF-8', 07:17:22 INFO - 'LANGUAGE': 'en_US:en', 07:17:22 INFO - 'LOGNAME': 'cltbld', 07:17:22 INFO - 'MAIL': '/var/mail/cltbld', 07:17:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:17:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:17:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:22 INFO - 'MOZ_NO_REMOTE': '1', 07:17:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:17:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:22 INFO - 'NO_EM_RESTART': '1', 07:17:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:22 INFO - 'PWD': '/builds/slave/test', 07:17:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:17:22 INFO - 'SHELL': '/bin/bash', 07:17:22 INFO - 'SHLVL': '1', 07:17:22 INFO - 'TERM': 'linux', 07:17:22 INFO - 'TMOUT': '86400', 07:17:22 INFO - 'USER': 'cltbld', 07:17:22 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1468505792.906124-411778537', 07:17:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:22 INFO - '_': '/tools/buildbot/bin/python'} 07:17:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IK-HY0PhQNSg4Zd-3dypZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:17:22 INFO - mozversion application_buildid: 20160714064843 07:17:22 INFO - mozversion application_changeset: 6b9dae7e278dcd38d0b1c221ca9420931dfac7fd 07:17:22 INFO - mozversion application_display_name: Nightly 07:17:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:17:22 INFO - mozversion application_name: Firefox 07:17:22 INFO - mozversion application_remotingname: firefox 07:17:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:17:22 INFO - mozversion application_vendor: Mozilla 07:17:22 INFO - mozversion application_version: 50.0a1 07:17:22 INFO - mozversion platform_buildid: 20160714064843 07:17:22 INFO - mozversion platform_changeset: 6b9dae7e278dcd38d0b1c221ca9420931dfac7fd 07:17:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:17:22 INFO - mozversion platform_version: 50.0a1 07:17:22 INFO - using testdate: 1468505842 07:17:22 INFO - actual date: 1468505842 07:17:22 INFO - starting webserver on 'localhost:33501' 07:17:22 INFO - SUITE-START | Running 2 tests 07:17:22 INFO - TEST-START | dromaeo_css 07:17:22 INFO - operating with platform_type : linux_ 07:17:22 INFO - Initialising browser for dromaeo_css test... 07:17:23 INFO - TEST-INFO | started process 6630 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLeO4hm/profile http://localhost:33501/getInfo.html) 07:17:27 INFO - PROCESS | 6630 | __metrics Screen width/height:1600/1200 07:17:27 INFO - PROCESS | 6630 | colorDepth:24 07:17:27 INFO - PROCESS | 6630 | Browser inner width/height: 1024/697 07:17:27 INFO - PROCESS | 6630 | __metrics 07:17:28 INFO - PROCESS | 6630 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:17:28 INFO - PROCESS | 6630 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:17:28 INFO - PROCESS | 6630 | console.error: PushService: 07:17:28 INFO - PROCESS | 6630 | stateChangeProcessEnqueue: Error transitioning state 07:17:28 INFO - PROCESS | 6630 | UnknownError 07:17:29 INFO - TEST-INFO | 6630: exit 0 07:17:29 INFO - Browser initialized. 07:17:29 INFO - Running cycle 1/1 for dromaeo_css test... 07:17:29 INFO - TEST-INFO | started process 6713 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLeO4hm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:17:41 INFO - PROCESS | 6713 | RSS: Main: 159191040 07:17:41 INFO - PROCESS | 6713 | 07:18:33 INFO - PROCESS | 6713 | 1468505913291 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:20:44 INFO - PROCESS | 6713 | Cycle 1(1): loaded http://localhost:33501/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33501/tests/dromaeo/cssquery-ext.html) 07:20:45 INFO - PROCESS | 6713 | RSS: Main: 248360960 07:20:45 INFO - PROCESS | 6713 | 07:23:48 INFO - PROCESS | 6713 | Cycle 1(1): loaded http://localhost:33501/tests/dromaeo/cssquery-ext.html (next: http://localhost:33501/tests/dromaeo/cssquery-jquery.html) 07:23:49 INFO - PROCESS | 6713 | RSS: Main: 243900416 07:23:49 INFO - PROCESS | 6713 | 07:26:51 INFO - PROCESS | 6713 | Cycle 1(1): loaded http://localhost:33501/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33501/tests/dromaeo/cssquery-mootools.html) 07:26:51 INFO - PROCESS | 6713 | RSS: Main: 249425920 07:26:51 INFO - PROCESS | 6713 | 07:29:53 INFO - PROCESS | 6713 | Cycle 1(1): loaded http://localhost:33501/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33501/tests/dromaeo/cssquery-prototype.html) 07:29:54 INFO - PROCESS | 6713 | RSS: Main: 243277824 07:29:54 INFO - PROCESS | 6713 | 07:32:57 INFO - PROCESS | 6713 | Cycle 1(1): loaded http://localhost:33501/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33501/tests/dromaeo/cssquery-yui.html) 07:32:58 INFO - PROCESS | 6713 | RSS: Main: 216141824 07:32:58 INFO - PROCESS | 6713 | 07:36:00 INFO - PROCESS | 6713 | Cycle 1(1): loaded http://localhost:33501/tests/dromaeo/cssquery-yui.html (next: http://localhost:33501/tests/dromaeo/cssquery-dojo.html) 07:36:00 INFO - PROCESS | 6713 | RSS: Main: 297558016 07:36:00 INFO - PROCESS | 6713 | 07:36:00 INFO - PROCESS | 6713 | __start_tp_report 07:36:00 INFO - PROCESS | 6713 | _x_x_mozilla_page_load 07:36:00 INFO - PROCESS | 6713 | _x_x_mozilla_page_load_details 07:36:00 INFO - PROCESS | 6713 | |i|pagename|runs| 07:36:00 INFO - PROCESS | 6713 | |0;dojo.html;2653.0846857834044;2653.164253260224;2675.3177939625393;2683.798715096368;2684.7046824849276;4605.861824145281;4622.482344685486;4669.902572895367;4689.2028355179655;4758.191107511722;4658.53414658534;4687.554682305184;4701.905961880769;4712.458067322259;4716.7641617919135;4292.441982542266;4310.935335969947;4378.781060946956;4393.560643935597;4513.187626227278;4461.665375096864;4473.731576105428;4481.260592002332;4489.147062058199;4529.071540334224;4164.229617520768;4198.181354635847;4206.894827629303;4236.936445953283;4334.5882141196535;4276.550962148992;4287.035417031174;4295.098029413795;4307.5261721210645;4364.629006534448;4269.701120921537;4314.029343397742;4321.481422229321;4326.437563116806;4367.323064924942;4597.471290801567;4682.953170468286;4707.811687532495;4761.35721677576;4765.69023013503;5011.874703132451;5016.122178618763;5020.046191223656;5089.3638295213095;5093.439721630618;5081.74591270435;5091.287219789232;5113.335266415379;5116.437191908887;5155.046316431472;4562.247229207143;4675.649326300541;4808.663393562487;4816.277558366273;4821.2045012573235;5090.618203634742;5152.587792976553;5175.870603234949;5218.217267409919;5222.3472065991755;4917.7786999585105;4971.801127954841;4974.27872958419;4976;4976.751162441863;4890.633202509826;5004.749762511859;5017.8243761468175;5044.722540260247;5106.234064890222;4967.2549117631925;4994.450610432849;4995.900081998412;4997.550220480101;5028.069807085628;4973.378327709036;4983.451820299837;5010.974945125324;5026.2460630904925;5029.371328583927;4155.667546596265;4192.203481338536;4193.832246710159;4243.087736136746;4338.696291259645;3706.425504046877;3722.925541489155;3758.4926034985474;3775.3581891078584;3776.6412190841825;4326;4426.26966550522;4431.977840110843;4456.264716321835;4472.1502914446155;5041.0422019816115;5056.317397151411;5058.064258112261;5060.671056381397;5098.107831129538;4284.892877678083;4331.826726930887;4402.647788176938;4407.118576284756;4415.183191109655;4550.067236216568;4592.563706447882;4599.379083823708;4611.16998940194;4616.515265897099;4830.879228019257;4838.225883858566;4841.95158048415;4851.296561998561;4888.071266459361;4980.825671101639;5041.168207245763;5101.642884998015;5127.3847138343635;5178.663386879992;4687.039156972881;4744.525547445366;4753.47711751714;4763.333133361263;4763.928541071818;4949.1586430306215;4950.851474455772;4953.603711702983;4955.479674634112;4988.6757360771435;4869.513048695244;4975.402951645826;4998.900021999467;5035.433246339112;5072.619553533426;4850.927236091391;4881.438634557071;4896.608271338213;4910.680805747615;4953;4890.682105663121;4892.461829198856;4898.4121905371585;4901.117798796251;4926.556609905126;4718.693284936468;4823.131836269365;4837.129316723023;4877.707337559757;4889.486603906681;5008.449070602158;5028.34631497903;5029.321041659329;5030.647854650139;5058.671186372874;4918.803247870045;4923.261510773413;4924.72913989734;4932.950670493249;4978.2034874419915 07:36:00 INFO - PROCESS | 6713 | |1;ext.html;561.6124873837052;575.6200907401117;579.1688926390632;579.9763417567993;582.3972188784609;27432.588511172347;27917;39301.21397572047;40674.796626016825;40943;41951;42284.36573451401;42428.36357454633;42429.15141697172;42459.575404245945;7887.763367098982;8032.477888937229;8035.316998055172;8040.276375126237;8047;7933.841323173533;8014.358851291911;8026.317762990153;8028;8029.518228906255;8021.558814265242;8066.637001334925;8068.919310806876;8071.757847264592;8073.596320183968;7989.680412783482;8029.116797152308;8032.839343213162;8036.357091432671;8050.59747012647;7863.842723145505;7915.12933577306;7923.207679232089;7932.524048557105;7934.246246606564;39397.21205575901;39853.60146398557;39860.80069599633;39978.200435991406;40021;2954.556816477524;3005.383896301253;3384.881529146468;3787.791671458069;3857.4406711027023;27679.723202767917;29810;30028.399432011454;30392.54411183834;31243.531347029584;3145.7289917319335;3150.2596889730894;3200.647928727838;3229.5801545798895;3237.53055806909;257406;258545.7072714643;259682;260635;261069;32332.83833580864;53649;55242.44757552454;55331.44668553343;55455.44544554583;32421.675783241866;34276.31447371088;34329.537160169515;34346.65653343485;34363.65636343604;13545.255010974492;13710.314484275747;13718.38267277975;13729.176249425067;13730.038897277094;11189;11216.439178041228;11245.437728113562;11250.268732532522;11250.943745281222;8065.274125328749;8078.111407745143;8087.069986951458;8142.877856832152;8148.877766833502;3079.5380692896247;3087.5368694695976;3118.937621247562;3156.542301366289;3171.429142754326;803.670495097019;835.7868743470376;854.3080105114877;865.35098675993;889.4574309671095;27482.312942176606;27588.44823103527;27627.585586216224;27914.302142446602;28304.71695283062;921.2675922641516;953.4994128082812;986.4229425785852;1002.293383164867;1003.7791685829106;14577.198254096127;14585.708285834224;14699.11805291686;14888.925555372154;15092;376727;377692;378176;380576;381139;50263.74868125636;50885;50895;50933;50942.23586646203;1054.6888667843004;1155.607093588184;1186.727052777866;1189.3339729751367;1214.611324376191;28844.567331490463;29895.850520747255;29900.401991960473;30502;30589.847050764605;52262.73868630632;53842.57708403053;53844.73077634587;53862;53988.730056349465;329530;336047;336202;336638;337593;32505;37895.43156852705;38654.80672596619;39398.60601393949;39726.2054758909;39553.604463956144;40803.59196407998;43025.569744302156;43150.35274470822;43740;35311.47032794459;37003.44494832526;37863.62136378711;37895;38622;36597.817010914776;37389.439158412104;37473.437898431;37640.62359376371;38125.046873828374;36166.09584760402;36650.266994659425;36863.81568092143;37065;37081.443778343884;33186.672533098405;33240.501392479615;33558.49662255019;33798.49302260517;33824;25526.23421297364;25668.253205683715;25706.485870282115;25729.327593706348;26119 07:36:00 INFO - PROCESS | 6713 | |2;jquery.html;350.3850741947883;360.9368360536906;361.19273423897585;365.70926113739574;379.63175719552027;16610.41863534775;17372.65254694907;18132.36536721215;18144.274229030856;18147.99999999998;16977.66044679106;17968.82031179691;18313.81686183138;18338.724919126224;18342;5032.245163225509;5244.895102097975;5267.789288428458;5281.049411106;5283.656562323456;3788.5264341957254;3902.746321489108;3932.075962148893;5193.558547523465;6130.693465326716;6185.721642526075;6201.906971395432;6209;6212.844678883019;6213.2233470816145;5896.086106653475;6087.026075827846;6088.056351265516;6176.876462470748;6179.845503862417;5305.920411193835;5308.5487733542695;5312.92030619541;5328.413874473805;5329.706866122362;21298.893505532527;22311.553768924692;22438.88780556103;22638.20766273189;22669.2065777697;1844.004237711634;1995.8702684325472;2083.7186979757844;2137.3801597536694;2225.7329120505483;13207.339633018311;13531.03799949002;13536.796948045787;13610.387532561059;14358.353874075692;1712.6403455274408;1835.2567210279858;1841;1856.916438760259;1862.3854128137682;67335;67492.98760518646;67847.66076169637;68427.31572684259;68655.65672171608;9268.304877134242;9480.810383792286;9575.904240957641;9701.805963880824;9808.46053467052;12612.432440540199;12659.430325635369;12683.302418367079;12684.746305073846;12708.682282942815;7506.924930750732;7541.35898448627;7558.848823023509;7683.807904802425;7743.148253692089;7618;7631.3894888408795;7652.349550288177;7791.649375778104;7820;5946.4648181663;6167.568270221132;6237.376262373727;6237.812865614039;6266.874662506724;1660.7924009498813;1663.1102360237458;1690.7319510367224;1697.4822679082997;1700.7278835386278;840.8402403543307;842.8440738463404;851.6933903794629;893.946363218209;898.4160295807777;17580.296788128588;17881;17994;18308.176132073822;18346.357877474224;813.556611646654;863.2532859076854;868.8175483148609;881.3213825354442;894.9910500895038;9458.196053335407;9473.384230025027;9658.420494770337;9895;10070.04334588213;375795;380500;412674;415334;415446;81369.18630813734;82661.58669206615;85127.99999999876;85183;85183.14816851752;951.8001219743793;966.5408930757834;966.7389804752537;983.041534503853;984.9015098490237;15427.922860386076;15573.532794016197;15687.764683529984;15801.920990394974;16091.597710057342;37720.2455950874;38412.03969900775;38911.80544097262;39507.61723339669;39602.801985989885;55763.721181393834;56859.71570142123;56968;58024.4197558019;58265.70867145637;7543.47195696296;7923.762287131395;8044.959775201321;8161.714339998071;8349.37379696513;12103.33431661267;12166.452509637265;12362.505499779909;12566.937165314115;12748.298843563321;10788.244822862638;10918.508667110158;11153.672713938178;11183.72040698989;11188.608398706006;10678.8932110681;10808.297460665031;10963.451827408438;11062.280951738112;11085.390303533382;10472.842907356548;11108.944455277671;11141.888581114084;11202.495887685236;11375.374354410587;7487.176410594721;7766.339861111869;7988.960055199919;8229.711960081368;8517.403781735218;7900.762977110466;10649.574017039542;11007.834882476609;11055.336679799238;11407.315561066363 07:36:00 INFO - PROCESS | 6713 | |3;mootools.html;1275.0755702115973;1365.5834970334047;1382.232860762277;1443.6607397261648;1700.9319627214904;6775.424088952439;7696.846063078742;7962.6814927402975;7969.123396426388;8177.141400152973;7896.526208427498;8053.637586308616;8062.274395304421;8066.395020373481;8069.838603227947;2201.6147174244484;2227.654713519399;2230.4981379189635;2231.0518029837253;2232.430730163814;2181.5964046651343;2210.7568167501563;2232.754397016327;2248.2243625949022;2249.1790496468752;2214.8892555372167;2244.876531790751;2251.167068184774;2252.538229662915;2257.3340864445026;2153.095699806085;2170.772068932763;2176.7823217678106;2177.1617927098023;2180.1061564758375;2180.7819218078225;2187.3547303545333;2189.5073608437974;2189.6824960380814;2190.145843121184;7894.486858354188;8109.107998120202;8166.550839703814;8167.754967350929;8169.877451838227;4739.857804265843;4832.565069143759;4853.611711063107;4857.878553036202;4859.562639362474;2800.061979236958;2858.4854726149283;2903.4483448144783;2904.404597057598;2916.329244273829;903.1645727701849;917.3028498341242;925.6343744220995;925.6436272035315;938.9201917836924;10673.839892401542;10728.463576821128;10768.138548916068;10786.191035672357;10788.622398216025;3890.124721937598;3967.1668949520345;4108.157827645386;4162.084341444877;4171.144915292358;8512.148785121562;8549.658013679507;8576.614052367659;8592.44149130317;8597.699080532151;4661.044485880387;4661.091087237956;4669.766511674403;4673.112108699336;4673.462551806518;3645.453182022718;3854.9036274093373;3948.269570129478;4351.0645211279725;4351.282038463618;3480.756347055682;3586.228960773394;3608.0619039050034;3656.652618001339;3662.08447888028;1065.174489770434;1075.9623413180502;1077.9137668986461;1078.983815242772;1092.1644941619668;720.6865013719049;813.1705660226536;815.5432957543676;818.1205204405288;841.2218697704722;4882.292067650171;4971.1797553403285;5126.666766660155;5137.51193636604;5286.418493965661;402.8799936177373;408.5710004495268;418.11359916976204;418.6901692747345;423.8389412023473;3664.2671465706967;3701.592824789271;3945.881623551298;4005.098852758106;4051.473308469939;9545.570449329796;10131.696049118538;10148.543315550818;10153.340032897986;10174.236932230113;9785.657501987396;9944.850827237597;10055.497225138713;10064.69805905824;10086.24353173515;7329.816754581071;7428.1086269647985;7497;7507.7747667568965;7527.8118047049265;5379.973100134631;5481.561475082063;5559.082751345983;5644.125160600113;5654.632448890973;8896;8923.330750193632;8948.552572371485;8951.239144672516;9054.411463254868;8050.798730031796;8558.914410855812;8986.68546600866;9205.493697846416;9226.861597075915;6564.310747371457;6787.490938179755;6790.830229244309;6792.72829086831;6959.130108736408;7555.395568354408;7643.541387516767;7698.730544430918;7702.730404435818;7748.1864404238995;6743.2582415935185;6753.3921947025;6904.4131248844415;7062.646867656699;7079.752208672672;6732.225794033553;6742.730290788313;6791.0832037676255;6873.759418420332;7096.53872498286;6548.47612191014;6585.275619681735;6590.044443555754;6614.702338394687;6614.933850661624;4699.671023028355;4884.3650325457465;4887.706737595756;4910.631702622246;4930.753462326941;4856.955754512655;4859.07677541266;4878.756062196805;4893.877653058702;4920.384951881015 07:36:00 INFO - PROCESS | 6713 | |4;prototype.html;298.4329773430483;301.22134282878756;307.2641024745734;309.9287163952291;310.793322440577;4828.348172996644;4831.613470922327;4833;4848.248521479172;4887.560119589236;4756.857294281169;4802.543758342952;4806.423229212491;4806.927896081562;4818.614510839133;3599.154198763295;3720.851165953372;3728.738988270822;3729.720270979674;3737.4020156774923;3650.8539658413633;3735;3787.5644300905337;3827.483289755889;3838.483798899433;3727.3104475671953;3787.261484010619;3788.223414200096;3809.3904975203973;3814.542254929412;3559.2703495783303;3756.4365345198166;3786.110264087937;3802.581716011223;3803.1442925341576;3252.593425821772;3264.7551433642334;3276.9016929492154;3280.2455435249785;3292.2098696312714;4665.230237010889;4672.925227197764;4673.205555055615;4676.649251306131;4699.624030077585;4084.693647976384;4233.449651545279;4242.745435273893;4259.275923093051;4278.72188307759;4981.128302547076;4981.178105612569;5005.799768009275;5010.849674509771;5024.296598476216;3570.107473131717;3573.857045718168;3575.856965721368;3580.7314451416246;3585.9779962710504;5113.616478764107;5197.454267301917;5227.581793456515;5250.789968401259;5271.789128434858;3612.7600887449425;3621.3843646580144;3629.8366573504254;3634.9818250908575;3645.908852278714;3672.3940549809518;3679.632036796299;3682.85678611562;3688.8524459021874;3689.262147570497;4219.6580897602125;4232.957670423318;4233.618974292329;4235.797385359596;4239.97880010598;4831.637627177975;4970.527799859007;4974.801007959713;4983.327250821165;4987.852793857433;1262.6464589914838;1269.8666640002666;1278.4566559212299;1278.4822147030468;1279.814426908093;801.8596745569502;822.6791551294999;826.3595713322103;841.7811369044092;845.9492430454193;4380.890477738082;4471;4490.236659767782;4525.298578720303;4537.3438694876795;5165.380154381498;5170.759017835692;5213.165893457029;5231.921521177185;5233.816816411483;4504.25679762842;4506.3916371290115;4531;4536.909261814745;4567.520410356931;2592.844429334246;2747.244507760342;2751.9449611008067;2753.4217814258827;2768.335599456156;4894.926576101361;4897.184119131513;4905.6811307265625;4939.925901111486;4954.157793175097;5033.79864805411;5291.947080529146;5292.708901010481;5302.522772950453;5321.521063104339;4906.681065730716;4928.137575924199;4930.876728081683;4945.752712364368;4953.563466594647;5192.896142077062;5196.662216955886;5197.610179236497;5202.944836789523;5250.527452529291;4844.8304309349005;5081.644284900021;5142.382914050338;5147;5147.202183661539;4922.630802689884;4922.923173016865;4927.260910863399;4930.383702037246;4935.531124543163;3671.6144804795113;3685.631436856293;3715.9442608360355;3718.0890681783135;3719.6094410086553;5085.288059671723;5182.6890386575415;5223.4515375884985;5233.162693968947;5235.3038185335345;4996.450390456974;5013.573846223112;5018.347614810052;5018.544622059562;5028.421731500925;5025.773840177128;5030.547250747451;5084.618653600921;5091.8939446938075;5095.87260318495;4877.244027175793;4910.9017819642695;5002.52476014778;5011.273365362075;5020.623453240948;4861.368022157097;4942.357493525818;5036.118679231193;5066.36670416198;5086.415062267886;4951.678140920829;4952.331435256195;4952.331435256195;4965.0318187953;4967.726775027409 07:36:00 INFO - PROCESS | 6713 | |5;yui.html;611.6574718157831;667.5427332277391;687.9243283238843;713.9229919048896;735.5439627430993;12158.452869620865;12578.371081445937;12597.055220858427;12604.873951260484;12628.810567841467;13171.73656526869;13404.597862064154;13422.328883555807;13424.597262082129;13444.462221511152;624.319491753988;765.720512013114;782.8512582609286;796.2236819101388;798.9520628762264;788.3929374381722;791.4657606115877;793.4445887878479;794;794.1938931984041;843.472829481574;844.2654890245495;844.8268105038452;844.907060223375;845.045099038086;647.4852492268634;792.7582087463321;825.5005721538503;827.1356432527963;831.2145022953281;604.6795198544778;607.7599348257413;609.2445367743966;609.2901769438598;609.6921054867264;12204.389780510939;12224.327661978588;12258;12281.877181228252;12285.324307163102;12367.938160309232;12856.550020749322;12910.548130815376;12935.935320323339;12980.221186728731;10987.175961802817;11106.61126860556;11315;11575.479103440366;11700.239484433485;4071.4096456013713;4104.440610063274;4118.4440100586635;4172.645325147336;4295.183915056161;58405.12392314161;58960.410395895924;59290;59346.70326648339;59361.703191483764;9257.166854983085;9501.572429240701;9559.522023898777;9570.425774453415;9571.090746379083;18261.269549217883;18432.07839608041;18521.53696157607;18528.814711852978;18531.629367412577;6563.278039415661;6651.933480665228;6834.555753875982;6875.621840798704;6931.584104953719;3638.69071128957;3661.885266215277;3687.985654512894;3691.686206672463;3708.35103856824;2798.5102607043686;2884.22126025976;2897.435000174946;2899.420115976813;2903.3177203357195;372.4878292348021;466.2609763524851;469.0525139218759;484.46224690593414;484.8569671946784;443.68276682172404;488.8020351757544;516.1818517649567;522.8353068783321;523.1733860500476;7640.656170472342;7844;7860.764177074697;7861.724839630586;8238.588070596446;492.9088118698052;518.2019689677854;523.254362533396;526.2789977730457;534.6311045378754;3535.5934067582043;3725.8509659613856;3746.2507498499863;3778.7165962552917;3781.205946751158;76918.6154069226;78861.60569197117;79874;88381.55809220913;97560.51219743855;85458.57270713606;86995;87331;88437;89185.55407222922;20177;21826.781732182793;28259.434811303658;74222.6288868563;79995.60002199952;8527.14728527167;8537.359698022798;8719.476831390137;8977.955110224408;9080.228180604723;31828;37933.620663794114;45009;48105;49218.75390623167;64097;68604.6569767148;69521;69522.30477695158;72246.63876680583;11100.833487497855;11262.718432038937;11289.943550282525;11364.318140911571;11897.345645989553;12404.751904962031;12441.502339906303;12515.874841251834;12616.684582885502;12741.235525868478;11526.553941414517;12067.818982715442;12144.39278036077;12502.93748531288;12544.310062946626;11783.76432471363;12281.631551053482;12377.62867113988;12377.876221238033;12397.442115105023;11032.944835275772;11628.895254950767;11761.647150585497;11872.347020913587;11922.046236300901;10086.596536138766;10143.289969702346;10143.78274607052;10436;10458.895411046096;9867.851982220129;10084.294099412971;10353.844692329772;10539.314944528582;10665.626703065665 07:36:00 INFO - PROCESS | 6713 | __end_tp_report 07:36:00 INFO - PROCESS | 6713 | __start_cc_report 07:36:00 INFO - PROCESS | 6713 | _x_x_mozilla_cycle_collect,930 07:36:00 INFO - PROCESS | 6713 | __end_cc_report 07:36:00 INFO - PROCESS | 6713 | __startTimestamp1468506960971__endTimestamp 07:36:00 INFO - PROCESS | 6713 | 07:36:00 INFO - PROCESS | 6713 | ------- Summary: start ------- 07:36:00 INFO - PROCESS | 6713 | Number of tests: 6 07:36:00 INFO - PROCESS | 6713 | 07:36:00 INFO - PROCESS | 6713 | [#0] dojo.html Cycles:165 Average:4671.08 Median:4830.88 stddev:485.91 (10.1%) stddev-sans-first:460.89 07:36:00 INFO - PROCESS | 6713 | Values: 2653.1 2653.2 2675.3 2683.8 2684.7 4605.9 4622.5 4669.9 4689.2 4758.2 4658.5 4687.6 4701.9 4712.5 4716.8 4292.4 4310.9 4378.8 4393.6 4513.2 4461.7 4473.7 4481.3 4489.1 4529.1 4164.2 4198.2 4206.9 4236.9 4334.6 4276.6 4287.0 4295.1 4307.5 4364.6 4269.7 4314.0 4321.5 4326.4 4367.3 4597.5 4683.0 4707.8 4761.4 4765.7 5011.9 5016.1 5020.0 5089.4 5093.4 5081.7 5091.3 5113.3 5116.4 5155.0 4562.2 4675.6 4808.7 4816.3 4821.2 5090.6 5152.6 5175.9 5218.2 5222.3 4917.8 4971.8 4974.3 4976.0 4976.8 4890.6 5004.7 5017.8 5044.7 5106.2 4967.3 4994.5 4995.9 4997.6 5028.1 4973.4 4983.5 5011.0 5026.2 5029.4 4155.7 4192.2 4193.8 4243.1 4338.7 3706.4 3722.9 3758.5 3775.4 3776.6 4326.0 4426.3 4432.0 4456.3 4472.2 5041.0 5056.3 5058.1 5060.7 5098.1 4284.9 4331.8 4402.6 4407.1 4415.2 4550.1 4592.6 4599.4 4611.2 4616.5 4830.9 4838.2 4842.0 4851.3 4888.1 4980.8 5041.2 5101.6 5127.4 5178.7 4687.0 4744.5 4753.5 4763.3 4763.9 4949.2 4950.9 4953.6 4955.5 4988.7 4869.5 4975.4 4998.9 5035.4 5072.6 4850.9 4881.4 4896.6 4910.7 4953.0 4890.7 4892.5 4898.4 4901.1 4926.6 4718.7 4823.1 4837.1 4877.7 4889.5 5008.4 5028.3 5029.3 5030.6 5058.7 4918.8 4923.3 4924.7 4933.0 4978.2 07:36:00 INFO - PROCESS | 6713 | 07:36:00 INFO - PROCESS | 6713 | [#1] ext.html Cycles:180 Average:47743.45 Median:377209.50 stddev:86473.25 (22.9%) stddev-sans-first:86643.27 07:36:00 INFO - PROCESS | 6713 | Values: 561.6 575.6 579.2 580.0 582.4 27432.6 27917.0 39301.2 40674.8 40943.0 41951.0 42284.4 42428.4 42429.2 42459.6 7887.8 8032.5 8035.3 8040.3 8047.0 7933.8 8014.4 8026.3 8028.0 8029.5 8021.6 8066.6 8068.9 8071.8 8073.6 7989.7 8029.1 8032.8 8036.4 8050.6 7863.8 7915.1 7923.2 7932.5 7934.2 39397.2 39853.6 39860.8 39978.2 40021.0 2954.6 3005.4 3384.9 3787.8 3857.4 27679.7 29810.0 30028.4 30392.5 31243.5 3145.7 3150.3 3200.6 3229.6 3237.5 257406.0 258545.7 259682.0 260635.0 261069.0 32332.8 53649.0 55242.4 55331.4 55455.4 32421.7 34276.3 34329.5 34346.7 34363.7 13545.3 13710.3 13718.4 13729.2 13730.0 11189.0 11216.4 11245.4 11250.3 11250.9 8065.3 8078.1 8087.1 8142.9 8148.9 3079.5 3087.5 3118.9 3156.5 3171.4 803.7 835.8 854.3 865.4 889.5 27482.3 27588.4 27627.6 27914.3 28304.7 921.3 953.5 986.4 1002.3 1003.8 14577.2 14585.7 14699.1 14888.9 15092.0 376727.0 377692.0 378176.0 380576.0 381139.0 50263.7 50885.0 50895.0 50933.0 50942.2 1054.7 1155.6 1186.7 1189.3 1214.6 28844.6 29895.9 29900.4 30502.0 30589.8 52262.7 53842.6 53844.7 53862.0 53988.7 329530.0 336047.0 336202.0 336638.0 337593.0 32505.0 37895.4 38654.8 39398.6 39726.2 39553.6 40803.6 43025.6 43150.4 43740.0 35311.5 37003.4 37863.6 37895.0 38622.0 36597.8 37389.4 37473.4 37640.6 38125.0 36166.1 36650.3 36863.8 37065.0 37081.4 33186.7 33240.5 33558.5 33798.5 33824.0 25526.2 25668.3 25706.5 25729.3 26119.0 07:36:00 INFO - PROCESS | 6713 | 07:36:00 INFO - PROCESS | 6713 | [#2] jquery.html Cycles:180 Average:25401.05 Median:414004.00 stddev:66181.88 (16.0%) stddev-sans-first:66340.81 07:36:00 INFO - PROCESS | 6713 | Values: 350.4 360.9 361.2 365.7 379.6 16610.4 17372.7 18132.4 18144.3 18148.0 16977.7 17968.8 18313.8 18338.7 18342.0 5032.2 5244.9 5267.8 5281.0 5283.7 3788.5 3902.7 3932.1 5193.6 6130.7 6185.7 6201.9 6209.0 6212.8 6213.2 5896.1 6087.0 6088.1 6176.9 6179.8 5305.9 5308.5 5312.9 5328.4 5329.7 21298.9 22311.6 22438.9 22638.2 22669.2 1844.0 1995.9 2083.7 2137.4 2225.7 13207.3 13531.0 13536.8 13610.4 14358.4 1712.6 1835.3 1841.0 1856.9 1862.4 67335.0 67493.0 67847.7 68427.3 68655.7 9268.3 9480.8 9575.9 9701.8 9808.5 12612.4 12659.4 12683.3 12684.7 12708.7 7506.9 7541.4 7558.8 7683.8 7743.1 7618.0 7631.4 7652.3 7791.6 7820.0 5946.5 6167.6 6237.4 6237.8 6266.9 1660.8 1663.1 1690.7 1697.5 1700.7 840.8 842.8 851.7 893.9 898.4 17580.3 17881.0 17994.0 18308.2 18346.4 813.6 863.3 868.8 881.3 895.0 9458.2 9473.4 9658.4 9895.0 10070.0 375795.0 380500.0 412674.0 415334.0 415446.0 81369.2 82661.6 85128.0 85183.0 85183.1 951.8 966.5 966.7 983.0 984.9 15427.9 15573.5 15687.8 15801.9 16091.6 37720.2 38412.0 38911.8 39507.6 39602.8 55763.7 56859.7 56968.0 58024.4 58265.7 7543.5 7923.8 8045.0 8161.7 8349.4 12103.3 12166.5 12362.5 12566.9 12748.3 10788.2 10918.5 11153.7 11183.7 11188.6 10678.9 10808.3 10963.5 11062.3 11085.4 10472.8 11108.9 11141.9 11202.5 11375.4 7487.2 7766.3 7989.0 8229.7 8517.4 7900.8 10649.6 11007.8 11055.3 11407.3 07:36:00 INFO - PROCESS | 6713 | 07:36:00 INFO - PROCESS | 6713 | [#3] mootools.html Cycles:180 Average:5200.02 Median:4880.52 stddev:2941.95 (60.3%) stddev-sans-first:2935.42 07:36:00 INFO - PROCESS | 6713 | Values: 1275.1 1365.6 1382.2 1443.7 1700.9 6775.4 7696.8 7962.7 7969.1 8177.1 7896.5 8053.6 8062.3 8066.4 8069.8 2201.6 2227.7 2230.5 2231.1 2232.4 2181.6 2210.8 2232.8 2248.2 2249.2 2214.9 2244.9 2251.2 2252.5 2257.3 2153.1 2170.8 2176.8 2177.2 2180.1 2180.8 2187.4 2189.5 2189.7 2190.1 7894.5 8109.1 8166.6 8167.8 8169.9 4739.9 4832.6 4853.6 4857.9 4859.6 2800.1 2858.5 2903.4 2904.4 2916.3 903.2 917.3 925.6 925.6 938.9 10673.8 10728.5 10768.1 10786.2 10788.6 3890.1 3967.2 4108.2 4162.1 4171.1 8512.1 8549.7 8576.6 8592.4 8597.7 4661.0 4661.1 4669.8 4673.1 4673.5 3645.5 3854.9 3948.3 4351.1 4351.3 3480.8 3586.2 3608.1 3656.7 3662.1 1065.2 1076.0 1077.9 1079.0 1092.2 720.7 813.2 815.5 818.1 841.2 4882.3 4971.2 5126.7 5137.5 5286.4 402.9 408.6 418.1 418.7 423.8 3664.3 3701.6 3945.9 4005.1 4051.5 9545.6 10131.7 10148.5 10153.3 10174.2 9785.7 9944.9 10055.5 10064.7 10086.2 7329.8 7428.1 7497.0 7507.8 7527.8 5380.0 5481.6 5559.1 5644.1 5654.6 8896.0 8923.3 8948.6 8951.2 9054.4 8050.8 8558.9 8986.7 9205.5 9226.9 6564.3 6787.5 6790.8 6792.7 6959.1 7555.4 7643.5 7698.7 7702.7 7748.2 6743.3 6753.4 6904.4 7062.6 7079.8 6732.2 6742.7 6791.1 6873.8 7096.5 6548.5 6585.3 6590.0 6614.7 6614.9 4699.7 4884.4 4887.7 4910.6 4930.8 4857.0 4859.1 4878.8 4893.9 4920.4 07:36:00 INFO - PROCESS | 6713 | 07:36:00 INFO - PROCESS | 6713 | [#4] prototype.html Cycles:180 Average:4184.54 Median:4829.98 stddev:1220.63 (25.3%) stddev-sans-first:1188.69 07:36:00 INFO - PROCESS | 6713 | Values: 298.4 301.2 307.3 309.9 310.8 4828.3 4831.6 4833.0 4848.2 4887.6 4756.9 4802.5 4806.4 4806.9 4818.6 3599.2 3720.9 3728.7 3729.7 3737.4 3650.9 3735.0 3787.6 3827.5 3838.5 3727.3 3787.3 3788.2 3809.4 3814.5 3559.3 3756.4 3786.1 3802.6 3803.1 3252.6 3264.8 3276.9 3280.2 3292.2 4665.2 4672.9 4673.2 4676.6 4699.6 4084.7 4233.4 4242.7 4259.3 4278.7 4981.1 4981.2 5005.8 5010.8 5024.3 3570.1 3573.9 3575.9 3580.7 3586.0 5113.6 5197.5 5227.6 5250.8 5271.8 3612.8 3621.4 3629.8 3635.0 3645.9 3672.4 3679.6 3682.9 3688.9 3689.3 4219.7 4233.0 4233.6 4235.8 4240.0 4831.6 4970.5 4974.8 4983.3 4987.9 1262.6 1269.9 1278.5 1278.5 1279.8 801.9 822.7 826.4 841.8 845.9 4380.9 4471.0 4490.2 4525.3 4537.3 5165.4 5170.8 5213.2 5231.9 5233.8 4504.3 4506.4 4531.0 4536.9 4567.5 2592.8 2747.2 2751.9 2753.4 2768.3 4894.9 4897.2 4905.7 4939.9 4954.2 5033.8 5291.9 5292.7 5302.5 5321.5 4906.7 4928.1 4930.9 4945.8 4953.6 5192.9 5196.7 5197.6 5202.9 5250.5 4844.8 5081.6 5142.4 5147.0 5147.2 4922.6 4922.9 4927.3 4930.4 4935.5 3671.6 3685.6 3715.9 3718.1 3719.6 5085.3 5182.7 5223.5 5233.2 5235.3 4996.5 5013.6 5018.3 5018.5 5028.4 5025.8 5030.5 5084.6 5091.9 5095.9 4877.2 4910.9 5002.5 5011.3 5020.6 4861.4 4942.4 5036.1 5066.4 5086.4 4951.7 4952.3 4952.3 4965.0 4967.7 07:36:00 INFO - PROCESS | 6713 | 07:36:00 INFO - PROCESS | 6713 | [#5] yui.html Cycles:180 Average:16709.32 Median:22726.34 stddev:23604.21 (103.9%) stddev-sans-first:23639.48 07:36:00 INFO - PROCESS | 6713 | Values: 611.7 667.5 687.9 713.9 735.5 12158.5 12578.4 12597.1 12604.9 12628.8 13171.7 13404.6 13422.3 13424.6 13444.5 624.3 765.7 782.9 796.2 799.0 788.4 791.5 793.4 794.0 794.2 843.5 844.3 844.8 844.9 845.0 647.5 792.8 825.5 827.1 831.2 604.7 607.8 609.2 609.3 609.7 12204.4 12224.3 12258.0 12281.9 12285.3 12367.9 12856.6 12910.5 12935.9 12980.2 10987.2 11106.6 11315.0 11575.5 11700.2 4071.4 4104.4 4118.4 4172.6 4295.2 58405.1 58960.4 59290.0 59346.7 59361.7 9257.2 9501.6 9559.5 9570.4 9571.1 18261.3 18432.1 18521.5 18528.8 18531.6 6563.3 6651.9 6834.6 6875.6 6931.6 3638.7 3661.9 3688.0 3691.7 3708.4 2798.5 2884.2 2897.4 2899.4 2903.3 372.5 466.3 469.1 484.5 484.9 443.7 488.8 516.2 522.8 523.2 7640.7 7844.0 7860.8 7861.7 8238.6 492.9 518.2 523.3 526.3 534.6 3535.6 3725.9 3746.3 3778.7 3781.2 76918.6 78861.6 79874.0 88381.6 97560.5 85458.6 86995.0 87331.0 88437.0 89185.6 20177.0 21826.8 28259.4 74222.6 79995.6 8527.1 8537.4 8719.5 8978.0 9080.2 31828.0 37933.6 45009.0 48105.0 49218.8 64097.0 68604.7 69521.0 69522.3 72246.6 11100.8 11262.7 11289.9 11364.3 11897.3 12404.8 12441.5 12515.9 12616.7 12741.2 11526.6 12067.8 12144.4 12502.9 12544.3 11783.8 12281.6 12377.6 12377.9 12397.4 11032.9 11628.9 11761.6 11872.3 11922.0 10086.6 10143.3 10143.8 10436.0 10458.9 9867.9 10084.3 10353.8 10539.3 10665.6 07:36:00 INFO - PROCESS | 6713 | -------- Summary: end -------- 07:36:00 INFO - PROCESS | 6713 | 07:36:01 INFO - TEST-INFO | 6713: exit 0 07:36:01 INFO - TEST-OK | dromaeo_css | took 1118829ms 07:36:01 INFO - TEST-START | kraken 07:36:01 INFO - operating with platform_type : linux_ 07:36:01 INFO - Initialising browser for kraken test... 07:36:01 INFO - TEST-INFO | started process 6907 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3_MzR1/profile http://localhost:33501/getInfo.html) 07:36:05 INFO - PROCESS | 6907 | __metrics Screen width/height:1600/1200 07:36:05 INFO - PROCESS | 6907 | colorDepth:24 07:36:05 INFO - PROCESS | 6907 | Browser inner width/height: 1024/697 07:36:05 INFO - PROCESS | 6907 | __metrics 07:36:06 INFO - PROCESS | 6907 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:36:06 INFO - PROCESS | 6907 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:36:06 INFO - PROCESS | 6907 | console.error: PushService: 07:36:06 INFO - PROCESS | 6907 | stateChangeProcessEnqueue: Error transitioning state 07:36:06 INFO - PROCESS | 6907 | UnknownError 07:36:07 INFO - TEST-INFO | 6907: exit 0 07:36:07 INFO - Browser initialized. 07:36:07 INFO - Running cycle 1/1 for kraken test... 07:36:07 INFO - TEST-INFO | started process 6988 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3_MzR1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:36:19 INFO - PROCESS | 6988 | RSS: Main: 159592448 07:36:19 INFO - PROCESS | 6988 | 07:36:22 INFO - PROCESS | 6988 | Cycle 1(1): loaded http://localhost:33501/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33501/tests/kraken/driver.html?testName=audio-beat-detection) 07:36:23 INFO - PROCESS | 6988 | RSS: Main: 217149440 07:36:23 INFO - PROCESS | 6988 | 07:36:25 INFO - PROCESS | 6988 | Cycle 1(1): loaded http://localhost:33501/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33501/tests/kraken/driver.html?testName=audio-dft) 07:36:26 INFO - PROCESS | 6988 | RSS: Main: 204169216 07:36:26 INFO - PROCESS | 6988 | 07:36:29 INFO - PROCESS | 6988 | Cycle 1(1): loaded http://localhost:33501/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33501/tests/kraken/driver.html?testName=audio-fft) 07:36:30 INFO - PROCESS | 6988 | RSS: Main: 271663104 07:36:30 INFO - PROCESS | 6988 | 07:36:32 INFO - PROCESS | 6988 | Cycle 1(1): loaded http://localhost:33501/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33501/tests/kraken/driver.html?testName=audio-oscillator) 07:36:33 INFO - PROCESS | 6988 | RSS: Main: 182034432 07:36:33 INFO - PROCESS | 6988 | 07:36:35 INFO - PROCESS | 6988 | Cycle 1(1): loaded http://localhost:33501/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33501/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:36:35 INFO - PROCESS | 6988 | RSS: Main: 185606144 07:36:35 INFO - PROCESS | 6988 | 07:36:39 INFO - PROCESS | 6988 | Cycle 1(1): loaded http://localhost:33501/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33501/tests/kraken/driver.html?testName=imaging-darkroom) 07:36:39 INFO - PROCESS | 6988 | RSS: Main: 222400512 07:36:39 INFO - PROCESS | 6988 | 07:36:43 INFO - PROCESS | 6988 | Cycle 1(1): loaded http://localhost:33501/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33501/tests/kraken/driver.html?testName=imaging-desaturate) 07:36:43 INFO - PROCESS | 6988 | RSS: Main: 218329088 07:36:43 INFO - PROCESS | 6988 | 07:36:46 INFO - PROCESS | 6988 | Cycle 1(1): loaded http://localhost:33501/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33501/tests/kraken/driver.html?testName=json-parse-financial) 07:36:47 INFO - PROCESS | 6988 | RSS: Main: 221200384 07:36:47 INFO - PROCESS | 6988 | 07:36:49 INFO - PROCESS | 6988 | Cycle 1(1): loaded http://localhost:33501/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33501/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:36:49 INFO - PROCESS | 6988 | RSS: Main: 207941632 07:36:49 INFO - PROCESS | 6988 | 07:36:51 INFO - PROCESS | 6988 | Cycle 1(1): loaded http://localhost:33501/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33501/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:36:52 INFO - PROCESS | 6988 | RSS: Main: 212537344 07:36:52 INFO - PROCESS | 6988 | 07:36:54 INFO - PROCESS | 6988 | Cycle 1(1): loaded http://localhost:33501/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33501/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:36:55 INFO - PROCESS | 6988 | RSS: Main: 213868544 07:36:55 INFO - PROCESS | 6988 | 07:36:57 INFO - PROCESS | 6988 | Cycle 1(1): loaded http://localhost:33501/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33501/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:36:58 INFO - PROCESS | 6988 | RSS: Main: 227627008 07:36:58 INFO - PROCESS | 6988 | 07:37:01 INFO - PROCESS | 6988 | Cycle 1(1): loaded http://localhost:33501/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33501/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:37:01 INFO - PROCESS | 6988 | RSS: Main: 226877440 07:37:01 INFO - PROCESS | 6988 | 07:37:03 INFO - PROCESS | 6988 | Cycle 1(1): loaded http://localhost:33501/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33501/tests/kraken/driver.html?testName=ai-astar) 07:37:03 INFO - PROCESS | 6988 | RSS: Main: 269074432 07:37:03 INFO - PROCESS | 6988 | 07:37:03 INFO - PROCESS | 6988 | __start_tp_report 07:37:03 INFO - PROCESS | 6988 | _x_x_mozilla_page_load 07:37:03 INFO - PROCESS | 6988 | _x_x_mozilla_page_load_details 07:37:03 INFO - PROCESS | 6988 | |i|pagename|runs| 07:37:03 INFO - PROCESS | 6988 | |0;ai-astar;105;113;114;114;112;112;114;111;112;113 07:37:03 INFO - PROCESS | 6988 | |1;audio-beat-detection;149;120;124;177;122;123;151;122;168;124 07:37:03 INFO - PROCESS | 6988 | |2;audio-dft;163;161;162;160;162;162;162;162;163;161 07:37:03 INFO - PROCESS | 6988 | |3;audio-fft;75;76;75;101;75;76;75;75;100;76 07:37:03 INFO - PROCESS | 6988 | |4;audio-oscillator;86;86;117;86;85;86;116;87;86;120 07:37:03 INFO - PROCESS | 6988 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 07:37:03 INFO - PROCESS | 6988 | |6;imaging-darkroom;147;148;148;146;146;146;147;146;147;146 07:37:03 INFO - PROCESS | 6988 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;94;95 07:37:03 INFO - PROCESS | 6988 | |8;json-parse-financial;66;65;66;66;65;68;65;67;66;66 07:37:03 INFO - PROCESS | 6988 | |9;json-stringify-tinderbox;65;66;65;65;65;65;66;65;65;65 07:37:03 INFO - PROCESS | 6988 | |10;stanford-crypto-aes;81;84;77;77;82;78;78;79;80;82 07:37:03 INFO - PROCESS | 6988 | |11;stanford-crypto-ccm;138;137;126;137;128;130;126;136;213;140 07:37:03 INFO - PROCESS | 6988 | |12;stanford-crypto-pbkdf2;169;164;161;164;163;161;162;162;162;163 07:37:03 INFO - PROCESS | 6988 | |13;stanford-crypto-sha256-iterative;68;66;65;66;67;65;63;65;64;67 07:37:03 INFO - PROCESS | 6988 | __end_tp_report 07:37:03 INFO - PROCESS | 6988 | __start_cc_report 07:37:03 INFO - PROCESS | 6988 | _x_x_mozilla_cycle_collect,1939 07:37:03 INFO - PROCESS | 6988 | __end_cc_report 07:37:03 INFO - PROCESS | 6988 | __startTimestamp1468507023926__endTimestamp 07:37:03 INFO - PROCESS | 6988 | 07:37:03 INFO - PROCESS | 6988 | ------- Summary: start ------- 07:37:03 INFO - PROCESS | 6988 | Number of tests: 14 07:37:03 INFO - PROCESS | 6988 | 07:37:03 INFO - PROCESS | 6988 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:2.67 (2.4%) stddev-sans-first:1.09 07:37:03 INFO - PROCESS | 6988 | Values: 105.0 113.0 114.0 114.0 112.0 112.0 114.0 111.0 112.0 113.0 07:37:03 INFO - PROCESS | 6988 | 07:37:03 INFO - PROCESS | 6988 | [#1] audio-beat-detection Cycles:10 Average:138.00 Median:136.50 stddev:21.51 (15.8%) stddev-sans-first:22.44 07:37:03 INFO - PROCESS | 6988 | Values: 149.0 120.0 124.0 177.0 122.0 123.0 151.0 122.0 168.0 124.0 07:37:03 INFO - PROCESS | 6988 | 07:37:03 INFO - PROCESS | 6988 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 07:37:03 INFO - PROCESS | 6988 | Values: 163.0 161.0 162.0 160.0 162.0 162.0 162.0 162.0 163.0 161.0 07:37:03 INFO - PROCESS | 6988 | 07:37:03 INFO - PROCESS | 6988 | [#3] audio-fft Cycles:10 Average:80.40 Median:75.00 stddev:10.61 (14.1%) stddev-sans-first:11.07 07:37:03 INFO - PROCESS | 6988 | Values: 75.0 76.0 75.0 101.0 75.0 76.0 75.0 75.0 100.0 76.0 07:37:03 INFO - PROCESS | 6988 | 07:37:03 INFO - PROCESS | 6988 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:86.00 stddev:15.34 (17.8%) stddev-sans-first:15.88 07:37:03 INFO - PROCESS | 6988 | Values: 86.0 86.0 117.0 86.0 85.0 86.0 116.0 87.0 86.0 120.0 07:37:03 INFO - PROCESS | 6988 | 07:37:03 INFO - PROCESS | 6988 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 07:37:03 INFO - PROCESS | 6988 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 07:37:03 INFO - PROCESS | 6988 | 07:37:03 INFO - PROCESS | 6988 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 07:37:03 INFO - PROCESS | 6988 | Values: 147.0 148.0 148.0 146.0 146.0 146.0 147.0 146.0 147.0 146.0 07:37:03 INFO - PROCESS | 6988 | 07:37:03 INFO - PROCESS | 6988 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:37:03 INFO - PROCESS | 6988 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 07:37:03 INFO - PROCESS | 6988 | 07:37:03 INFO - PROCESS | 6988 | [#8] json-parse-financial Cycles:10 Average:66.00 Median:66.00 stddev:0.94 (1.4%) stddev-sans-first:1.00 07:37:03 INFO - PROCESS | 6988 | Values: 66.0 65.0 66.0 66.0 65.0 68.0 65.0 67.0 66.0 66.0 07:37:03 INFO - PROCESS | 6988 | 07:37:03 INFO - PROCESS | 6988 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 07:37:03 INFO - PROCESS | 6988 | Values: 65.0 66.0 65.0 65.0 65.0 65.0 66.0 65.0 65.0 65.0 07:37:03 INFO - PROCESS | 6988 | 07:37:03 INFO - PROCESS | 6988 | [#10] stanford-crypto-aes Cycles:10 Average:79.80 Median:80.50 stddev:2.39 (3.0%) stddev-sans-first:2.50 07:37:03 INFO - PROCESS | 6988 | Values: 81.0 84.0 77.0 77.0 82.0 78.0 78.0 79.0 80.0 82.0 07:37:03 INFO - PROCESS | 6988 | 07:37:03 INFO - PROCESS | 6988 | [#11] stanford-crypto-ccm Cycles:10 Average:141.10 Median:137.00 stddev:25.80 (18.8%) stddev-sans-first:27.34 07:37:03 INFO - PROCESS | 6988 | Values: 138.0 137.0 126.0 137.0 128.0 130.0 126.0 136.0 213.0 140.0 07:37:03 INFO - PROCESS | 6988 | 07:37:03 INFO - PROCESS | 6988 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.10 Median:163.00 stddev:2.33 (1.4%) stddev-sans-first:1.13 07:37:03 INFO - PROCESS | 6988 | Values: 169.0 164.0 161.0 164.0 163.0 161.0 162.0 162.0 162.0 163.0 07:37:03 INFO - PROCESS | 6988 | 07:37:03 INFO - PROCESS | 6988 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:1.51 (2.3%) stddev-sans-first:1.32 07:37:03 INFO - PROCESS | 6988 | Values: 68.0 66.0 65.0 66.0 67.0 65.0 63.0 65.0 64.0 67.0 07:37:03 INFO - PROCESS | 6988 | -------- Summary: end -------- 07:37:03 INFO - PROCESS | 6988 | 07:37:04 INFO - TEST-INFO | 6988: exit 0 07:37:05 INFO - TEST-OK | kraken | took 63192ms 07:37:05 INFO - SUITE-END | took 1182s 07:37:05 INFO - Completed test suite (00:19:42) 07:37:05 INFO - javascript benchmark 07:37:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2653.0846857834044, 2653.164253260224, 2675.3177939625393, 2683.798715096368, 2684.7046824849276, 4605.861824145281, 4622.482344685486, 4669.902572895367, 4689.2028355179655, 4758.191107511722, 4658.53414658534, 4687.554682305184, 4701.905961880769, 4712.458067322259, 4716.7641617919135, 4292.441982542266, 4310.935335969947, 4378.781060946956, 4393.560643935597, 4513.187626227278, 4461.665375096864, 4473.731576105428, 4481.260592002332, 4489.147062058199, 4529.071540334224, 4164.229617520768, 4198.181354635847, 4206.894827629303, 4236.936445953283, 4334.5882141196535, 4276.550962148992, 4287.035417031174, 4295.098029413795, 4307.5261721210645, 4364.629006534448, 4269.701120921537, 4314.029343397742, 4321.481422229321, 4326.437563116806, 4367.323064924942, 4597.471290801567, 4682.953170468286, 4707.811687532495, 4761.35721677576, 4765.69023013503, 5011.874703132451, 5016.122178618763, 5020.046191223656, 5089.3638295213095, 5093.439721630618, 5081.74591270435, 5091.287219789232, 5113.335266415379, 5116.437191908887, 5155.046316431472, 4562.247229207143, 4675.649326300541, 4808.663393562487, 4816.277558366273, 4821.2045012573235, 5090.618203634742, 5152.587792976553, 5175.870603234949, 5218.217267409919, 5222.3472065991755, 4917.7786999585105, 4971.801127954841, 4974.27872958419, 4976.0, 4976.751162441863, 4890.633202509826, 5004.749762511859, 5017.8243761468175, 5044.722540260247, 5106.234064890222, 4967.2549117631925, 4994.450610432849, 4995.900081998412, 4997.550220480101, 5028.069807085628, 4973.378327709036, 4983.451820299837, 5010.974945125324, 5026.2460630904925, 5029.371328583927, 4155.667546596265, 4192.203481338536, 4193.832246710159, 4243.087736136746, 4338.696291259645, 3706.425504046877, 3722.925541489155, 3758.4926034985474, 3775.3581891078584, 3776.6412190841825, 4326.0, 4426.26966550522, 4431.977840110843, 4456.264716321835, 4472.1502914446155, 5041.0422019816115, 5056.317397151411, 5058.064258112261, 5060.671056381397, 5098.107831129538, 4284.892877678083, 4331.826726930887, 4402.647788176938, 4407.118576284756, 4415.183191109655, 4550.067236216568, 4592.563706447882, 4599.379083823708, 4611.16998940194, 4616.515265897099, 4830.879228019257, 4838.225883858566, 4841.95158048415, 4851.296561998561, 4888.071266459361, 4980.825671101639, 5041.168207245763, 5101.642884998015, 5127.3847138343635, 5178.663386879992, 4687.039156972881, 4744.525547445366, 4753.47711751714, 4763.333133361263, 4763.928541071818, 4949.1586430306215, 4950.851474455772, 4953.603711702983, 4955.479674634112, 4988.6757360771435, 4869.513048695244, 4975.402951645826, 4998.900021999467, 5035.433246339112, 5072.619553533426, 4850.927236091391, 4881.438634557071, 4896.608271338213, 4910.680805747615, 4953.0, 4890.682105663121, 4892.461829198856, 4898.4121905371585, 4901.117798796251, 4926.556609905126, 4718.693284936468, 4823.131836269365, 4837.129316723023, 4877.707337559757, 4889.486603906681, 5008.449070602158, 5028.34631497903, 5029.321041659329, 5030.647854650139, 5058.671186372874, 4918.803247870045, 4923.261510773413, 4924.72913989734, 4932.950670493249, 4978.2034874419915], "value": 4640.446730216552, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.6124873837052, 575.6200907401117, 579.1688926390632, 579.9763417567993, 582.3972188784609, 27432.588511172347, 27917.0, 39301.21397572047, 40674.796626016825, 40943.0, 41951.0, 42284.36573451401, 42428.36357454633, 42429.15141697172, 42459.575404245945, 7887.763367098982, 8032.477888937229, 8035.316998055172, 8040.276375126237, 8047.0, 7933.841323173533, 8014.358851291911, 8026.317762990153, 8028.0, 8029.518228906255, 8021.558814265242, 8066.637001334925, 8068.919310806876, 8071.757847264592, 8073.596320183968, 7989.680412783482, 8029.116797152308, 8032.839343213162, 8036.357091432671, 8050.59747012647, 7863.842723145505, 7915.12933577306, 7923.207679232089, 7932.524048557105, 7934.246246606564, 39397.21205575901, 39853.60146398557, 39860.80069599633, 39978.200435991406, 40021.0, 2954.556816477524, 3005.383896301253, 3384.881529146468, 3787.791671458069, 3857.4406711027023, 27679.723202767917, 29810.0, 30028.399432011454, 30392.54411183834, 31243.531347029584, 3145.7289917319335, 3150.2596889730894, 3200.647928727838, 3229.5801545798895, 3237.53055806909, 257406.0, 258545.7072714643, 259682.0, 260635.0, 261069.0, 32332.83833580864, 53649.0, 55242.44757552454, 55331.44668553343, 55455.44544554583, 32421.675783241866, 34276.31447371088, 34329.537160169515, 34346.65653343485, 34363.65636343604, 13545.255010974492, 13710.314484275747, 13718.38267277975, 13729.176249425067, 13730.038897277094, 11189.0, 11216.439178041228, 11245.437728113562, 11250.268732532522, 11250.943745281222, 8065.274125328749, 8078.111407745143, 8087.069986951458, 8142.877856832152, 8148.877766833502, 3079.5380692896247, 3087.5368694695976, 3118.937621247562, 3156.542301366289, 3171.429142754326, 803.670495097019, 835.7868743470376, 854.3080105114877, 865.35098675993, 889.4574309671095, 27482.312942176606, 27588.44823103527, 27627.585586216224, 27914.302142446602, 28304.71695283062, 921.2675922641516, 953.4994128082812, 986.4229425785852, 1002.293383164867, 1003.7791685829106, 14577.198254096127, 14585.708285834224, 14699.11805291686, 14888.925555372154, 15092.0, 376727.0, 377692.0, 378176.0, 380576.0, 381139.0, 50263.74868125636, 50885.0, 50895.0, 50933.0, 50942.23586646203, 1054.6888667843004, 1155.607093588184, 1186.727052777866, 1189.3339729751367, 1214.611324376191, 28844.567331490463, 29895.850520747255, 29900.401991960473, 30502.0, 30589.847050764605, 52262.73868630632, 53842.57708403053, 53844.73077634587, 53862.0, 53988.730056349465, 329530.0, 336047.0, 336202.0, 336638.0, 337593.0, 32505.0, 37895.43156852705, 38654.80672596619, 39398.60601393949, 39726.2054758909, 39553.604463956144, 40803.59196407998, 43025.569744302156, 43150.35274470822, 43740.0, 35311.47032794459, 37003.44494832526, 37863.62136378711, 37895.0, 38622.0, 36597.817010914776, 37389.439158412104, 37473.437898431, 37640.62359376371, 38125.046873828374, 36166.09584760402, 36650.266994659425, 36863.81568092143, 37065.0, 37081.443778343884, 33186.672533098405, 33240.501392479615, 33558.49662255019, 33798.49302260517, 33824.0, 25526.23421297364, 25668.253205683715, 25706.485870282115, 25729.327593706348, 26119.0], "value": 16956.779502945963, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.3850741947883, 360.9368360536906, 361.19273423897585, 365.70926113739574, 379.63175719552027, 16610.41863534775, 17372.65254694907, 18132.36536721215, 18144.274229030856, 18147.99999999998, 16977.66044679106, 17968.82031179691, 18313.81686183138, 18338.724919126224, 18342.0, 5032.245163225509, 5244.895102097975, 5267.789288428458, 5281.049411106, 5283.656562323456, 3788.5264341957254, 3902.746321489108, 3932.075962148893, 5193.558547523465, 6130.693465326716, 6185.721642526075, 6201.906971395432, 6209.0, 6212.844678883019, 6213.2233470816145, 5896.086106653475, 6087.026075827846, 6088.056351265516, 6176.876462470748, 6179.845503862417, 5305.920411193835, 5308.5487733542695, 5312.92030619541, 5328.413874473805, 5329.706866122362, 21298.893505532527, 22311.553768924692, 22438.88780556103, 22638.20766273189, 22669.2065777697, 1844.004237711634, 1995.8702684325472, 2083.7186979757844, 2137.3801597536694, 2225.7329120505483, 13207.339633018311, 13531.03799949002, 13536.796948045787, 13610.387532561059, 14358.353874075692, 1712.6403455274408, 1835.2567210279858, 1841.0, 1856.916438760259, 1862.3854128137682, 67335.0, 67492.98760518646, 67847.66076169637, 68427.31572684259, 68655.65672171608, 9268.304877134242, 9480.810383792286, 9575.904240957641, 9701.805963880824, 9808.46053467052, 12612.432440540199, 12659.430325635369, 12683.302418367079, 12684.746305073846, 12708.682282942815, 7506.924930750732, 7541.35898448627, 7558.848823023509, 7683.807904802425, 7743.148253692089, 7618.0, 7631.3894888408795, 7652.349550288177, 7791.649375778104, 7820.0, 5946.4648181663, 6167.568270221132, 6237.376262373727, 6237.812865614039, 6266.874662506724, 1660.7924009498813, 1663.1102360237458, 1690.7319510367224, 1697.4822679082997, 1700.7278835386278, 840.8402403543307, 842.8440738463404, 851.6933903794629, 893.946363218209, 898.4160295807777, 17580.296788128588, 17881.0, 17994.0, 18308.176132073822, 18346.357877474224, 813.556611646654, 863.2532859076854, 868.8175483148609, 881.3213825354442, 894.9910500895038, 9458.196053335407, 9473.384230025027, 9658.420494770337, 9895.0, 10070.04334588213, 375795.0, 380500.0, 412674.0, 415334.0, 415446.0, 81369.18630813734, 82661.58669206615, 85127.99999999876, 85183.0, 85183.14816851752, 951.8001219743793, 966.5408930757834, 966.7389804752537, 983.041534503853, 984.9015098490237, 15427.922860386076, 15573.532794016197, 15687.764683529984, 15801.920990394974, 16091.597710057342, 37720.2455950874, 38412.03969900775, 38911.80544097262, 39507.61723339669, 39602.801985989885, 55763.721181393834, 56859.71570142123, 56968.0, 58024.4197558019, 58265.70867145637, 7543.47195696296, 7923.762287131395, 8044.959775201321, 8161.714339998071, 8349.37379696513, 12103.33431661267, 12166.452509637265, 12362.505499779909, 12566.937165314115, 12748.298843563321, 10788.244822862638, 10918.508667110158, 11153.672713938178, 11183.72040698989, 11188.608398706006, 10678.8932110681, 10808.297460665031, 10963.451827408438, 11062.280951738112, 11085.390303533382, 10472.842907356548, 11108.944455277671, 11141.888581114084, 11202.495887685236, 11375.374354410587, 7487.176410594721, 7766.339861111869, 7988.960055199919, 8229.711960081368, 8517.403781735218, 7900.762977110466, 10649.574017039542, 11007.834882476609, 11055.336679799238, 11407.315561066363], "value": 8642.545614758184, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1275.0755702115973, 1365.5834970334047, 1382.232860762277, 1443.6607397261648, 1700.9319627214904, 6775.424088952439, 7696.846063078742, 7962.6814927402975, 7969.123396426388, 8177.141400152973, 7896.526208427498, 8053.637586308616, 8062.274395304421, 8066.395020373481, 8069.838603227947, 2201.6147174244484, 2227.654713519399, 2230.4981379189635, 2231.0518029837253, 2232.430730163814, 2181.5964046651343, 2210.7568167501563, 2232.754397016327, 2248.2243625949022, 2249.1790496468752, 2214.8892555372167, 2244.876531790751, 2251.167068184774, 2252.538229662915, 2257.3340864445026, 2153.095699806085, 2170.772068932763, 2176.7823217678106, 2177.1617927098023, 2180.1061564758375, 2180.7819218078225, 2187.3547303545333, 2189.5073608437974, 2189.6824960380814, 2190.145843121184, 7894.486858354188, 8109.107998120202, 8166.550839703814, 8167.754967350929, 8169.877451838227, 4739.857804265843, 4832.565069143759, 4853.611711063107, 4857.878553036202, 4859.562639362474, 2800.061979236958, 2858.4854726149283, 2903.4483448144783, 2904.404597057598, 2916.329244273829, 903.1645727701849, 917.3028498341242, 925.6343744220995, 925.6436272035315, 938.9201917836924, 10673.839892401542, 10728.463576821128, 10768.138548916068, 10786.191035672357, 10788.622398216025, 3890.124721937598, 3967.1668949520345, 4108.157827645386, 4162.084341444877, 4171.144915292358, 8512.148785121562, 8549.658013679507, 8576.614052367659, 8592.44149130317, 8597.699080532151, 4661.044485880387, 4661.091087237956, 4669.766511674403, 4673.112108699336, 4673.462551806518, 3645.453182022718, 3854.9036274093373, 3948.269570129478, 4351.0645211279725, 4351.282038463618, 3480.756347055682, 3586.228960773394, 3608.0619039050034, 3656.652618001339, 3662.08447888028, 1065.174489770434, 1075.9623413180502, 1077.9137668986461, 1078.983815242772, 1092.1644941619668, 720.6865013719049, 813.1705660226536, 815.5432957543676, 818.1205204405288, 841.2218697704722, 4882.292067650171, 4971.1797553403285, 5126.666766660155, 5137.51193636604, 5286.418493965661, 402.8799936177373, 408.5710004495268, 418.11359916976204, 418.6901692747345, 423.8389412023473, 3664.2671465706967, 3701.592824789271, 3945.881623551298, 4005.098852758106, 4051.473308469939, 9545.570449329796, 10131.696049118538, 10148.543315550818, 10153.340032897986, 10174.236932230113, 9785.657501987396, 9944.850827237597, 10055.497225138713, 10064.69805905824, 10086.24353173515, 7329.816754581071, 7428.1086269647985, 7497.0, 7507.7747667568965, 7527.8118047049265, 5379.973100134631, 5481.561475082063, 5559.082751345983, 5644.125160600113, 5654.632448890973, 8896.0, 8923.330750193632, 8948.552572371485, 8951.239144672516, 9054.411463254868, 8050.798730031796, 8558.914410855812, 8986.68546600866, 9205.493697846416, 9226.861597075915, 6564.310747371457, 6787.490938179755, 6790.830229244309, 6792.72829086831, 6959.130108736408, 7555.395568354408, 7643.541387516767, 7698.730544430918, 7702.730404435818, 7748.1864404238995, 6743.2582415935185, 6753.3921947025, 6904.4131248844415, 7062.646867656699, 7079.752208672672, 6732.225794033553, 6742.730290788313, 6791.0832037676255, 6873.759418420332, 7096.53872498286, 6548.47612191014, 6585.275619681735, 6590.044443555754, 6614.702338394687, 6614.933850661624, 4699.671023028355, 4884.3650325457465, 4887.706737595756, 4910.631702622246, 4930.753462326941, 4856.955754512655, 4859.07677541266, 4878.756062196805, 4893.877653058702, 4920.384951881015], "value": 4094.5329815237533, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.4329773430483, 301.22134282878756, 307.2641024745734, 309.9287163952291, 310.793322440577, 4828.348172996644, 4831.613470922327, 4833.0, 4848.248521479172, 4887.560119589236, 4756.857294281169, 4802.543758342952, 4806.423229212491, 4806.927896081562, 4818.614510839133, 3599.154198763295, 3720.851165953372, 3728.738988270822, 3729.720270979674, 3737.4020156774923, 3650.8539658413633, 3735.0, 3787.5644300905337, 3827.483289755889, 3838.483798899433, 3727.3104475671953, 3787.261484010619, 3788.223414200096, 3809.3904975203973, 3814.542254929412, 3559.2703495783303, 3756.4365345198166, 3786.110264087937, 3802.581716011223, 3803.1442925341576, 3252.593425821772, 3264.7551433642334, 3276.9016929492154, 3280.2455435249785, 3292.2098696312714, 4665.230237010889, 4672.925227197764, 4673.205555055615, 4676.649251306131, 4699.624030077585, 4084.693647976384, 4233.449651545279, 4242.745435273893, 4259.275923093051, 4278.72188307759, 4981.128302547076, 4981.178105612569, 5005.799768009275, 5010.849674509771, 5024.296598476216, 3570.107473131717, 3573.857045718168, 3575.856965721368, 3580.7314451416246, 3585.9779962710504, 5113.616478764107, 5197.454267301917, 5227.581793456515, 5250.789968401259, 5271.789128434858, 3612.7600887449425, 3621.3843646580144, 3629.8366573504254, 3634.9818250908575, 3645.908852278714, 3672.3940549809518, 3679.632036796299, 3682.85678611562, 3688.8524459021874, 3689.262147570497, 4219.6580897602125, 4232.957670423318, 4233.618974292329, 4235.797385359596, 4239.97880010598, 4831.637627177975, 4970.527799859007, 4974.801007959713, 4983.327250821165, 4987.852793857433, 1262.6464589914838, 1269.8666640002666, 1278.4566559212299, 1278.4822147030468, 1279.814426908093, 801.8596745569502, 822.6791551294999, 826.3595713322103, 841.7811369044092, 845.9492430454193, 4380.890477738082, 4471.0, 4490.236659767782, 4525.298578720303, 4537.3438694876795, 5165.380154381498, 5170.759017835692, 5213.165893457029, 5231.921521177185, 5233.816816411483, 4504.25679762842, 4506.3916371290115, 4531.0, 4536.909261814745, 4567.520410356931, 2592.844429334246, 2747.244507760342, 2751.9449611008067, 2753.4217814258827, 2768.335599456156, 4894.926576101361, 4897.184119131513, 4905.6811307265625, 4939.925901111486, 4954.157793175097, 5033.79864805411, 5291.947080529146, 5292.708901010481, 5302.522772950453, 5321.521063104339, 4906.681065730716, 4928.137575924199, 4930.876728081683, 4945.752712364368, 4953.563466594647, 5192.896142077062, 5196.662216955886, 5197.610179236497, 5202.944836789523, 5250.527452529291, 4844.8304309349005, 5081.644284900021, 5142.382914050338, 5147.0, 5147.202183661539, 4922.630802689884, 4922.923173016865, 4927.260910863399, 4930.383702037246, 4935.531124543163, 3671.6144804795113, 3685.631436856293, 3715.9442608360355, 3718.0890681783135, 3719.6094410086553, 5085.288059671723, 5182.6890386575415, 5223.4515375884985, 5233.162693968947, 5235.3038185335345, 4996.450390456974, 5013.573846223112, 5018.347614810052, 5018.544622059562, 5028.421731500925, 5025.773840177128, 5030.547250747451, 5084.618653600921, 5091.8939446938075, 5095.87260318495, 4877.244027175793, 4910.9017819642695, 5002.52476014778, 5011.273365362075, 5020.623453240948, 4861.368022157097, 4942.357493525818, 5036.118679231193, 5066.36670416198, 5086.415062267886, 4951.678140920829, 4952.331435256195, 4952.331435256195, 4965.0318187953, 4967.726775027409], "value": 3795.984547037869, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.6574718157831, 667.5427332277391, 687.9243283238843, 713.9229919048896, 735.5439627430993, 12158.452869620865, 12578.371081445937, 12597.055220858427, 12604.873951260484, 12628.810567841467, 13171.73656526869, 13404.597862064154, 13422.328883555807, 13424.597262082129, 13444.462221511152, 624.319491753988, 765.720512013114, 782.8512582609286, 796.2236819101388, 798.9520628762264, 788.3929374381722, 791.4657606115877, 793.4445887878479, 794.0, 794.1938931984041, 843.472829481574, 844.2654890245495, 844.8268105038452, 844.907060223375, 845.045099038086, 647.4852492268634, 792.7582087463321, 825.5005721538503, 827.1356432527963, 831.2145022953281, 604.6795198544778, 607.7599348257413, 609.2445367743966, 609.2901769438598, 609.6921054867264, 12204.389780510939, 12224.327661978588, 12258.0, 12281.877181228252, 12285.324307163102, 12367.938160309232, 12856.550020749322, 12910.548130815376, 12935.935320323339, 12980.221186728731, 10987.175961802817, 11106.61126860556, 11315.0, 11575.479103440366, 11700.239484433485, 4071.4096456013713, 4104.440610063274, 4118.4440100586635, 4172.645325147336, 4295.183915056161, 58405.12392314161, 58960.410395895924, 59290.0, 59346.70326648339, 59361.703191483764, 9257.166854983085, 9501.572429240701, 9559.522023898777, 9570.425774453415, 9571.090746379083, 18261.269549217883, 18432.07839608041, 18521.53696157607, 18528.814711852978, 18531.629367412577, 6563.278039415661, 6651.933480665228, 6834.555753875982, 6875.621840798704, 6931.584104953719, 3638.69071128957, 3661.885266215277, 3687.985654512894, 3691.686206672463, 3708.35103856824, 2798.5102607043686, 2884.22126025976, 2897.435000174946, 2899.420115976813, 2903.3177203357195, 372.4878292348021, 466.2609763524851, 469.0525139218759, 484.46224690593414, 484.8569671946784, 443.68276682172404, 488.8020351757544, 516.1818517649567, 522.8353068783321, 523.1733860500476, 7640.656170472342, 7844.0, 7860.764177074697, 7861.724839630586, 8238.588070596446, 492.9088118698052, 518.2019689677854, 523.254362533396, 526.2789977730457, 534.6311045378754, 3535.5934067582043, 3725.8509659613856, 3746.2507498499863, 3778.7165962552917, 3781.205946751158, 76918.6154069226, 78861.60569197117, 79874.0, 88381.55809220913, 97560.51219743855, 85458.57270713606, 86995.0, 87331.0, 88437.0, 89185.55407222922, 20177.0, 21826.781732182793, 28259.434811303658, 74222.6288868563, 79995.60002199952, 8527.14728527167, 8537.359698022798, 8719.476831390137, 8977.955110224408, 9080.228180604723, 31828.0, 37933.620663794114, 45009.0, 48105.0, 49218.75390623167, 64097.0, 68604.6569767148, 69521.0, 69522.30477695158, 72246.63876680583, 11100.833487497855, 11262.718432038937, 11289.943550282525, 11364.318140911571, 11897.345645989553, 12404.751904962031, 12441.502339906303, 12515.874841251834, 12616.684582885502, 12741.235525868478, 11526.553941414517, 12067.818982715442, 12144.39278036077, 12502.93748531288, 12544.310062946626, 11783.76432471363, 12281.631551053482, 12377.62867113988, 12377.876221238033, 12397.442115105023, 11032.944835275772, 11628.895254950767, 11761.647150585497, 11872.347020913587, 11922.046236300901, 10086.596536138766, 10143.289969702346, 10143.78274607052, 10436.0, 10458.895411046096, 9867.851982220129, 10084.294099412971, 10353.844692329772, 10539.314944528582, 10665.626703065665], "value": 6418.282720757015, "unit": "score"}], "name": "dromaeo_css", "value": 6386.413138015471, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 114.0, 114.0, 112.0, 112.0, 114.0, 111.0, 112.0, 113.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 120.0, 124.0, 177.0, 122.0, 123.0, 151.0, 122.0, 168.0, 124.0], "value": 138.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 162.0, 160.0, 162.0, 162.0, 162.0, 162.0, 163.0, 161.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 101.0, 75.0, 76.0, 75.0, 75.0, 100.0, 76.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 117.0, 86.0, 85.0, 86.0, 116.0, 87.0, 86.0, 120.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 66.0, 65.0, 68.0, 65.0, 67.0, 66.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 84.0, 77.0, 77.0, 82.0, 78.0, 78.0, 79.0, 80.0, 82.0], "value": 79.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 137.0, 126.0, 137.0, 128.0, 130.0, 126.0, 136.0, 213.0, 140.0], "value": 141.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 164.0, 161.0, 164.0, 163.0, 161.0, 162.0, 162.0, 162.0, 163.0], "value": 163.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 65.0, 66.0, 67.0, 65.0, 63.0, 65.0, 64.0, 67.0], "value": 65.6, "unit": "score"}], "name": "kraken", "value": 1527.0999999999997, "alertThreshold": 2.0}]} 07:37:05 INFO - Return code: 0 07:37:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:37:05 INFO - # TBPL SUCCESS # 07:37:05 INFO - Running post-action listener: _resource_record_post_action 07:37:05 INFO - ##### 07:37:05 INFO - ##### Finished run-tests step (success) 07:37:05 INFO - ##### 07:37:05 INFO - Running post-run listener: _resource_record_post_run 07:37:05 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 618496; Write bytes: 291172352; Read time: 84; Write time: 191188 07:37:05 INFO - TinderboxPrint: CPU usage
12.9% 07:37:05 INFO - TinderboxPrint: I/O read bytes / time
618,496 / 84 07:37:05 INFO - TinderboxPrint: I/O write bytes / time
291,172,352 / 191,188 07:37:05 INFO - TinderboxPrint: CPU idle
8,332.4 (87.1%) 07:37:05 INFO - TinderboxPrint: CPU user
1,198.7 (12.5%) 07:37:05 INFO - TinderboxPrint: Swap in / out
0 / 0 07:37:05 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 1150976; Read time: 0; Write time: 64 07:37:05 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 614400; Write bytes: 290021376; Read time: 68; Write time: 191124 07:37:05 INFO - Running post-run listener: _upload_blobber_files 07:37:05 INFO - Blob upload gear active. 07:37:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:37:05 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:37:05 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:37:05 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:37:06 INFO - (blobuploader) - INFO - Open directory for files ... 07:37:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:37:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:37:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:37:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:37:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:37:11 INFO - (blobuploader) - INFO - Done attempting. 07:37:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:37:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:37:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:37:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:37:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:37:11 INFO - (blobuploader) - INFO - Done attempting. 07:37:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:37:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:37:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:37:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:37:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:37:12 INFO - (blobuploader) - INFO - Done attempting. 07:37:12 INFO - (blobuploader) - INFO - Iteration through files over. 07:37:12 INFO - Return code: 0 07:37:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:37:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:37:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7a3aa9f5edc6313c234a529a0d36443e30e62d4baa1e2cfb1b355362cdabef3540ea5f3e551c03b7cd914ab3f09d535a7c1456886313f38455c7dfd6be867fd1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9d6e003ebd9c73697dce08dd790a24552b3eba625920920b28af524b60986c75604fc99dba26190f7e7e1fa2912a28623c50b103859c20a139f206d01010c2c0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ce12a0440b043d33dc696afde23791d07645bcffff9a5cc82a7df16327f659f1dfa2ffdc3e44009af0672b275effc7a74209daad28d5a6e0b901fa9b19876df0"} 07:37:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:37:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:37:12 INFO - Contents: 07:37:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7a3aa9f5edc6313c234a529a0d36443e30e62d4baa1e2cfb1b355362cdabef3540ea5f3e551c03b7cd914ab3f09d535a7c1456886313f38455c7dfd6be867fd1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9d6e003ebd9c73697dce08dd790a24552b3eba625920920b28af524b60986c75604fc99dba26190f7e7e1fa2912a28623c50b103859c20a139f206d01010c2c0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ce12a0440b043d33dc696afde23791d07645bcffff9a5cc82a7df16327f659f1dfa2ffdc3e44009af0672b275effc7a74209daad28d5a6e0b901fa9b19876df0"} 07:37:12 INFO - Running post-run listener: copy_logs_to_upload_dir 07:37:12 INFO - Copying logs to upload dir... 07:37:12 INFO - mkdir: /builds/slave/test/build/upload/logs 07:37:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.213587 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-14 07:37:12.771023) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 07:37:12.774551) ========= 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=20e666a3d4cfbb71505a330e000001b4-1468505792.906124-411778537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7a3aa9f5edc6313c234a529a0d36443e30e62d4baa1e2cfb1b355362cdabef3540ea5f3e551c03b7cd914ab3f09d535a7c1456886313f38455c7dfd6be867fd1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9d6e003ebd9c73697dce08dd790a24552b3eba625920920b28af524b60986c75604fc99dba26190f7e7e1fa2912a28623c50b103859c20a139f206d01010c2c0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ce12a0440b043d33dc696afde23791d07645bcffff9a5cc82a7df16327f659f1dfa2ffdc3e44009af0672b275effc7a74209daad28d5a6e0b901fa9b19876df0"} build_url:https://queue.taskcluster.net/v1/task/IK-HY0PhQNSg4Zd-3dypZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011349 build_url: 'https://queue.taskcluster.net/v1/task/IK-HY0PhQNSg4Zd-3dypZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7a3aa9f5edc6313c234a529a0d36443e30e62d4baa1e2cfb1b355362cdabef3540ea5f3e551c03b7cd914ab3f09d535a7c1456886313f38455c7dfd6be867fd1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9d6e003ebd9c73697dce08dd790a24552b3eba625920920b28af524b60986c75604fc99dba26190f7e7e1fa2912a28623c50b103859c20a139f206d01010c2c0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ce12a0440b043d33dc696afde23791d07645bcffff9a5cc82a7df16327f659f1dfa2ffdc3e44009af0672b275effc7a74209daad28d5a6e0b901fa9b19876df0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 07:37:12.803080) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 07:37:12.803405) ========= 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=20e666a3d4cfbb71505a330e000001b4-1468505792.906124-411778537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004430 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 07:37:12.888233) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 07:37:12.888674) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 07:37:12.889722) ========= ========= Total master_lag: 0.18 =========