builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-027 starttime: 1468669140.5 results: success (0) buildid: 20160716041051 builduid: 96a31fedca3d42c4b065d0ed9f3cf80e revision: 98e3e1a81859a64dfa625d1d40d3d0043a46941c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 04:39:00.499878) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 04:39:00.500365) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-16 04:39:00.500649) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-16 04:39:00.516087) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 04:39:00.516477) ========= 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=1f5564757af27664ca02d71f000001b0-1468669012.189267-1996861812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-16 04:39:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.6M=0s 2016-07-16 04:39:00 (50.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086396 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 04:39:00.616916) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 04:39:00.617244) ========= 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=1f5564757af27664ca02d71f000001b0-1468669012.189267-1996861812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020439 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 04:39:00.666135) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 04:39:00.666571) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 98e3e1a81859a64dfa625d1d40d3d0043a46941c --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 98e3e1a81859a64dfa625d1d40d3d0043a46941c --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=1f5564757af27664ca02d71f000001b0-1468669012.189267-1996861812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-16 04:39:00,849 truncating revision to first 12 chars 2016-07-16 04:39:00,849 Setting DEBUG logging. 2016-07-16 04:39:00,849 attempt 1/10 2016-07-16 04:39:00,849 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/98e3e1a81859?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-16 04:39:01,181 unpacking tar archive at: fx-team-98e3e1a81859/testing/mozharness/ program finished with exit code 0 elapsedTime=0.743149 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 04:39:01.423318) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 04:39:01.423667) ========= script_repo_revision: 98e3e1a81859a64dfa625d1d40d3d0043a46941c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 04:39:01.424053) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 04:39:01.424322) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 04:39:01.434359) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-07-16 04:39:01.434664) ========= /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=1f5564757af27664ca02d71f000001b0-1468669012.189267-1996861812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:39:01 INFO - MultiFileLogger online at 20160716 04:39:01 in /builds/slave/test 04:39:01 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 04:39:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:39:01 INFO - {'append_to_log': False, 04:39:01 INFO - 'base_work_dir': '/builds/slave/test', 04:39:01 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:39:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:39:01 INFO - 'branch': 'Fx-Team-Non-PGO', 04:39:01 INFO - 'buildbot_json_path': 'buildprops.json', 04:39:01 INFO - 'config_files': ('talos/linux_config.py',), 04:39:01 INFO - 'default_actions': ('clobber', 04:39:01 INFO - 'read-buildbot-config', 04:39:01 INFO - 'download-and-extract', 04:39:01 INFO - 'populate-webroot', 04:39:01 INFO - 'create-virtualenv', 04:39:01 INFO - 'install', 04:39:01 INFO - 'run-tests'), 04:39:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:39:01 INFO - 'download_minidump_stackwalk': True, 04:39:01 INFO - 'download_symbols': 'ondemand', 04:39:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:39:01 INFO - 'tooltool.py': '/tools/tooltool.py', 04:39:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:39:01 INFO - '/tools/misc-python/virtualenv.py')}, 04:39:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:39:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:39:01 INFO - 'installer_path': 'installer.exe', 04:39:01 INFO - 'log_level': 'info', 04:39:01 INFO - 'log_name': 'talos', 04:39:01 INFO - 'log_to_console': True, 04:39:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:39:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:39:01 INFO - 'opt_config_files': (), 04:39:01 INFO - 'pip_index': False, 04:39:01 INFO - 'sps_profile': False, 04:39:01 INFO - 'sps_profile_interval': 0, 04:39:01 INFO - 'suite': 'dromaeojs', 04:39:01 INFO - 'system_bits': '32', 04:39:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:39:01 INFO - 'title': 'talos-linux64-ix-027', 04:39:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:39:01 INFO - 'use_talos_json': True, 04:39:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:39:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:39:01 INFO - 'work_dir': 'build'} 04:39:01 INFO - ##### 04:39:01 INFO - ##### Running clobber step. 04:39:01 INFO - ##### 04:39:01 INFO - Running pre-action listener: _resource_record_pre_action 04:39:01 INFO - Running main action method: clobber 04:39:01 INFO - rmtree: /builds/slave/test/build 04:39:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:39:02 INFO - Running post-action listener: _resource_record_post_action 04:39:02 INFO - ##### 04:39:02 INFO - ##### Finished clobber step (success) 04:39:02 INFO - ##### 04:39:02 INFO - ##### 04:39:02 INFO - ##### Running read-buildbot-config step. 04:39:02 INFO - ##### 04:39:02 INFO - Running pre-action listener: _resource_record_pre_action 04:39:02 INFO - Running main action method: read_buildbot_config 04:39:02 INFO - Using buildbot properties: 04:39:02 INFO - { 04:39:02 INFO - "project": "", 04:39:02 INFO - "product": "firefox", 04:39:02 INFO - "script_repo_revision": "production", 04:39:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:39:02 INFO - "repository": "", 04:39:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:39:02 INFO - "buildid": "20160716041051", 04:39:02 INFO - "pgo_build": "False", 04:39:02 INFO - "basedir": "/builds/slave/test", 04:39:02 INFO - "buildnumber": 3167, 04:39:02 INFO - "slavename": "talos-linux64-ix-027", 04:39:02 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:39:02 INFO - "platform": "ubuntu64_hw", 04:39:02 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:39:02 INFO - "branch": "fx-team", 04:39:02 INFO - "repo_path": "integration/fx-team", 04:39:02 INFO - "revision": "98e3e1a81859a64dfa625d1d40d3d0043a46941c", 04:39:02 INFO - "stage_platform": "linux64", 04:39:02 INFO - "builduid": "96a31fedca3d42c4b065d0ed9f3cf80e", 04:39:02 INFO - "slavebuilddir": "test" 04:39:02 INFO - } 04:39:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/YhPIAQ-ZQoixyf7H4MRFUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:39:02 INFO - Running post-action listener: _resource_record_post_action 04:39:02 INFO - ##### 04:39:02 INFO - ##### Finished read-buildbot-config step (success) 04:39:02 INFO - ##### 04:39:02 INFO - ##### 04:39:02 INFO - ##### Running download-and-extract step. 04:39:02 INFO - ##### 04:39:02 INFO - Running pre-action listener: _resource_record_pre_action 04:39:02 INFO - Running main action method: download_and_extract 04:39:02 INFO - mkdir: /builds/slave/test/build/tests 04:39:02 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')]} 04:39:02 INFO - https://queue.taskcluster.net/v1/task/YhPIAQ-ZQoixyf7H4MRFUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:39:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhPIAQ-ZQoixyf7H4MRFUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:39:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhPIAQ-ZQoixyf7H4MRFUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:39:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhPIAQ-ZQoixyf7H4MRFUQ/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 04:39:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhPIAQ-ZQoixyf7H4MRFUQ/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 04:39:04 INFO - Downloaded 1361 bytes. 04:39:04 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:39:04 INFO - Using the following test package requirements: 04:39:04 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:39:04 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:39:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:39:04 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:39:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:39:04 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:39:04 INFO - u'jsshell-linux-x86_64.zip'], 04:39:04 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:39:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:39:04 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:39:04 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:39:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:39:04 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:39:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:39:04 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:39:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:39:04 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:39:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:39:04 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:39:04 INFO - https://queue.taskcluster.net/v1/task/YhPIAQ-ZQoixyf7H4MRFUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:39:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhPIAQ-ZQoixyf7H4MRFUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:39:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhPIAQ-ZQoixyf7H4MRFUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:39:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhPIAQ-ZQoixyf7H4MRFUQ/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 04:39:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhPIAQ-ZQoixyf7H4MRFUQ/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 04:39:06 INFO - Downloaded 22757638 bytes. 04:39:06 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'] 04:39:06 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 04:39:07 INFO - Return code: 0 04:39:07 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 04:39:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:39:07 INFO - https://queue.taskcluster.net/v1/task/YhPIAQ-ZQoixyf7H4MRFUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:39:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhPIAQ-ZQoixyf7H4MRFUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:39:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhPIAQ-ZQoixyf7H4MRFUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:39:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhPIAQ-ZQoixyf7H4MRFUQ/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 04:39:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhPIAQ-ZQoixyf7H4MRFUQ/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 04:39:15 INFO - Downloaded 22757638 bytes. 04:39:15 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'] 04:39:15 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 04:39:16 INFO - Return code: 0 04:39:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:39:16 INFO - https://queue.taskcluster.net/v1/task/YhPIAQ-ZQoixyf7H4MRFUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:39:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhPIAQ-ZQoixyf7H4MRFUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:39:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhPIAQ-ZQoixyf7H4MRFUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:39:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhPIAQ-ZQoixyf7H4MRFUQ/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 04:39:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhPIAQ-ZQoixyf7H4MRFUQ/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 04:39:17 INFO - Downloaded 14403317 bytes. 04:39:17 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'] 04:39:17 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 04:39:17 INFO - Return code: 0 04:39:17 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')]} 04:39:17 INFO - https://queue.taskcluster.net/v1/task/YhPIAQ-ZQoixyf7H4MRFUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:39:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhPIAQ-ZQoixyf7H4MRFUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:39:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhPIAQ-ZQoixyf7H4MRFUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:39:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhPIAQ-ZQoixyf7H4MRFUQ/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 04:39:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhPIAQ-ZQoixyf7H4MRFUQ/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 04:39:19 INFO - Downloaded 57074829 bytes. 04:39:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YhPIAQ-ZQoixyf7H4MRFUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:39:19 INFO - mkdir: /builds/slave/test/properties 04:39:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:39:19 INFO - Writing to file /builds/slave/test/properties/build_url 04:39:19 INFO - Contents: 04:39:19 INFO - build_url:https://queue.taskcluster.net/v1/task/YhPIAQ-ZQoixyf7H4MRFUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:39:19 INFO - Running post-action listener: _resource_record_post_action 04:39:19 INFO - Running post-action listener: set_extra_try_arguments 04:39:19 INFO - ##### 04:39:19 INFO - ##### Finished download-and-extract step (success) 04:39:19 INFO - ##### 04:39:19 INFO - ##### 04:39:19 INFO - ##### Running populate-webroot step. 04:39:19 INFO - ##### 04:39:19 INFO - Running pre-action listener: _resource_record_pre_action 04:39:19 INFO - Running main action method: populate_webroot 04:39:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:39:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:39:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:39:19 INFO - '--tppagecycles', 04:39:19 INFO - '7'], 04:39:19 INFO - 'tests': ['tsvgm']}}, 04:39:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:39:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:39:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:39:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:39:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:39:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:39:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:19 INFO - 'talos_options': ['--disable-e10s'], 04:39:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:39:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:39:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:19 INFO - 'talos_options': ['--disable-e10s'], 04:39:19 INFO - 'tests': ['damp', 'tps']}, 04:39:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:19 INFO - 'tests': ['damp', 'tps']}, 04:39:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:39:19 INFO - 'tests': ['dromaeo_dom']}, 04:39:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:39:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:39:19 INFO - 'tests': ['basic_compositor_video']}, 04:39:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:39:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:39:19 INFO - 'tests': ['a11yr', 04:39:19 INFO - 'ts_paint', 04:39:19 INFO - 'tpaint', 04:39:19 INFO - 'sessionrestore', 04:39:19 INFO - 'sessionrestore_no_auto_restore', 04:39:19 INFO - 'tabpaint']}, 04:39:19 INFO - 'other-e10s': {'tests': ['a11yr', 04:39:19 INFO - 'ts_paint', 04:39:19 INFO - 'tpaint', 04:39:19 INFO - 'sessionrestore', 04:39:19 INFO - 'sessionrestore_no_auto_restore', 04:39:19 INFO - 'tabpaint']}, 04:39:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:39:19 INFO - 'ts_paint', 04:39:19 INFO - 'tpaint', 04:39:19 INFO - 'sessionrestore', 04:39:19 INFO - 'sessionrestore_no_auto_restore', 04:39:19 INFO - 'tabpaint']}, 04:39:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:39:19 INFO - 'ts_paint', 04:39:19 INFO - 'tpaint', 04:39:19 INFO - 'sessionrestore', 04:39:19 INFO - 'sessionrestore_no_auto_restore', 04:39:19 INFO - 'tabpaint']}, 04:39:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:39:19 INFO - 'tests': ['a11yr', 04:39:19 INFO - 'ts_paint', 04:39:19 INFO - 'tpaint', 04:39:19 INFO - 'sessionrestore', 04:39:19 INFO - 'sessionrestore_no_auto_restore', 04:39:19 INFO - 'tabpaint']}, 04:39:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:39:19 INFO - 'tests': ['a11yr', 04:39:19 INFO - 'ts_paint', 04:39:19 INFO - 'tpaint', 04:39:19 INFO - 'sessionrestore', 04:39:19 INFO - 'sessionrestore_no_auto_restore', 04:39:19 INFO - 'tabpaint']}, 04:39:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:39:19 INFO - 'tests': ['tsvgx', 04:39:19 INFO - 'tsvgr_opacity', 04:39:19 INFO - 'tart', 04:39:19 INFO - 'tscrollx', 04:39:19 INFO - 'cart']}, 04:39:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:39:19 INFO - 'tsvgr_opacity', 04:39:19 INFO - 'tart', 04:39:19 INFO - 'tscrollx', 04:39:19 INFO - 'cart']}, 04:39:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:19 INFO - 'talos_options': ['--disable-e10s'], 04:39:19 INFO - 'tests': ['tp5o']}, 04:39:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:19 INFO - 'tests': ['tp5o']}, 04:39:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:19 INFO - 'talos_options': ['--disable-e10s', 04:39:19 INFO - '--xperf_path', 04:39:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:39:19 INFO - 'tests': ['tp5n']}, 04:39:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:19 INFO - 'talos_options': ['--xperf_path', 04:39:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:39:19 INFO - 'tests': ['tp5n']}}, 04:39:19 INFO - 'talos.zip': {'path': '', 04:39:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:39:19 INFO - Running post-action listener: _resource_record_post_action 04:39:19 INFO - ##### 04:39:19 INFO - ##### Finished populate-webroot step (success) 04:39:19 INFO - ##### 04:39:19 INFO - ##### 04:39:19 INFO - ##### Running create-virtualenv step. 04:39:19 INFO - ##### 04:39:19 INFO - Running pre-action listener: _resource_record_pre_action 04:39:19 INFO - Running main action method: create_virtualenv 04:39:19 INFO - Creating virtualenv /builds/slave/test/build/venv 04:39:19 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 04:39:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:39:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:39:19 INFO - Using real prefix '/usr' 04:39:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:39:20 INFO - Installing distribute.............................................................................................................................................................................................done. 04:39:22 INFO - Installing pip.................done. 04:39:22 INFO - Return code: 0 04:39:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:39: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')]} 04:39:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39: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')]} 04:39:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:22 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 0x1cfa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb93b0>, '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 0x1fba2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fba740>, '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': '1f5564757af27664ca02d71f000001b0-1468669012.189267-1996861812', '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 04:39:22 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 04:39:22 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 04:39:22 INFO - Using env: {'DISPLAY': ':0', 04:39:22 INFO - 'HOME': '/home/cltbld', 04:39:22 INFO - 'LANG': 'en_US.UTF-8', 04:39:22 INFO - 'LANGUAGE': 'en_US:en', 04:39:22 INFO - 'LOGNAME': 'cltbld', 04:39:22 INFO - 'MAIL': '/var/mail/cltbld', 04:39:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:22 INFO - 'MOZ_NO_REMOTE': '1', 04:39:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:22 INFO - 'NO_EM_RESTART': '1', 04:39:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:22 INFO - 'PWD': '/builds/slave/test', 04:39:22 INFO - 'SHELL': '/bin/bash', 04:39:22 INFO - 'SHLVL': '1', 04:39:22 INFO - 'TERM': 'linux', 04:39:22 INFO - 'TMOUT': '86400', 04:39:22 INFO - 'USER': 'cltbld', 04:39:22 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468669012.189267-1996861812', 04:39:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:22 INFO - '_': '/tools/buildbot/bin/python'} 04:39:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:22 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 04:39:22 INFO - Cleaning up... 04:39:22 INFO - Return code: 0 04:39:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:39: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')]} 04:39:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39: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')]} 04:39:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:22 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 0x1cfa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb93b0>, '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 0x1fba2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fba740>, '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': '1f5564757af27664ca02d71f000001b0-1468669012.189267-1996861812', '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 04:39:22 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 04:39:22 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 04:39:22 INFO - Using env: {'DISPLAY': ':0', 04:39:22 INFO - 'HOME': '/home/cltbld', 04:39:22 INFO - 'LANG': 'en_US.UTF-8', 04:39:22 INFO - 'LANGUAGE': 'en_US:en', 04:39:22 INFO - 'LOGNAME': 'cltbld', 04:39:22 INFO - 'MAIL': '/var/mail/cltbld', 04:39:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:22 INFO - 'MOZ_NO_REMOTE': '1', 04:39:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:22 INFO - 'NO_EM_RESTART': '1', 04:39:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:22 INFO - 'PWD': '/builds/slave/test', 04:39:22 INFO - 'SHELL': '/bin/bash', 04:39:22 INFO - 'SHLVL': '1', 04:39:22 INFO - 'TERM': 'linux', 04:39:22 INFO - 'TMOUT': '86400', 04:39:22 INFO - 'USER': 'cltbld', 04:39:22 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468669012.189267-1996861812', 04:39:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:22 INFO - '_': '/tools/buildbot/bin/python'} 04:39:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:22 INFO - Downloading/unpacking psutil>=3.1.1 04:39:22 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 04:39:22 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 04:39:22 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 04:39:22 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 04:39:22 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 04:39:22 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 04:39:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:39:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:39:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:39:25 INFO - Installing collected packages: psutil 04:39:25 INFO - Running setup.py install for psutil 04:39:25 INFO - building 'psutil._psutil_linux' extension 04:39:25 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 04:39:25 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 04:39:25 INFO - building 'psutil._psutil_posix' extension 04:39:25 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 04:39:25 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 04:39:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:39:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:39:25 INFO - Successfully installed psutil 04:39:25 INFO - Cleaning up... 04:39:25 INFO - Return code: 0 04:39:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:39:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:39:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:25 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 0x1cfa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb93b0>, '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 0x1fba2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fba740>, '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': '1f5564757af27664ca02d71f000001b0-1468669012.189267-1996861812', '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 04:39:25 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 04:39:25 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 04:39:25 INFO - Using env: {'DISPLAY': ':0', 04:39:25 INFO - 'HOME': '/home/cltbld', 04:39:25 INFO - 'LANG': 'en_US.UTF-8', 04:39:25 INFO - 'LANGUAGE': 'en_US:en', 04:39:25 INFO - 'LOGNAME': 'cltbld', 04:39:25 INFO - 'MAIL': '/var/mail/cltbld', 04:39:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:25 INFO - 'MOZ_NO_REMOTE': '1', 04:39:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:25 INFO - 'NO_EM_RESTART': '1', 04:39:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:25 INFO - 'PWD': '/builds/slave/test', 04:39:25 INFO - 'SHELL': '/bin/bash', 04:39:25 INFO - 'SHLVL': '1', 04:39:25 INFO - 'TERM': 'linux', 04:39:25 INFO - 'TMOUT': '86400', 04:39:25 INFO - 'USER': 'cltbld', 04:39:25 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468669012.189267-1996861812', 04:39:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:25 INFO - '_': '/tools/buildbot/bin/python'} 04:39:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:39:25 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 04:39:25 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 04:39:25 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 04:39:25 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 04:39:25 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 04:39:25 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 04:39:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:39:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:39:27 INFO - Installing collected packages: mozsystemmonitor 04:39:27 INFO - Running setup.py install for mozsystemmonitor 04:39:27 INFO - Successfully installed mozsystemmonitor 04:39:27 INFO - Cleaning up... 04:39:27 INFO - Return code: 0 04:39:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:39:27 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')]} 04:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:27 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')]} 04:39:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:27 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 0x1cfa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb93b0>, '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 0x1fba2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fba740>, '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': '1f5564757af27664ca02d71f000001b0-1468669012.189267-1996861812', '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 04:39:27 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 04:39:27 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 04:39:27 INFO - Using env: {'DISPLAY': ':0', 04:39:27 INFO - 'HOME': '/home/cltbld', 04:39:27 INFO - 'LANG': 'en_US.UTF-8', 04:39:27 INFO - 'LANGUAGE': 'en_US:en', 04:39:27 INFO - 'LOGNAME': 'cltbld', 04:39:27 INFO - 'MAIL': '/var/mail/cltbld', 04:39:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:27 INFO - 'MOZ_NO_REMOTE': '1', 04:39:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:27 INFO - 'NO_EM_RESTART': '1', 04:39:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:27 INFO - 'PWD': '/builds/slave/test', 04:39:27 INFO - 'SHELL': '/bin/bash', 04:39:27 INFO - 'SHLVL': '1', 04:39:27 INFO - 'TERM': 'linux', 04:39:27 INFO - 'TMOUT': '86400', 04:39:27 INFO - 'USER': 'cltbld', 04:39:27 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468669012.189267-1996861812', 04:39:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:27 INFO - '_': '/tools/buildbot/bin/python'} 04:39:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:28 INFO - Downloading/unpacking jsonschema==2.5.1 04:39:28 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 04:39:28 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 04:39:28 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 04:39:28 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 04:39:28 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 04:39:28 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 04:39:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:39:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:39:30 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 04:39:30 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 04:39:30 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 04:39:30 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 04:39:30 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 04:39:30 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 04:39:30 INFO - Downloading functools32-3.2.3-2.tar.gz 04:39:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:39:30 INFO - warning: no files found matching '*.txt' 04:39:30 INFO - no previously-included directories found matching 'build' 04:39:30 INFO - no previously-included directories found matching 'dist' 04:39:30 INFO - no previously-included directories found matching '.git*' 04:39:30 INFO - Installing collected packages: jsonschema, functools32 04:39:30 INFO - Running setup.py install for functools32 04:39:30 INFO - warning: no files found matching '*.txt' 04:39:30 INFO - no previously-included directories found matching 'build' 04:39:30 INFO - no previously-included directories found matching 'dist' 04:39:30 INFO - no previously-included directories found matching '.git*' 04:39:30 INFO - Successfully installed jsonschema functools32 04:39:30 INFO - Cleaning up... 04:39:30 INFO - Return code: 0 04:39:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:39:30 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')]} 04:39:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:30 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')]} 04:39:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:30 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 0x1cfa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb93b0>, '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 0x1fba2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fba740>, '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': '1f5564757af27664ca02d71f000001b0-1468669012.189267-1996861812', '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 04:39:30 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 04:39:30 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 04:39:30 INFO - Using env: {'DISPLAY': ':0', 04:39:30 INFO - 'HOME': '/home/cltbld', 04:39:30 INFO - 'LANG': 'en_US.UTF-8', 04:39:30 INFO - 'LANGUAGE': 'en_US:en', 04:39:30 INFO - 'LOGNAME': 'cltbld', 04:39:30 INFO - 'MAIL': '/var/mail/cltbld', 04:39:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:30 INFO - 'MOZ_NO_REMOTE': '1', 04:39:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:30 INFO - 'NO_EM_RESTART': '1', 04:39:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:30 INFO - 'PWD': '/builds/slave/test', 04:39:30 INFO - 'SHELL': '/bin/bash', 04:39:30 INFO - 'SHLVL': '1', 04:39:30 INFO - 'TERM': 'linux', 04:39:30 INFO - 'TMOUT': '86400', 04:39:30 INFO - 'USER': 'cltbld', 04:39:30 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468669012.189267-1996861812', 04:39:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:30 INFO - '_': '/tools/buildbot/bin/python'} 04:39:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:30 INFO - Downloading/unpacking blobuploader==1.2.4 04:39:30 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 04:39:30 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 04:39:30 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 04:39:30 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 04:39:30 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 04:39:30 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 04:39:32 INFO - Downloading blobuploader-1.2.4.tar.gz 04:39:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:39:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:39:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:39:33 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 04:39:33 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 04:39:33 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 04:39:33 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 04:39:33 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 04:39:33 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 04:39:33 INFO - Downloading docopt-0.6.1.tar.gz 04:39:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:39:33 INFO - Installing collected packages: blobuploader, requests, docopt 04:39:33 INFO - Running setup.py install for blobuploader 04:39:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:39:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:39:33 INFO - Running setup.py install for requests 04:39:33 INFO - Running setup.py install for docopt 04:39:33 INFO - Successfully installed blobuploader requests docopt 04:39:33 INFO - Cleaning up... 04:39:33 INFO - Return code: 0 04:39:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:39:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:39:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:33 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 0x1cfa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb93b0>, '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 0x1fba2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fba740>, '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': '1f5564757af27664ca02d71f000001b0-1468669012.189267-1996861812', '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 04:39:33 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 04:39:33 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 04:39:34 INFO - Using env: {'DISPLAY': ':0', 04:39:34 INFO - 'HOME': '/home/cltbld', 04:39:34 INFO - 'LANG': 'en_US.UTF-8', 04:39:34 INFO - 'LANGUAGE': 'en_US:en', 04:39:34 INFO - 'LOGNAME': 'cltbld', 04:39:34 INFO - 'MAIL': '/var/mail/cltbld', 04:39:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:34 INFO - 'MOZ_NO_REMOTE': '1', 04:39:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:34 INFO - 'NO_EM_RESTART': '1', 04:39:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:34 INFO - 'PWD': '/builds/slave/test', 04:39:34 INFO - 'SHELL': '/bin/bash', 04:39:34 INFO - 'SHLVL': '1', 04:39:34 INFO - 'TERM': 'linux', 04:39:34 INFO - 'TMOUT': '86400', 04:39:34 INFO - 'USER': 'cltbld', 04:39:34 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468669012.189267-1996861812', 04:39:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:34 INFO - '_': '/tools/buildbot/bin/python'} 04:39:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:39:34 INFO - Running setup.py (path:/tmp/pip-ykNuBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:39:34 INFO - Running setup.py (path:/tmp/pip-lYLrix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:39:34 INFO - Running setup.py (path:/tmp/pip-KmxjMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:39:34 INFO - Running setup.py (path:/tmp/pip-rP2YZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:39:34 INFO - Running setup.py (path:/tmp/pip-2SYOdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:39:34 INFO - Running setup.py (path:/tmp/pip-YdUqXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:39:34 INFO - Running setup.py (path:/tmp/pip-zmIUAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:39:34 INFO - Running setup.py (path:/tmp/pip-vzNrWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:39:34 INFO - Running setup.py (path:/tmp/pip-UEtLY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:39:34 INFO - Running setup.py (path:/tmp/pip-lYyrgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:39:34 INFO - Running setup.py (path:/tmp/pip-GYHGPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:39:35 INFO - Running setup.py (path:/tmp/pip-Tj5qjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:39:35 INFO - Running setup.py (path:/tmp/pip-xJqusz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:39:35 INFO - Running setup.py (path:/tmp/pip-E4h3ds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:35 INFO - Running setup.py (path:/tmp/pip-bfIy5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:39:35 INFO - Running setup.py (path:/tmp/pip-Hk13Bu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:39:35 INFO - Running setup.py (path:/tmp/pip-qju8YK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:39:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:39:35 INFO - Running setup.py install for manifestparser 04:39:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:39:35 INFO - Running setup.py install for mozcrash 04:39:35 INFO - Running setup.py install for mozdebug 04:39:35 INFO - Running setup.py install for mozdevice 04:39:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:39:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:39:35 INFO - Running setup.py install for mozfile 04:39:35 INFO - Running setup.py install for mozhttpd 04:39:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:39:36 INFO - Running setup.py install for mozinfo 04:39:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:39:36 INFO - Running setup.py install for mozInstall 04:39:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:39:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:39:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:39:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:39:36 INFO - Running setup.py install for mozleak 04:39:36 INFO - Running setup.py install for mozlog 04:39:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:39:36 INFO - Running setup.py install for moznetwork 04:39:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:39:36 INFO - Running setup.py install for mozprocess 04:39:36 INFO - Running setup.py install for mozprofile 04:39:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:39:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:39:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:39:36 INFO - Running setup.py install for mozrunner 04:39:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:39:36 INFO - Running setup.py install for mozscreenshot 04:39:37 INFO - Running setup.py install for moztest 04:39:37 INFO - Running setup.py install for mozversion 04:39:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:39:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:39:37 INFO - Cleaning up... 04:39:37 INFO - Return code: 0 04:39:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39:37 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')]} 04:39:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:37 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')]} 04:39:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:37 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 0x1cfa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb93b0>, '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 0x1fba2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fba740>, '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': '1f5564757af27664ca02d71f000001b0-1468669012.189267-1996861812', '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 04:39:37 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 04:39:37 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 04:39:37 INFO - Using env: {'DISPLAY': ':0', 04:39:37 INFO - 'HOME': '/home/cltbld', 04:39:37 INFO - 'LANG': 'en_US.UTF-8', 04:39:37 INFO - 'LANGUAGE': 'en_US:en', 04:39:37 INFO - 'LOGNAME': 'cltbld', 04:39:37 INFO - 'MAIL': '/var/mail/cltbld', 04:39:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:37 INFO - 'MOZ_NO_REMOTE': '1', 04:39:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:37 INFO - 'NO_EM_RESTART': '1', 04:39:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:37 INFO - 'PWD': '/builds/slave/test', 04:39:37 INFO - 'SHELL': '/bin/bash', 04:39:37 INFO - 'SHLVL': '1', 04:39:37 INFO - 'TERM': 'linux', 04:39:37 INFO - 'TMOUT': '86400', 04:39:37 INFO - 'USER': 'cltbld', 04:39:37 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468669012.189267-1996861812', 04:39:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:37 INFO - '_': '/tools/buildbot/bin/python'} 04:39:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:39:37 INFO - Running setup.py (path:/tmp/pip-bxiN2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:39:37 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)) 04:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:39:37 INFO - Running setup.py (path:/tmp/pip-cfol5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:39:37 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)) 04:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:39:37 INFO - Running setup.py (path:/tmp/pip-1sfuoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:39:37 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)) 04:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:39:37 INFO - Running setup.py (path:/tmp/pip-4BVrI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:39:37 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)) 04:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:39:37 INFO - Running setup.py (path:/tmp/pip-MPtzez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:39:37 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)) 04:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:39:37 INFO - Running setup.py (path:/tmp/pip-LWsmhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:39:37 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)) 04:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:39:37 INFO - Running setup.py (path:/tmp/pip-5rOlFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:39:37 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)) 04:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:39:37 INFO - Running setup.py (path:/tmp/pip-wULiUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:39:38 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)) 04:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:39:38 INFO - Running setup.py (path:/tmp/pip-IvyjVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:39:38 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)) 04:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:39:38 INFO - Running setup.py (path:/tmp/pip-cYitCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:39:38 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)) 04:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:39:38 INFO - Running setup.py (path:/tmp/pip-YWEv6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:39:38 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)) 04:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:39:38 INFO - Running setup.py (path:/tmp/pip-jaMZUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:39:38 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)) 04:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:39:38 INFO - Running setup.py (path:/tmp/pip-jjCIOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:39:38 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)) 04:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:39:38 INFO - Running setup.py (path:/tmp/pip-UZtVcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:39:38 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)) 04:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:38 INFO - Running setup.py (path:/tmp/pip-i_ALGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:38 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)) 04:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:39:38 INFO - Running setup.py (path:/tmp/pip-o9Hj4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:39:38 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)) 04:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:39:38 INFO - Running setup.py (path:/tmp/pip-SIDatO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:39:38 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)) 04:39:38 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)) 04:39:38 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)) 04:39:38 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)) 04:39:38 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)) 04:39:38 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)) 04:39:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:39:38 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 04:39:38 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 04:39:38 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 04:39:38 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 04:39:38 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 04:39:38 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 04:39:40 INFO - Downloading blessings-1.6.tar.gz 04:39:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:39:40 INFO - Installing collected packages: blessings 04:39:40 INFO - Running setup.py install for blessings 04:39:40 INFO - Successfully installed blessings 04:39:40 INFO - Cleaning up... 04:39:41 INFO - Return code: 0 04:39:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:39:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:39:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:39:41 INFO - Reading from file tmpfile_stdout 04:39:41 INFO - Current package versions: 04:39:41 INFO - argparse == 1.2.1 04:39:41 INFO - blessings == 1.6 04:39:41 INFO - blobuploader == 1.2.4 04:39:41 INFO - docopt == 0.6.1 04:39:41 INFO - functools32 == 3.2.3-2 04:39:41 INFO - jsonschema == 2.5.1 04:39:41 INFO - manifestparser == 1.1 04:39:41 INFO - mozInstall == 1.12 04:39:41 INFO - mozcrash == 0.17 04:39:41 INFO - mozdebug == 0.1 04:39:41 INFO - mozdevice == 0.48 04:39:41 INFO - mozfile == 1.2 04:39:41 INFO - mozhttpd == 0.7 04:39:41 INFO - mozinfo == 0.9 04:39:41 INFO - mozleak == 0.1 04:39:41 INFO - mozlog == 3.2 04:39:41 INFO - moznetwork == 0.27 04:39:41 INFO - mozprocess == 0.23 04:39:41 INFO - mozprofile == 0.28 04:39:41 INFO - mozrunner == 6.12 04:39:41 INFO - mozscreenshot == 0.1 04:39:41 INFO - mozsystemmonitor == 0.3 04:39:41 INFO - moztest == 0.7 04:39:41 INFO - mozversion == 1.4 04:39:41 INFO - psutil == 3.1.1 04:39:41 INFO - requests == 1.2.3 04:39:41 INFO - wsgiref == 0.1.2 04:39:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39:41 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')]} 04:39:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:41 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')]} 04:39:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:41 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 0x1cfa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb93b0>, '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 0x1fba2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fba740>, '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': '1f5564757af27664ca02d71f000001b0-1468669012.189267-1996861812', '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 04:39:41 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 04:39:41 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 04:39:41 INFO - Using env: {'DISPLAY': ':0', 04:39:41 INFO - 'HOME': '/home/cltbld', 04:39:41 INFO - 'LANG': 'en_US.UTF-8', 04:39:41 INFO - 'LANGUAGE': 'en_US:en', 04:39:41 INFO - 'LOGNAME': 'cltbld', 04:39:41 INFO - 'MAIL': '/var/mail/cltbld', 04:39:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:41 INFO - 'MOZ_NO_REMOTE': '1', 04:39:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:41 INFO - 'NO_EM_RESTART': '1', 04:39:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:41 INFO - 'PWD': '/builds/slave/test', 04:39:41 INFO - 'SHELL': '/bin/bash', 04:39:41 INFO - 'SHLVL': '1', 04:39:41 INFO - 'TERM': 'linux', 04:39:41 INFO - 'TMOUT': '86400', 04:39:41 INFO - 'USER': 'cltbld', 04:39:41 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468669012.189267-1996861812', 04:39:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:41 INFO - '_': '/tools/buildbot/bin/python'} 04:39:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:41 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)) 04:39:41 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)) 04:39:41 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)) 04:39:41 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)) 04:39:41 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)) 04:39:41 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)) 04:39:41 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)) 04:39:41 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)) 04:39:41 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)) 04:39:41 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)) 04:39:41 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)) 04:39:41 INFO - Cleaning up... 04:39:41 INFO - Return code: 0 04:39:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:39:41 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')]} 04:39:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:41 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')]} 04:39:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:41 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 0x1cfa030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb93b0>, '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 0x1fba2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fba740>, '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': '1f5564757af27664ca02d71f000001b0-1468669012.189267-1996861812', '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 04:39:41 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 04:39:41 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 04:39:41 INFO - Using env: {'DISPLAY': ':0', 04:39:41 INFO - 'HOME': '/home/cltbld', 04:39:41 INFO - 'LANG': 'en_US.UTF-8', 04:39:41 INFO - 'LANGUAGE': 'en_US:en', 04:39:41 INFO - 'LOGNAME': 'cltbld', 04:39:41 INFO - 'MAIL': '/var/mail/cltbld', 04:39:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:41 INFO - 'MOZ_NO_REMOTE': '1', 04:39:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:41 INFO - 'NO_EM_RESTART': '1', 04:39:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:41 INFO - 'PWD': '/builds/slave/test', 04:39:41 INFO - 'SHELL': '/bin/bash', 04:39:41 INFO - 'SHLVL': '1', 04:39:41 INFO - 'TERM': 'linux', 04:39:41 INFO - 'TMOUT': '86400', 04:39:41 INFO - 'USER': 'cltbld', 04:39:41 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468669012.189267-1996861812', 04:39:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:41 INFO - '_': '/tools/buildbot/bin/python'} 04:39:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:39:41 INFO - Cleaning up... 04:39:41 INFO - Return code: 0 04:39:41 INFO - Running post-action listener: _resource_record_post_action 04:39:41 INFO - Running post-action listener: _start_resource_monitoring 04:39:41 INFO - Starting resource monitoring. 04:39:41 INFO - ##### 04:39:41 INFO - ##### Finished create-virtualenv step (success) 04:39:41 INFO - ##### 04:39:41 INFO - ##### 04:39:41 INFO - ##### Running install step. 04:39:41 INFO - ##### 04:39:41 INFO - Running pre-action listener: _resource_record_pre_action 04:39:41 INFO - Running main action method: install 04:39:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:39:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:39:41 INFO - Reading from file tmpfile_stdout 04:39:41 INFO - Detecting whether we're running mozinstall >=1.0... 04:39:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:39:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:39:42 INFO - Reading from file tmpfile_stdout 04:39:42 INFO - Output received: 04:39:42 INFO - Usage: mozinstall [options] installer 04:39:42 INFO - Options: 04:39:42 INFO - -h, --help show this help message and exit 04:39:42 INFO - -d DEST, --destination=DEST 04:39:42 INFO - Directory to install application into. [default: 04:39:42 INFO - "/builds/slave/test"] 04:39:42 INFO - --app=APP Application being installed. [default: firefox] 04:39:42 INFO - mkdir: /builds/slave/test/build/application 04:39:42 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'] 04:39:42 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 04:39:58 INFO - Reading from file tmpfile_stdout 04:39:58 INFO - Output received: 04:39:58 INFO - /builds/slave/test/build/application/firefox/firefox 04:39:58 INFO - Running post-action listener: _resource_record_post_action 04:39:58 INFO - ##### 04:39:58 INFO - ##### Finished install step (success) 04:39:58 INFO - ##### 04:39:58 INFO - ##### 04:39:58 INFO - ##### Running run-tests step. 04:39:58 INFO - ##### 04:39:58 INFO - Running pre-action listener: _resource_record_pre_action 04:39:58 INFO - Running main action method: run_tests 04:39:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:39:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:39:58 INFO - Python 2.7.3 04:39:58 INFO - Return code: 0 04:39:58 INFO - grabbing minidump binary from tooltool 04:39: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')]} 04:39:58 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 0x1fb93b0>, '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 0x1fba2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fba740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:39:58 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 04:39:58 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 04:39:58 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 04:39:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:39:58 INFO - Return code: 0 04:39:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:39:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:39:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:39:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:39:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:39:58 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/YhPIAQ-ZQoixyf7H4MRFUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 04:39:58 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/YhPIAQ-ZQoixyf7H4MRFUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 04:39:58 INFO - Using env: {'DISPLAY': ':0', 04:39:58 INFO - 'HOME': '/home/cltbld', 04:39:58 INFO - 'LANG': 'en_US.UTF-8', 04:39:58 INFO - 'LANGUAGE': 'en_US:en', 04:39:58 INFO - 'LOGNAME': 'cltbld', 04:39:58 INFO - 'MAIL': '/var/mail/cltbld', 04:39:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:39:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:39:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:58 INFO - 'MOZ_NO_REMOTE': '1', 04:39:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:39:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:39:58 INFO - 'NO_EM_RESTART': '1', 04:39:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:39:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:58 INFO - 'PWD': '/builds/slave/test', 04:39:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:39:58 INFO - 'SHELL': '/bin/bash', 04:39:58 INFO - 'SHLVL': '1', 04:39:58 INFO - 'TERM': 'linux', 04:39:58 INFO - 'TMOUT': '86400', 04:39:58 INFO - 'USER': 'cltbld', 04:39:58 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468669012.189267-1996861812', 04:39:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:58 INFO - '_': '/tools/buildbot/bin/python'} 04:39:58 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/YhPIAQ-ZQoixyf7H4MRFUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 04:39:58 INFO - mozversion application_buildid: 20160716041051 04:39:58 INFO - mozversion application_changeset: 98e3e1a81859a64dfa625d1d40d3d0043a46941c 04:39:58 INFO - mozversion application_display_name: Nightly 04:39:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:39:58 INFO - mozversion application_name: Firefox 04:39:58 INFO - mozversion application_remotingname: firefox 04:39:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:39:58 INFO - mozversion application_vendor: Mozilla 04:39:58 INFO - mozversion application_version: 50.0a1 04:39:58 INFO - mozversion platform_buildid: 20160716041051 04:39:58 INFO - mozversion platform_changeset: 98e3e1a81859a64dfa625d1d40d3d0043a46941c 04:39:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:39:58 INFO - mozversion platform_version: 50.0a1 04:39:58 INFO - using testdate: 1468669198 04:39:58 INFO - actual date: 1468669198 04:39:58 INFO - starting webserver on 'localhost:49440' 04:39:58 INFO - SUITE-START | Running 2 tests 04:39:58 INFO - TEST-START | dromaeo_css 04:39:58 INFO - operating with platform_type : linux_ 04:39:58 INFO - Initialising browser for dromaeo_css test... 04:39:58 INFO - TEST-INFO | started process 13845 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpANrlh6/profile http://localhost:49440/getInfo.html) 04:40:02 INFO - PROCESS | 13845 | __metrics Screen width/height:1600/1200 04:40:02 INFO - PROCESS | 13845 | colorDepth:24 04:40:02 INFO - PROCESS | 13845 | Browser inner width/height: 1024/697 04:40:02 INFO - PROCESS | 13845 | __metrics 04:40:03 INFO - PROCESS | 13845 | 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" 04:40:03 INFO - PROCESS | 13845 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:40:04 INFO - TEST-INFO | 13845: exit 0 04:40:04 INFO - Browser initialized. 04:40:04 INFO - Running cycle 1/1 for dromaeo_css test... 04:40:04 INFO - TEST-INFO | started process 13926 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpANrlh6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:40:16 INFO - PROCESS | 13926 | RSS: Main: 158928896 04:40:16 INFO - PROCESS | 13926 | 04:41:07 INFO - PROCESS | 13926 | 1468669267540 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] 04:43:20 INFO - PROCESS | 13926 | Cycle 1(1): loaded http://localhost:49440/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49440/tests/dromaeo/cssquery-ext.html) 04:43:21 INFO - PROCESS | 13926 | RSS: Main: 244084736 04:43:21 INFO - PROCESS | 13926 | 04:46:24 INFO - PROCESS | 13926 | Cycle 1(1): loaded http://localhost:49440/tests/dromaeo/cssquery-ext.html (next: http://localhost:49440/tests/dromaeo/cssquery-jquery.html) 04:46:25 INFO - PROCESS | 13926 | RSS: Main: 244846592 04:46:25 INFO - PROCESS | 13926 | 04:49:27 INFO - PROCESS | 13926 | Cycle 1(1): loaded http://localhost:49440/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49440/tests/dromaeo/cssquery-mootools.html) 04:49:27 INFO - PROCESS | 13926 | RSS: Main: 245489664 04:49:27 INFO - PROCESS | 13926 | 04:52:30 INFO - PROCESS | 13926 | Cycle 1(1): loaded http://localhost:49440/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49440/tests/dromaeo/cssquery-prototype.html) 04:52:30 INFO - PROCESS | 13926 | RSS: Main: 238399488 04:52:30 INFO - PROCESS | 13926 | 04:55:33 INFO - PROCESS | 13926 | Cycle 1(1): loaded http://localhost:49440/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49440/tests/dromaeo/cssquery-yui.html) 04:55:34 INFO - PROCESS | 13926 | RSS: Main: 218812416 04:55:34 INFO - PROCESS | 13926 | 04:58:36 INFO - PROCESS | 13926 | Cycle 1(1): loaded http://localhost:49440/tests/dromaeo/cssquery-yui.html (next: http://localhost:49440/tests/dromaeo/cssquery-dojo.html) 04:58:37 INFO - PROCESS | 13926 | RSS: Main: 270426112 04:58:37 INFO - PROCESS | 13926 | 04:58:37 INFO - PROCESS | 13926 | __start_tp_report 04:58:37 INFO - PROCESS | 13926 | _x_x_mozilla_page_load 04:58:37 INFO - PROCESS | 13926 | _x_x_mozilla_page_load_details 04:58:37 INFO - PROCESS | 13926 | |i|pagename|runs| 04:58:37 INFO - PROCESS | 13926 | |0;dojo.html;2635.3148181472816;2635.617835413866;2668.4529671417363;2675.57190849464;2677.3039009857443;4708.646851486135;4715.55202255786;4735.455422626399;4781.737004464753;4803.8799030024265;4730.621550275978;4737.502562230968;4748.6913350632185;4808.687435316702;4816.181249187638;4191.706580539363;4389.144116897206;4466.5980061794435;4514.119746649405;4524.049949510607;4430.069685366061;4469.7988590513505;4482.17079840229;4489.730616163024;4519.502854685982;4292.18448494785;4347.239233134221;4370.759608221547;4401.713888597231;4433.113377324548;4373.562643735633;4384.780760961939;4389.385486031958;4457.799399027052;4494.797734101973;4427.933580996288;4440.822367105312;4442.2892337225885;4444.73331600105;4486.237339652267;4559.475660299075;4659.510751371091;4749.216379297412;4825.710457372534;4863.635227357962;5186.0665080285535;5195.9740201298755;5216.947830521722;5218;5223.921641175385;5190.558802501791;5216.217567364888;5232.738363081869;5237.16205407133;5239.292695486099;4721.055788842245;4792.185328494094;4834.057358815067;4837.95162048382;4843.055604157155;5278.788848446019;5307;5313.203019547099;5370.301860758076;5372.677639341652;5093.2360145977655;5096.362954630671;5097.08252514551;5127.666701664454;5155.948440515547;4938.506149385033;4977.825776097891;5079.111155547765;5107.642465027412;5163.948360516347;5109.642325037212;5121.027004869063;5122.257272695439;5144.202648589475;5146.382434107856;5093.490650934951;5101.285819985205;5116.360454943132;5118.641695081308;5148.819791307361;4315.805788739514;4357.607815296575;4358.738475691469;4408.6913916026215;4413.801378937956;3855.325318069383;3868.4777555030273;3875.3411919973673;3896.7467114637457;3897.3569361055106;4375.7155784873885;4420.359047938031;4421.867343979686;4437.467503899488;4460.063386688832;5178.844634660966;5182.6372153949615;5183.688978661217;5196.688198708014;5241.528262456397;4300.6989510734575;4413.867583972486;4422.270325396274;4434.024514606781;4479.148961697267;4581.221192397301;4583.427071616048;4591.678582499193;4596.2416201326405;4608.423947006624;4751.619870410359;4758.1435341638835;4758.571728544448;4760.404949381327;4800.7359595221205;5011.574016208663;5070.391553013662;5090.796368145381;5123.410807757155;5193.350831146106;4703.176944034712;4757.072370887644;4784.47370789206;4805.159097158054;4839.41926968766;5051.393832739947;5052.040112378636;5055.368078990126;5061.822836200715;5099.77051032697;5128.205128205134;5128.205128205134;5135;5139.897202055863;5139.948600513947;4875.634327425386;4882.902341953212;4915.336429581961;4929.531694489161;4941;4920.950790492049;4924.901501970012;4927.60579153674;4930.926036109533;4940.308356830118;4797.56821886032;4852.150873597036;4857.9514204858915;4864.975675121602;4916.213405855046;4984.928240428325;5034.370703662043;5036.395632524121;5053.8736531587;5060.3168572242275;4932.950670493393;4941.579965702812;4947.554720075211;4948.678335908155;5000.499950004971 04:58:37 INFO - PROCESS | 13926 | |1;ext.html;578.6932925549459;589.0281036290121;616.5098746496535;617.3517806303383;623.1276213301375;39322.80338598307;41153;41207.17585648289;44704.55295447045;44736.776316118456;42084.368734469004;42683;42688;42775;42856.357154642705;7518.436117291198;7948.841023179533;8053.798655033642;8086.353091752675;10491.16070714341;10335.328203666775;10381.532831022585;10409.791804163911;10410.323328983592;10414.531346089407;10382.169426445866;10428.530716117793;10435.53902453657;10438.739031524236;10477.895221047767;7553.7356192533;10168.79662406755;10395.064444200021;10423.322484038514;10447.738806529822;10262.281640285182;10328.741781455448;10331.380117192992;10337.121344685711;10354.223433242538;39076;39144.41283380752;39313.21373572541;39330.60669393298;39349.60650393488;2582.0704546363295;3151.6848315168527;3187.6015498062743;3315.386653469116;3523.8195204606486;29829.552556711667;30141.849290753624;30301.393972120655;30367.848160759277;31240.062798116094;3303.752218583592;3309.321589074234;3321.1653421128694;3374.4263475209273;3383.120388698956;272735;273911.6304418485;274026;274218;274733;42489.36265956013;45943.77028114838;52246;52650;52759.472405275454;54565.727171364684;54769.45230547723;54905.45094549083;55060.72469637706;55064.59483241411;15107;15272.694546109016;15303.92348038275;15305.540833775005;15312.923435382752;10152.746181345377;10833.891661083446;11092.057175140204;11130.49912753928;11382.089432845352;15665.138417386925;15699.136547489768;15812.92093539525;15848.841511584968;15882.285297161656;5818.418158184148;5906.438888305604;5932.970335148297;6047.697615119227;6068;845.8054647431126;941.8540126280437;991.306085739985;996;1037.1443559063803;27420.725792742218;28609.919417779987;28678.85660571684;28814.279643009093;28867.711322886502;936.9531523423938;952.2667545989549;999.1457304005116;1037.1961729659574;1038.7351225437465;14044.578662640137;14540.709185816224;14541.200233987021;14700.044497107654;14815.259237038104;387593;391212;391365;392231;392609;47301.5269847304;47470.05059898783;47555.76222118867;47556.7622161887;47707;1110.6723516562633;1147.3804145761362;1147.7761836441814;1190.9702257443632;1216.8661447240797;19903.800961990193;28301.150965470246;28311.29221769472;28708.425831482837;29047;40735.1852962945;41152;41155.58844411517;41176;41275.793621031706;299971;301985;304677;305719;307266;21819.890900545397;22464;24003.15988940379;24115.517689646458;24605.507889841745;40801.795991019855;40964.38553421761;41038;41204.58795412127;41253.1749365017;35114.47328290027;35294.47058294179;35831.82084089563;36085.639143609274;36122;33508.1622959428;34570.48144277888;34786.82606586951;34938;35276.47085293774;35077.824610876785;35184.29631407409;35539;35660.28679426449;36285;29157.7084229155;30964.53553196749;33434.83282583669;33650.83174584111;33684.66315336815;25071.122510712037;25740.485190296462;25777.613335800354;25903.870480647474;26230.08194713176 04:58:37 INFO - PROCESS | 13926 | |2;jquery.html;378.7765517378866;380.288859832114;383.4095492940871;383.44166138237154;403.1252182763403;16227.432039878606;17047.829521704778;17408.825911740878;17624.11879406031;17650;14505.637359066028;14803.25983700816;17310.221040053195;17469.213885375157;17761.20074596643;5086.694798312104;5292.973535132319;5293.179557168645;5323.281357016811;5332.680039197641;3772.9811350943205;3997.040710229553;5934.495567876736;6234.189555357797;6245.56281060326;5160.200168973815;6278.246610406758;6280.591761535486;6301.558890877641;6312.526560507958;5483.369412517552;5554.250176226198;5580.665160090408;5585.636933599303;5590.245316882229;3312.8343582821003;5044.899102017976;5332.386775520826;5335.33308336458;5487.149491828733;12269.815952760715;12304.384780761016;12320.075994300374;12355.93822030884;12475.064370172273;1884.679604467244;1885.2930151193302;1917.0702209428416;1924.8845069295887;2024.7165396844453;8501.61742721579;9418.811623767486;9660.584853786553;11515.884841151565;13193.670158246025;1712.6745918275487;1757.534253422844;1766.3376233912284;1766.9116544172869;1778.3597904754279;64396.67801661009;64924.67537662329;66169.66915165441;69953.3004669957;71838;10006.19950403966;10197.490125493696;10290.485475726184;10395.272330936761;10518.211134164969;14132.57602271913;14139.43442262298;14171.716565668628;14235;14246.791747278981;7489.550626962399;7601.391888648895;7674.040744906887;7702.614869256515;7741.61291935401;7418.443616728767;7469.141048779351;7572.545647261182;7670.501417407851;7695.384369250447;4363.978180109143;4370.803313850821;4400.119976004812;4449.13241917823;4546.681732278775;1584.429605342076;1678.8208377156366;1678.860530807398;1692.69531484334;1745.5810605454853;879.8020445399734;892.9464232146092;923.3628796130782;950.8954015058338;955.7562821480617;16862.156892155344;16940.40708575194;17081.31674732997;17103.973761574347;17385.91307043482;792.5878543157526;809.3039985612369;825.6160885188297;850.4812064640564;856.0797143071223;8202.630881610341;9660.75848103803;9870.802583948282;9881.555330010167;10082.395056296646;394597;402642;405528;406437;407309;76911.23088769152;79360;79615;79965.60017199993;80150.59924700456;809.3039985612369;852.5609311204735;878.9648414063494;882.139913584263;883.8762573239752;15313.693726125191;15535.300911458786;15593.142377169364;15668.76496852571;16084.276207570454;37197.44203836891;37494.250114998096;37963;38959.41560876646;39062.2187556253;48668;48678.26982595193;52381;52678;52719;6574.539782215199;6989.860202795814;7132.928670713434;7236.782896513113;7294.96352518234;10773.138148947908;11162.218644694793;11286.15353848481;11577.479013444583;11845.230060046415;9735.9026409735;9770.609175633179;9833.16418104469;9874.259430542594;10120.645777397756;9659.71020869375;9962.701118966443;10008.199344052604;10071.597136114473;10252.794944101226;10158.288919775545;10473.738156546147;10546;10568.947155264175;10574.312669676447;7078.079849619517;7139.607321597362;7222.458315626244;7385.003024591611;7405.7778266652085;9532.52337383142;10334.638287660197;10370.688879333633;10462.372257664565;10468.63359782404 04:58:37 INFO - PROCESS | 13926 | |3;mootools.html;1340.0619566303587;1416.2069241224915;1489.5997762103623;1694.2291257477848;1765.2674140231798;7769.611519424035;8215.83568328633;8298.585070746454;8307.750767476979;8316;6923.826904327382;7566.319031287183;7874.488158269708;7882.527048377101;7891.9210807891905;2213.092632020872;2273.499830037389;2282.1784157703214;2295.276987748862;2297.081167532992;1881.1722841949568;2249.876256805875;2250.077468238023;2305.942351441219;2306.4925716342377;2117.841161912863;2190.6823510590953;2215.3353993801875;2224.2659922225625;2234.497238121426;2217.46780772615;2231.3306008197555;2231.7768223177554;2243.4279258789065;2246.4608493961496;2208.1829723002593;2214.147553192033;2216.6342553478657;2216.8448208625405;2243.32700189944;8021.879671804928;8067.677292908276;8070.878936815952;8075.232852878967;8079.757607271791;4646.628269738413;4805.183118869801;4808.975955120237;4815.951840481585;4816.8073277069225;2802.6776920654183;2973.3310005248863;3010.202296391458;3024.7882648214413;3029.3486900316316;928.5264515097282;971.4851128901623;980.8822941247024;986.5856340337004;991.1971303244395;10819.621313254078;10949.562017519289;11037.11703063761;11041.282316649393;11056.668299951014;4120.196561670446;4415.757133357632;4421.159979603929;4421.823127074946;4422.447194100738;9602.231821454267;9662.275329350327;9672.613095476103;9673.9032609673;9677.758056048515;4833.830815921497;4849.151398505247;4851.878703032382;4852.344933434012;4854.490278520775;4262.680298977527;4356.302991521341;4360.4331436913;4399.450068741407;4423.51341352451;3682.6869716074434;3686.870959516404;3778.6410291022307;3813.504244448204;3814.904627384338;1107.7119948813368;1191.1721353659298;1196.4316949449117;1230.4524486603375;1233.7039110613389;762.7063580521428;778.1712476212815;785.3050050705053;797.2266901105918;798.297498201579;4681.087187998376;4698.459677137173;4738.360321356642;4751.477337492873;4794.5924596409695;804.3082948664144;837.4807619276088;852.3607294529103;853.9274161696201;858.5235194467131;3047.527633216855;3120.7347375472887;3137.341158356725;3153.5112057631104;3194.632617249;9527.38072025316;9887.209023278121;9896.10935015852;9906.55420506079;10009.099181073738;8610.741677749553;9311.441313521074;9907.900920990842;9913.653022144335;9919.40483570988;7044.788656340318;7122.323379278961;7189.1013623297085;7197.532160409662;7200.451902840809;5315.707636080053;5354.732263386737;5446.346438427414;5518.586106042143;5530.585206109477;9074.500902450429;9236.584353703965;9383.859242111237;9388.95305523468;9389.577469013775;9356.391834530734;9440.858387124335;9488.288378371511;9656.855147172939;9695;6789.355011273921;6823.283555226828;6869.244383117753;6910.7581234656545;6919.238883722887;7594.240575942362;7727.729529466442;7760.611969401394;7790.9220907790195;7796.532208067534;6807;6994.6852391643515;7021.0872586565465;7021.297870212938;7064.964675176591;6688.765893193715;6718.966405167943;6984.860302794017;7006.159260888726;7042.7887163385185;6183.96908015457;6217.720202590804;6219.813405597839;6242.531810114168;6242.719077641608;4389.100234451866;4461.375407442895;4485.349624304523;4488.169688607488;4505.369248305175;4393.802278897521;4452.755098469615;4510.706804057726;4658.20810462229;4693.601043911306 04:58:37 INFO - PROCESS | 13926 | |4;prototype.html;296.988120475181;300.0638009410639;306.12906281628767;313.2028986230043;315.41805369094016;4866.197077482211;4874.829380971667;4875.146849301375;4901.852944411665;4924.729139897304;4809.783559739812;4813.302071199674;4839.637027222963;4858.975705121469;4862.756862156895;3591.658792414723;3695.5380577427823;3751.981240093796;3829.9617003829885;3854.1713531590703;3789.488419063419;3821.866234681787;3837.6354246346555;3847.3074846527616;3850.5571859236265;3785.867494637688;3794.601566835484;3800.220954704293;3811.1805961718223;3821.464994900716;3527.417976033951;3648.872289469869;3786.753860999054;3789.7408228923105;3797.5442946846556;3374.5106959490736;3375.476801095834;3376.0547046826928;3384.983075084609;3385.7460690448315;4743.667943243974;4748.124490826139;4754.524547545252;4771.6898401603785;4790.616750659939;4228.72273987659;4310.978445107754;4357.738535687838;4372.213001659732;4384.868453946355;5001.249812528114;5031.245313203012;5038.420581633122;5040.621953353513;5054.62090343222;3699;3703.6111208323277;3704.685101766353;3706.3328600851837;3733.533308336458;5192.792288308463;5313.237116699294;5330.440303768088;5342.679439233659;5357.4106848246665;3761.4545890845675;3764.5670747863796;3771.585125636178;3775.9433608495897;3776.339140650375;3853.190829925747;3854.3447613905705;3858.7298889077497;3863.6715879150024;3876.379779235309;4332.393464914914;4353.82584696615;4357.825686972549;4360.956390436118;4372.715773474714;4847.345608342828;4994.1759609663995;4999.150314383629;5069;5081.415637201695;1302.9218246905216;1314.2705798281854;1321.6563693439775;1322.5966080345586;1328.9401976911063;810.7121971700079;859.8366310401004;870.5429649433971;900.2213085680839;927.7197467494814;4392.494863090722;4407.735535867794;4410.213863385334;4425.84509542171;4434.534373890695;5116.641835071584;5129.948700513021;5138.871528211825;5168.095583272912;5201.895962080737;4218.535961044283;4353.25994580922;4388.978055109768;4391.98984233628;4404.66964977628;2783.5268004439295;2787.665480142355;2800.6079148919166;2804.453131639311;2822.1251412062325;4970.925436118461;4980.161308054374;4994.303076338736;4999.225120106389;5004.174311238678;5285.894282114413;5368.355797304349;5369.48989845964;5461.098918678374;5467.20725494809;4867.829625963074;4913.361263035782;4934.851954441372;4954.9752251238515;4956.529129732669;5169.4830516948;5200.6879587224885;5217.895642087213;5229.607779416635;5233.377652927605;4885.5358740919555;5114.514121158484;5116.9232461512365;5177.8187763428095;5188.584913206859;4919.3604831371695;4933.457319694759;4938.283948827472;4938.876528086683;4950.628702847229;3742.1954279829965;3766.0584853786554;3772.43413487979;3786.9017984784105;3797.7911214883447;5099.745012749422;5279.8680032997945;5285.894282114259;5309.203619457112;5347.171188465794;5064.5441910228255;5081.618878584195;5101.240072175094;5115.718635474936;5120.641555091108;5077.213031980049;5121.641485096007;5125.615578831677;5144.356955380577;5155.118381790545;4907.73751808706;4923.458419573915;5003.649744517995;5031.924521132113;5058.772355244097;4875.8049678012485;5018.84943451697;5142.588592912483;5148.6910785353;5169.302144210634;4987.80048798044;5033.395992480926;5039.034776437119;5041.143005689115;5049.4094360276395 04:58:37 INFO - PROCESS | 13926 | |5;yui.html;637.5295729049932;664.7507184805697;674.7402250133697;698.7004172239633;752.059925093633;11646.534138634455;12836.422360993754;12866.485340586389;12898.871011289884;12917.483300667975;11860.881391186085;11937.641870743892;11945.104117191202;11952.462139203735;11974.580889668863;618.8855061813556;752.9887051694229;755.3617193471536;777.2460713108276;781.6599779096083;790.9920900790976;792.5165648954134;794.027316537243;794.4756460735887;796.040770871099;829.5686243153557;833.9082700902895;835.2274146414572;835.2566216067704;835.51122593283;653.3923451190415;795.2842441802367;813.772143799737;816.9550674712889;830.9501429914194;599.865030368168;599.9610025348383;599.9670018149;600.6756351570191;600.7777122464717;13111.47554097835;13132.737345253137;13135.277559734212;13146.86853131466;13149.21104733719;12324.876751232463;12712.364381780966;12927.48290068396;13031.087823852335;13078.803817942739;11619.825702614467;11646.825297620542;11674.591389301333;11729.413529323585;11862;4082.5917408259234;4131.690123240769;4142.06803469217;4155.148194620096;4168.7290326128705;59984.700076499335;60140;60164.99999999956;60794;61122;9928.620357593209;9976.60093596248;10131.290809643402;10206.13247873939;10385;18908.527286817665;18979.810201897802;18992.240310387708;18993.715094273597;19007;6676.566023208476;6815.863682726417;6879.140107486564;6905.896411553831;6972.965135174393;3782.527184101987;3867.5358956925347;3879.728419010642;3910.9804450977563;3920.3335432976464;2888.725571070745;2966.2139533023765;2985.4924662807375;2985.9552106718415;2996.056242283674;401.44199562608;445.05425969814144;449.0771464640131;456.2084782901663;456.7373760087963;480.3563225278144;526.6760942020629;530.7850320620155;557.9665220086807;559.2394343692575;7898.9210107899335;8116.837663246702;8310.127436619068;8382;8541.743747687578;509.38110196111904;549.7031602934451;552.9797523569009;560.2800401484074;576.7808232871566;3633.364161271767;3669.743117981769;3755.75587586806;3807.562130354989;3860.942085868714;99508;104939.475302623;105765;106103;107465.46267268613;90285.54857225672;90797;91107.54446227859;91365.99999999868;91444;49346.259806102935;51624;57573.712131439075;77939.61030194926;80210.59894700606;7379.594122323324;7397.445191610758;7410.407167426485;7449.255074492507;7471.215522370073;47217.527824721314;47756.2836557445;48543;48949.75525122351;49064.018719626125;66233.33766662271;70809;71252.28747712457;71410;73229;9631.470269135265;9778.41329520231;9783.559739811868;9825.9017409825;9938.204943604638;11521.711957201138;11687.532498699957;11688.240264382788;11729.765404691687;11884.881151188378;8591.785205369915;9310;10520.263581549218;10657.89342106569;10932.945335273273;9186.356955013085;9471.526423678926;9476.95261523688;9762.316637835283;9840.65557705477;9613.086756758097;9762.560684769345;11708.297502149899;12081.335526546125;12259.264444133023;10286;10549.73625659334;10923;11073.778524429628;11438.656840294805;10614.89385106139;10718.73203169927;10750.946245269037;10779.299345542828;10858 04:58:37 INFO - PROCESS | 13926 | __end_tp_report 04:58:37 INFO - PROCESS | 13926 | __start_cc_report 04:58:37 INFO - PROCESS | 13926 | _x_x_mozilla_cycle_collect,872 04:58:37 INFO - PROCESS | 13926 | __end_cc_report 04:58:37 INFO - PROCESS | 13926 | __startTimestamp1468670317201__endTimestamp 04:58:37 INFO - PROCESS | 13926 | 04:58:37 INFO - PROCESS | 13926 | ------- Summary: start ------- 04:58:37 INFO - PROCESS | 13926 | Number of tests: 6 04:58:37 INFO - PROCESS | 13926 | 04:58:37 INFO - PROCESS | 13926 | [#0] dojo.html Cycles:165 Average:4739.78 Median:4837.95 stddev:498.43 (10.3%) stddev-sans-first:471.83 04:58:37 INFO - PROCESS | 13926 | Values: 2635.3 2635.6 2668.5 2675.6 2677.3 4708.6 4715.6 4735.5 4781.7 4803.9 4730.6 4737.5 4748.7 4808.7 4816.2 4191.7 4389.1 4466.6 4514.1 4524.0 4430.1 4469.8 4482.2 4489.7 4519.5 4292.2 4347.2 4370.8 4401.7 4433.1 4373.6 4384.8 4389.4 4457.8 4494.8 4427.9 4440.8 4442.3 4444.7 4486.2 4559.5 4659.5 4749.2 4825.7 4863.6 5186.1 5196.0 5216.9 5218.0 5223.9 5190.6 5216.2 5232.7 5237.2 5239.3 4721.1 4792.2 4834.1 4838.0 4843.1 5278.8 5307.0 5313.2 5370.3 5372.7 5093.2 5096.4 5097.1 5127.7 5155.9 4938.5 4977.8 5079.1 5107.6 5163.9 5109.6 5121.0 5122.3 5144.2 5146.4 5093.5 5101.3 5116.4 5118.6 5148.8 4315.8 4357.6 4358.7 4408.7 4413.8 3855.3 3868.5 3875.3 3896.7 3897.4 4375.7 4420.4 4421.9 4437.5 4460.1 5178.8 5182.6 5183.7 5196.7 5241.5 4300.7 4413.9 4422.3 4434.0 4479.1 4581.2 4583.4 4591.7 4596.2 4608.4 4751.6 4758.1 4758.6 4760.4 4800.7 5011.6 5070.4 5090.8 5123.4 5193.4 4703.2 4757.1 4784.5 4805.2 4839.4 5051.4 5052.0 5055.4 5061.8 5099.8 5128.2 5128.2 5135.0 5139.9 5139.9 4875.6 4882.9 4915.3 4929.5 4941.0 4921.0 4924.9 4927.6 4930.9 4940.3 4797.6 4852.2 4858.0 4865.0 4916.2 4984.9 5034.4 5036.4 5053.9 5060.3 4933.0 4941.6 4947.6 4948.7 5000.5 04:58:37 INFO - PROCESS | 13926 | 04:58:37 INFO - PROCESS | 13926 | [#1] ext.html Cycles:180 Average:47822.34 Median:3318.28 stddev:85876.01 (2588.0%) stddev-sans-first:86043.66 04:58:37 INFO - PROCESS | 13926 | Values: 578.7 589.0 616.5 617.4 623.1 39322.8 41153.0 41207.2 44704.6 44736.8 42084.4 42683.0 42688.0 42775.0 42856.4 7518.4 7948.8 8053.8 8086.4 10491.2 10335.3 10381.5 10409.8 10410.3 10414.5 10382.2 10428.5 10435.5 10438.7 10477.9 7553.7 10168.8 10395.1 10423.3 10447.7 10262.3 10328.7 10331.4 10337.1 10354.2 39076.0 39144.4 39313.2 39330.6 39349.6 2582.1 3151.7 3187.6 3315.4 3523.8 29829.6 30141.8 30301.4 30367.8 31240.1 3303.8 3309.3 3321.2 3374.4 3383.1 272735.0 273911.6 274026.0 274218.0 274733.0 42489.4 45943.8 52246.0 52650.0 52759.5 54565.7 54769.5 54905.5 55060.7 55064.6 15107.0 15272.7 15303.9 15305.5 15312.9 10152.7 10833.9 11092.1 11130.5 11382.1 15665.1 15699.1 15812.9 15848.8 15882.3 5818.4 5906.4 5933.0 6047.7 6068.0 845.8 941.9 991.3 996.0 1037.1 27420.7 28609.9 28678.9 28814.3 28867.7 937.0 952.3 999.1 1037.2 1038.7 14044.6 14540.7 14541.2 14700.0 14815.3 387593.0 391212.0 391365.0 392231.0 392609.0 47301.5 47470.1 47555.8 47556.8 47707.0 1110.7 1147.4 1147.8 1191.0 1216.9 19903.8 28301.2 28311.3 28708.4 29047.0 40735.2 41152.0 41155.6 41176.0 41275.8 299971.0 301985.0 304677.0 305719.0 307266.0 21819.9 22464.0 24003.2 24115.5 24605.5 40801.8 40964.4 41038.0 41204.6 41253.2 35114.5 35294.5 35831.8 36085.6 36122.0 33508.2 34570.5 34786.8 34938.0 35276.5 35077.8 35184.3 35539.0 35660.3 36285.0 29157.7 30964.5 33434.8 33650.8 33684.7 25071.1 25740.5 25777.6 25903.9 26230.1 04:58:37 INFO - PROCESS | 13926 | 04:58:37 INFO - PROCESS | 13926 | [#2] jquery.html Cycles:180 Average:24538.87 Median:4385.46 stddev:66558.58 (1517.7%) stddev-sans-first:66720.57 04:58:37 INFO - PROCESS | 13926 | Values: 378.8 380.3 383.4 383.4 403.1 16227.4 17047.8 17408.8 17624.1 17650.0 14505.6 14803.3 17310.2 17469.2 17761.2 5086.7 5293.0 5293.2 5323.3 5332.7 3773.0 3997.0 5934.5 6234.2 6245.6 5160.2 6278.2 6280.6 6301.6 6312.5 5483.4 5554.3 5580.7 5585.6 5590.2 3312.8 5044.9 5332.4 5335.3 5487.1 12269.8 12304.4 12320.1 12355.9 12475.1 1884.7 1885.3 1917.1 1924.9 2024.7 8501.6 9418.8 9660.6 11515.9 13193.7 1712.7 1757.5 1766.3 1766.9 1778.4 64396.7 64924.7 66169.7 69953.3 71838.0 10006.2 10197.5 10290.5 10395.3 10518.2 14132.6 14139.4 14171.7 14235.0 14246.8 7489.6 7601.4 7674.0 7702.6 7741.6 7418.4 7469.1 7572.5 7670.5 7695.4 4364.0 4370.8 4400.1 4449.1 4546.7 1584.4 1678.8 1678.9 1692.7 1745.6 879.8 892.9 923.4 950.9 955.8 16862.2 16940.4 17081.3 17104.0 17385.9 792.6 809.3 825.6 850.5 856.1 8202.6 9660.8 9870.8 9881.6 10082.4 394597.0 402642.0 405528.0 406437.0 407309.0 76911.2 79360.0 79615.0 79965.6 80150.6 809.3 852.6 879.0 882.1 883.9 15313.7 15535.3 15593.1 15668.8 16084.3 37197.4 37494.3 37963.0 38959.4 39062.2 48668.0 48678.3 52381.0 52678.0 52719.0 6574.5 6989.9 7132.9 7236.8 7295.0 10773.1 11162.2 11286.2 11577.5 11845.2 9735.9 9770.6 9833.2 9874.3 10120.6 9659.7 9962.7 10008.2 10071.6 10252.8 10158.3 10473.7 10546.0 10568.9 10574.3 7078.1 7139.6 7222.5 7385.0 7405.8 9532.5 10334.6 10370.7 10462.4 10468.6 04:58:37 INFO - PROCESS | 13926 | 04:58:37 INFO - PROCESS | 13926 | [#3] mootools.html Cycles:180 Average:5232.70 Median:5085.10 stddev:2976.75 (58.5%) stddev-sans-first:2970.73 04:58:37 INFO - PROCESS | 13926 | Values: 1340.1 1416.2 1489.6 1694.2 1765.3 7769.6 8215.8 8298.6 8307.8 8316.0 6923.8 7566.3 7874.5 7882.5 7891.9 2213.1 2273.5 2282.2 2295.3 2297.1 1881.2 2249.9 2250.1 2305.9 2306.5 2117.8 2190.7 2215.3 2224.3 2234.5 2217.5 2231.3 2231.8 2243.4 2246.5 2208.2 2214.1 2216.6 2216.8 2243.3 8021.9 8067.7 8070.9 8075.2 8079.8 4646.6 4805.2 4809.0 4816.0 4816.8 2802.7 2973.3 3010.2 3024.8 3029.3 928.5 971.5 980.9 986.6 991.2 10819.6 10949.6 11037.1 11041.3 11056.7 4120.2 4415.8 4421.2 4421.8 4422.4 9602.2 9662.3 9672.6 9673.9 9677.8 4833.8 4849.2 4851.9 4852.3 4854.5 4262.7 4356.3 4360.4 4399.5 4423.5 3682.7 3686.9 3778.6 3813.5 3814.9 1107.7 1191.2 1196.4 1230.5 1233.7 762.7 778.2 785.3 797.2 798.3 4681.1 4698.5 4738.4 4751.5 4794.6 804.3 837.5 852.4 853.9 858.5 3047.5 3120.7 3137.3 3153.5 3194.6 9527.4 9887.2 9896.1 9906.6 10009.1 8610.7 9311.4 9907.9 9913.7 9919.4 7044.8 7122.3 7189.1 7197.5 7200.5 5315.7 5354.7 5446.3 5518.6 5530.6 9074.5 9236.6 9383.9 9389.0 9389.6 9356.4 9440.9 9488.3 9656.9 9695.0 6789.4 6823.3 6869.2 6910.8 6919.2 7594.2 7727.7 7760.6 7790.9 7796.5 6807.0 6994.7 7021.1 7021.3 7065.0 6688.8 6719.0 6984.9 7006.2 7042.8 6184.0 6217.7 6219.8 6242.5 6242.7 4389.1 4461.4 4485.3 4488.2 4505.4 4393.8 4452.8 4510.7 4658.2 4693.6 04:58:37 INFO - PROCESS | 13926 | 04:58:37 INFO - PROCESS | 13926 | [#4] prototype.html Cycles:180 Average:4234.11 Median:4864.48 stddev:1219.41 (25.1%) stddev-sans-first:1186.48 04:58:37 INFO - PROCESS | 13926 | Values: 297.0 300.1 306.1 313.2 315.4 4866.2 4874.8 4875.1 4901.9 4924.7 4809.8 4813.3 4839.6 4859.0 4862.8 3591.7 3695.5 3752.0 3830.0 3854.2 3789.5 3821.9 3837.6 3847.3 3850.6 3785.9 3794.6 3800.2 3811.2 3821.5 3527.4 3648.9 3786.8 3789.7 3797.5 3374.5 3375.5 3376.1 3385.0 3385.7 4743.7 4748.1 4754.5 4771.7 4790.6 4228.7 4311.0 4357.7 4372.2 4384.9 5001.2 5031.2 5038.4 5040.6 5054.6 3699.0 3703.6 3704.7 3706.3 3733.5 5192.8 5313.2 5330.4 5342.7 5357.4 3761.5 3764.6 3771.6 3775.9 3776.3 3853.2 3854.3 3858.7 3863.7 3876.4 4332.4 4353.8 4357.8 4361.0 4372.7 4847.3 4994.2 4999.2 5069.0 5081.4 1302.9 1314.3 1321.7 1322.6 1328.9 810.7 859.8 870.5 900.2 927.7 4392.5 4407.7 4410.2 4425.8 4434.5 5116.6 5129.9 5138.9 5168.1 5201.9 4218.5 4353.3 4389.0 4392.0 4404.7 2783.5 2787.7 2800.6 2804.5 2822.1 4970.9 4980.2 4994.3 4999.2 5004.2 5285.9 5368.4 5369.5 5461.1 5467.2 4867.8 4913.4 4934.9 4955.0 4956.5 5169.5 5200.7 5217.9 5229.6 5233.4 4885.5 5114.5 5116.9 5177.8 5188.6 4919.4 4933.5 4938.3 4938.9 4950.6 3742.2 3766.1 3772.4 3786.9 3797.8 5099.7 5279.9 5285.9 5309.2 5347.2 5064.5 5081.6 5101.2 5115.7 5120.6 5077.2 5121.6 5125.6 5144.4 5155.1 4907.7 4923.5 5003.6 5031.9 5058.8 4875.8 5018.8 5142.6 5148.7 5169.3 4987.8 5033.4 5039.0 5041.1 5049.4 04:58:37 INFO - PROCESS | 13926 | 04:58:37 INFO - PROCESS | 13926 | [#5] yui.html Cycles:180 Average:17963.26 Median:26066.69 stddev:26455.67 (101.5%) stddev-sans-first:26497.90 04:58:37 INFO - PROCESS | 13926 | Values: 637.5 664.8 674.7 698.7 752.1 11646.5 12836.4 12866.5 12898.9 12917.5 11860.9 11937.6 11945.1 11952.5 11974.6 618.9 753.0 755.4 777.2 781.7 791.0 792.5 794.0 794.5 796.0 829.6 833.9 835.2 835.3 835.5 653.4 795.3 813.8 817.0 831.0 599.9 600.0 600.0 600.7 600.8 13111.5 13132.7 13135.3 13146.9 13149.2 12324.9 12712.4 12927.5 13031.1 13078.8 11619.8 11646.8 11674.6 11729.4 11862.0 4082.6 4131.7 4142.1 4155.1 4168.7 59984.7 60140.0 60165.0 60794.0 61122.0 9928.6 9976.6 10131.3 10206.1 10385.0 18908.5 18979.8 18992.2 18993.7 19007.0 6676.6 6815.9 6879.1 6905.9 6973.0 3782.5 3867.5 3879.7 3911.0 3920.3 2888.7 2966.2 2985.5 2986.0 2996.1 401.4 445.1 449.1 456.2 456.7 480.4 526.7 530.8 558.0 559.2 7898.9 8116.8 8310.1 8382.0 8541.7 509.4 549.7 553.0 560.3 576.8 3633.4 3669.7 3755.8 3807.6 3860.9 99508.0 104939.5 105765.0 106103.0 107465.5 90285.5 90797.0 91107.5 91366.0 91444.0 49346.3 51624.0 57573.7 77939.6 80210.6 7379.6 7397.4 7410.4 7449.3 7471.2 47217.5 47756.3 48543.0 48949.8 49064.0 66233.3 70809.0 71252.3 71410.0 73229.0 9631.5 9778.4 9783.6 9825.9 9938.2 11521.7 11687.5 11688.2 11729.8 11884.9 8591.8 9310.0 10520.3 10657.9 10932.9 9186.4 9471.5 9477.0 9762.3 9840.7 9613.1 9762.6 11708.3 12081.3 12259.3 10286.0 10549.7 10923.0 11073.8 11438.7 10614.9 10718.7 10750.9 10779.3 10858.0 04:58:37 INFO - PROCESS | 13926 | -------- Summary: end -------- 04:58:37 INFO - PROCESS | 13926 | 04:58:38 INFO - TEST-INFO | 13926: exit 0 04:58:38 INFO - TEST-OK | dromaeo_css | took 1119439ms 04:58:38 INFO - TEST-START | kraken 04:58:38 INFO - operating with platform_type : linux_ 04:58:38 INFO - Initialising browser for kraken test... 04:58:38 INFO - TEST-INFO | started process 14116 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB4XJk9/profile http://localhost:49440/getInfo.html) 04:58:42 INFO - PROCESS | 14116 | __metrics Screen width/height:1600/1200 04:58:42 INFO - PROCESS | 14116 | colorDepth:24 04:58:42 INFO - PROCESS | 14116 | Browser inner width/height: 1024/697 04:58:42 INFO - PROCESS | 14116 | __metrics 04:58:42 INFO - PROCESS | 14116 | 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" 04:58:42 INFO - PROCESS | 14116 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:58:43 INFO - TEST-INFO | 14116: exit 0 04:58:43 INFO - Browser initialized. 04:58:43 INFO - Running cycle 1/1 for kraken test... 04:58:43 INFO - TEST-INFO | started process 14198 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB4XJk9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:58:55 INFO - PROCESS | 14198 | RSS: Main: 158699520 04:58:55 INFO - PROCESS | 14198 | 04:58:58 INFO - PROCESS | 14198 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49440/tests/kraken/driver.html?testName=audio-beat-detection) 04:58:59 INFO - PROCESS | 14198 | RSS: Main: 218415104 04:58:59 INFO - PROCESS | 14198 | 04:59:01 INFO - PROCESS | 14198 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49440/tests/kraken/driver.html?testName=audio-dft) 04:59:02 INFO - PROCESS | 14198 | RSS: Main: 205123584 04:59:02 INFO - PROCESS | 14198 | 04:59:05 INFO - PROCESS | 14198 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49440/tests/kraken/driver.html?testName=audio-fft) 04:59:06 INFO - PROCESS | 14198 | RSS: Main: 272216064 04:59:06 INFO - PROCESS | 14198 | 04:59:08 INFO - PROCESS | 14198 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49440/tests/kraken/driver.html?testName=audio-oscillator) 04:59:09 INFO - PROCESS | 14198 | RSS: Main: 182558720 04:59:09 INFO - PROCESS | 14198 | 04:59:11 INFO - PROCESS | 14198 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49440/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:59:11 INFO - PROCESS | 14198 | RSS: Main: 186470400 04:59:11 INFO - PROCESS | 14198 | 04:59:15 INFO - PROCESS | 14198 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49440/tests/kraken/driver.html?testName=imaging-darkroom) 04:59:15 INFO - PROCESS | 14198 | RSS: Main: 222199808 04:59:15 INFO - PROCESS | 14198 | 04:59:19 INFO - PROCESS | 14198 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49440/tests/kraken/driver.html?testName=imaging-desaturate) 04:59:19 INFO - PROCESS | 14198 | RSS: Main: 218275840 04:59:19 INFO - PROCESS | 14198 | 04:59:22 INFO - PROCESS | 14198 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49440/tests/kraken/driver.html?testName=json-parse-financial) 04:59:23 INFO - PROCESS | 14198 | RSS: Main: 221016064 04:59:23 INFO - PROCESS | 14198 | 04:59:25 INFO - PROCESS | 14198 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49440/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:59:25 INFO - PROCESS | 14198 | RSS: Main: 210702336 04:59:25 INFO - PROCESS | 14198 | 04:59:27 INFO - PROCESS | 14198 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49440/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:59:28 INFO - PROCESS | 14198 | RSS: Main: 214024192 04:59:28 INFO - PROCESS | 14198 | 04:59:30 INFO - PROCESS | 14198 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49440/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:59:31 INFO - PROCESS | 14198 | RSS: Main: 213843968 04:59:31 INFO - PROCESS | 14198 | 04:59:33 INFO - PROCESS | 14198 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49440/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:59:34 INFO - PROCESS | 14198 | RSS: Main: 226070528 04:59:34 INFO - PROCESS | 14198 | 04:59:37 INFO - PROCESS | 14198 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49440/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:59:37 INFO - PROCESS | 14198 | RSS: Main: 226676736 04:59:37 INFO - PROCESS | 14198 | 04:59:39 INFO - PROCESS | 14198 | Cycle 1(1): loaded http://localhost:49440/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49440/tests/kraken/driver.html?testName=ai-astar) 04:59:39 INFO - PROCESS | 14198 | RSS: Main: 270008320 04:59:39 INFO - PROCESS | 14198 | 04:59:39 INFO - PROCESS | 14198 | __start_tp_report 04:59:39 INFO - PROCESS | 14198 | _x_x_mozilla_page_load 04:59:39 INFO - PROCESS | 14198 | _x_x_mozilla_page_load_details 04:59:39 INFO - PROCESS | 14198 | |i|pagename|runs| 04:59:39 INFO - PROCESS | 14198 | |0;ai-astar;103;114;113;115;113;113;113;113;113;113 04:59:39 INFO - PROCESS | 14198 | |1;audio-beat-detection;153;121;125;194;121;123;155;121;153;123 04:59:39 INFO - PROCESS | 14198 | |2;audio-dft;162;162;162;161;161;162;163;163;161;163 04:59:39 INFO - PROCESS | 14198 | |3;audio-fft;76;75;75;108;77;78;76;75;102;76 04:59:39 INFO - PROCESS | 14198 | |4;audio-oscillator;85;84;121;84;85;84;113;84;85;128 04:59:39 INFO - PROCESS | 14198 | |5;imaging-gaussian-blur;117;117;117;117;117;116;116;117;118;117 04:59:39 INFO - PROCESS | 14198 | |6;imaging-darkroom;147;147;147;146;146;146;146;146;147;146 04:59:39 INFO - PROCESS | 14198 | |7;imaging-desaturate;95;94;95;94;95;94;94;94;94;95 04:59:39 INFO - PROCESS | 14198 | |8;json-parse-financial;63;61;61;63;62;62;71;61;74;61 04:59:39 INFO - PROCESS | 14198 | |9;json-stringify-tinderbox;65;66;76;66;66;65;67;66;65;66 04:59:39 INFO - PROCESS | 14198 | |10;stanford-crypto-aes;78;82;87;84;79;78;82;79;80;78 04:59:39 INFO - PROCESS | 14198 | |11;stanford-crypto-ccm;134;128;127;140;125;127;129;129;167;127 04:59:39 INFO - PROCESS | 14198 | |12;stanford-crypto-pbkdf2;164;165;164;168;162;163;161;169;165;166 04:59:39 INFO - PROCESS | 14198 | |13;stanford-crypto-sha256-iterative;69;66;66;66;66;67;66;64;67;65 04:59:39 INFO - PROCESS | 14198 | __end_tp_report 04:59:39 INFO - PROCESS | 14198 | __start_cc_report 04:59:39 INFO - PROCESS | 14198 | _x_x_mozilla_cycle_collect,1936 04:59:39 INFO - PROCESS | 14198 | __end_cc_report 04:59:39 INFO - PROCESS | 14198 | __startTimestamp1468670379835__endTimestamp 04:59:39 INFO - PROCESS | 14198 | 04:59:39 INFO - PROCESS | 14198 | ------- Summary: start ------- 04:59:39 INFO - PROCESS | 14198 | Number of tests: 14 04:59:39 INFO - PROCESS | 14198 | 04:59:39 INFO - PROCESS | 14198 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.00 stddev:3.33 (3.0%) stddev-sans-first:0.71 04:59:39 INFO - PROCESS | 14198 | Values: 103.0 114.0 113.0 115.0 113.0 113.0 113.0 113.0 113.0 113.0 04:59:39 INFO - PROCESS | 14198 | 04:59:39 INFO - PROCESS | 14198 | [#1] audio-beat-detection Cycles:10 Average:138.90 Median:139.00 stddev:24.39 (17.5%) stddev-sans-first:25.33 04:59:39 INFO - PROCESS | 14198 | Values: 153.0 121.0 125.0 194.0 121.0 123.0 155.0 121.0 153.0 123.0 04:59:39 INFO - PROCESS | 14198 | 04:59:39 INFO - PROCESS | 14198 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 04:59:39 INFO - PROCESS | 14198 | Values: 162.0 162.0 162.0 161.0 161.0 162.0 163.0 163.0 161.0 163.0 04:59:39 INFO - PROCESS | 14198 | 04:59:39 INFO - PROCESS | 14198 | [#3] audio-fft Cycles:10 Average:81.80 Median:76.00 stddev:12.35 (16.2%) stddev-sans-first:12.91 04:59:39 INFO - PROCESS | 14198 | Values: 76.0 75.0 75.0 108.0 77.0 78.0 76.0 75.0 102.0 76.0 04:59:39 INFO - PROCESS | 14198 | 04:59:39 INFO - PROCESS | 14198 | [#4] audio-oscillator Cycles:10 Average:95.30 Median:84.00 stddev:17.86 (21.3%) stddev-sans-first:18.55 04:59:39 INFO - PROCESS | 14198 | Values: 85.0 84.0 121.0 84.0 85.0 84.0 113.0 84.0 85.0 128.0 04:59:39 INFO - PROCESS | 14198 | 04:59:39 INFO - PROCESS | 14198 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 04:59:39 INFO - PROCESS | 14198 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 118.0 117.0 04:59:39 INFO - PROCESS | 14198 | 04:59:39 INFO - PROCESS | 14198 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 04:59:39 INFO - PROCESS | 14198 | Values: 147.0 147.0 147.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 04:59:39 INFO - PROCESS | 14198 | 04:59:39 INFO - PROCESS | 14198 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 04:59:39 INFO - PROCESS | 14198 | Values: 95.0 94.0 95.0 94.0 95.0 94.0 94.0 94.0 94.0 95.0 04:59:39 INFO - PROCESS | 14198 | 04:59:39 INFO - PROCESS | 14198 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:62.50 stddev:4.65 (7.4%) stddev-sans-first:4.92 04:59:39 INFO - PROCESS | 14198 | Values: 63.0 61.0 61.0 63.0 62.0 62.0 71.0 61.0 74.0 61.0 04:59:39 INFO - PROCESS | 14198 | 04:59:39 INFO - PROCESS | 14198 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:66.00 stddev:3.29 (5.0%) stddev-sans-first:3.43 04:59:39 INFO - PROCESS | 14198 | Values: 65.0 66.0 76.0 66.0 66.0 65.0 67.0 66.0 65.0 66.0 04:59:39 INFO - PROCESS | 14198 | 04:59:39 INFO - PROCESS | 14198 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:81.00 stddev:3.02 (3.7%) stddev-sans-first:3.04 04:59:39 INFO - PROCESS | 14198 | Values: 78.0 82.0 87.0 84.0 79.0 78.0 82.0 79.0 80.0 78.0 04:59:39 INFO - PROCESS | 14198 | 04:59:39 INFO - PROCESS | 14198 | [#11] stanford-crypto-ccm Cycles:10 Average:133.30 Median:129.00 stddev:12.62 (9.8%) stddev-sans-first:13.39 04:59:39 INFO - PROCESS | 14198 | Values: 134.0 128.0 127.0 140.0 125.0 127.0 129.0 129.0 167.0 127.0 04:59:39 INFO - PROCESS | 14198 | 04:59:39 INFO - PROCESS | 14198 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.70 Median:165.00 stddev:2.50 (1.5%) stddev-sans-first:2.64 04:59:39 INFO - PROCESS | 14198 | Values: 164.0 165.0 164.0 168.0 162.0 163.0 161.0 169.0 165.0 166.0 04:59:39 INFO - PROCESS | 14198 | 04:59:39 INFO - PROCESS | 14198 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.00 stddev:1.32 (2.0%) stddev-sans-first:0.93 04:59:39 INFO - PROCESS | 14198 | Values: 69.0 66.0 66.0 66.0 66.0 67.0 66.0 64.0 67.0 65.0 04:59:39 INFO - PROCESS | 14198 | -------- Summary: end -------- 04:59:39 INFO - PROCESS | 14198 | 04:59:40 INFO - TEST-INFO | 14198: exit 0 04:59:40 INFO - TEST-OK | kraken | took 62854ms 04:59:40 INFO - SUITE-END | took 1182s 04:59:40 INFO - Completed test suite (00:19:42) 04:59:40 INFO - javascript benchmark 04:59:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2635.3148181472816, 2635.617835413866, 2668.4529671417363, 2675.57190849464, 2677.3039009857443, 4708.646851486135, 4715.55202255786, 4735.455422626399, 4781.737004464753, 4803.8799030024265, 4730.621550275978, 4737.502562230968, 4748.6913350632185, 4808.687435316702, 4816.181249187638, 4191.706580539363, 4389.144116897206, 4466.5980061794435, 4514.119746649405, 4524.049949510607, 4430.069685366061, 4469.7988590513505, 4482.17079840229, 4489.730616163024, 4519.502854685982, 4292.18448494785, 4347.239233134221, 4370.759608221547, 4401.713888597231, 4433.113377324548, 4373.562643735633, 4384.780760961939, 4389.385486031958, 4457.799399027052, 4494.797734101973, 4427.933580996288, 4440.822367105312, 4442.2892337225885, 4444.73331600105, 4486.237339652267, 4559.475660299075, 4659.510751371091, 4749.216379297412, 4825.710457372534, 4863.635227357962, 5186.0665080285535, 5195.9740201298755, 5216.947830521722, 5218.0, 5223.921641175385, 5190.558802501791, 5216.217567364888, 5232.738363081869, 5237.16205407133, 5239.292695486099, 4721.055788842245, 4792.185328494094, 4834.057358815067, 4837.95162048382, 4843.055604157155, 5278.788848446019, 5307.0, 5313.203019547099, 5370.301860758076, 5372.677639341652, 5093.2360145977655, 5096.362954630671, 5097.08252514551, 5127.666701664454, 5155.948440515547, 4938.506149385033, 4977.825776097891, 5079.111155547765, 5107.642465027412, 5163.948360516347, 5109.642325037212, 5121.027004869063, 5122.257272695439, 5144.202648589475, 5146.382434107856, 5093.490650934951, 5101.285819985205, 5116.360454943132, 5118.641695081308, 5148.819791307361, 4315.805788739514, 4357.607815296575, 4358.738475691469, 4408.6913916026215, 4413.801378937956, 3855.325318069383, 3868.4777555030273, 3875.3411919973673, 3896.7467114637457, 3897.3569361055106, 4375.7155784873885, 4420.359047938031, 4421.867343979686, 4437.467503899488, 4460.063386688832, 5178.844634660966, 5182.6372153949615, 5183.688978661217, 5196.688198708014, 5241.528262456397, 4300.6989510734575, 4413.867583972486, 4422.270325396274, 4434.024514606781, 4479.148961697267, 4581.221192397301, 4583.427071616048, 4591.678582499193, 4596.2416201326405, 4608.423947006624, 4751.619870410359, 4758.1435341638835, 4758.571728544448, 4760.404949381327, 4800.7359595221205, 5011.574016208663, 5070.391553013662, 5090.796368145381, 5123.410807757155, 5193.350831146106, 4703.176944034712, 4757.072370887644, 4784.47370789206, 4805.159097158054, 4839.41926968766, 5051.393832739947, 5052.040112378636, 5055.368078990126, 5061.822836200715, 5099.77051032697, 5128.205128205134, 5128.205128205134, 5135.0, 5139.897202055863, 5139.948600513947, 4875.634327425386, 4882.902341953212, 4915.336429581961, 4929.531694489161, 4941.0, 4920.950790492049, 4924.901501970012, 4927.60579153674, 4930.926036109533, 4940.308356830118, 4797.56821886032, 4852.150873597036, 4857.9514204858915, 4864.975675121602, 4916.213405855046, 4984.928240428325, 5034.370703662043, 5036.395632524121, 5053.8736531587, 5060.3168572242275, 4932.950670493393, 4941.579965702812, 4947.554720075211, 4948.678335908155, 5000.499950004971], "value": 4707.836079857811, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.6932925549459, 589.0281036290121, 616.5098746496535, 617.3517806303383, 623.1276213301375, 39322.80338598307, 41153.0, 41207.17585648289, 44704.55295447045, 44736.776316118456, 42084.368734469004, 42683.0, 42688.0, 42775.0, 42856.357154642705, 7518.436117291198, 7948.841023179533, 8053.798655033642, 8086.353091752675, 10491.16070714341, 10335.328203666775, 10381.532831022585, 10409.791804163911, 10410.323328983592, 10414.531346089407, 10382.169426445866, 10428.530716117793, 10435.53902453657, 10438.739031524236, 10477.895221047767, 7553.7356192533, 10168.79662406755, 10395.064444200021, 10423.322484038514, 10447.738806529822, 10262.281640285182, 10328.741781455448, 10331.380117192992, 10337.121344685711, 10354.223433242538, 39076.0, 39144.41283380752, 39313.21373572541, 39330.60669393298, 39349.60650393488, 2582.0704546363295, 3151.6848315168527, 3187.6015498062743, 3315.386653469116, 3523.8195204606486, 29829.552556711667, 30141.849290753624, 30301.393972120655, 30367.848160759277, 31240.062798116094, 3303.752218583592, 3309.321589074234, 3321.1653421128694, 3374.4263475209273, 3383.120388698956, 272735.0, 273911.6304418485, 274026.0, 274218.0, 274733.0, 42489.36265956013, 45943.77028114838, 52246.0, 52650.0, 52759.472405275454, 54565.727171364684, 54769.45230547723, 54905.45094549083, 55060.72469637706, 55064.59483241411, 15107.0, 15272.694546109016, 15303.92348038275, 15305.540833775005, 15312.923435382752, 10152.746181345377, 10833.891661083446, 11092.057175140204, 11130.49912753928, 11382.089432845352, 15665.138417386925, 15699.136547489768, 15812.92093539525, 15848.841511584968, 15882.285297161656, 5818.418158184148, 5906.438888305604, 5932.970335148297, 6047.697615119227, 6068.0, 845.8054647431126, 941.8540126280437, 991.306085739985, 996.0, 1037.1443559063803, 27420.725792742218, 28609.919417779987, 28678.85660571684, 28814.279643009093, 28867.711322886502, 936.9531523423938, 952.2667545989549, 999.1457304005116, 1037.1961729659574, 1038.7351225437465, 14044.578662640137, 14540.709185816224, 14541.200233987021, 14700.044497107654, 14815.259237038104, 387593.0, 391212.0, 391365.0, 392231.0, 392609.0, 47301.5269847304, 47470.05059898783, 47555.76222118867, 47556.7622161887, 47707.0, 1110.6723516562633, 1147.3804145761362, 1147.7761836441814, 1190.9702257443632, 1216.8661447240797, 19903.800961990193, 28301.150965470246, 28311.29221769472, 28708.425831482837, 29047.0, 40735.1852962945, 41152.0, 41155.58844411517, 41176.0, 41275.793621031706, 299971.0, 301985.0, 304677.0, 305719.0, 307266.0, 21819.890900545397, 22464.0, 24003.15988940379, 24115.517689646458, 24605.507889841745, 40801.795991019855, 40964.38553421761, 41038.0, 41204.58795412127, 41253.1749365017, 35114.47328290027, 35294.47058294179, 35831.82084089563, 36085.639143609274, 36122.0, 33508.1622959428, 34570.48144277888, 34786.82606586951, 34938.0, 35276.47085293774, 35077.824610876785, 35184.29631407409, 35539.0, 35660.28679426449, 36285.0, 29157.7084229155, 30964.53553196749, 33434.83282583669, 33650.83174584111, 33684.66315336815, 25071.122510712037, 25740.485190296462, 25777.613335800354, 25903.870480647474, 26230.08194713176], "value": 17973.745940532164, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.7765517378866, 380.288859832114, 383.4095492940871, 383.44166138237154, 403.1252182763403, 16227.432039878606, 17047.829521704778, 17408.825911740878, 17624.11879406031, 17650.0, 14505.637359066028, 14803.25983700816, 17310.221040053195, 17469.213885375157, 17761.20074596643, 5086.694798312104, 5292.973535132319, 5293.179557168645, 5323.281357016811, 5332.680039197641, 3772.9811350943205, 3997.040710229553, 5934.495567876736, 6234.189555357797, 6245.56281060326, 5160.200168973815, 6278.246610406758, 6280.591761535486, 6301.558890877641, 6312.526560507958, 5483.369412517552, 5554.250176226198, 5580.665160090408, 5585.636933599303, 5590.245316882229, 3312.8343582821003, 5044.899102017976, 5332.386775520826, 5335.33308336458, 5487.149491828733, 12269.815952760715, 12304.384780761016, 12320.075994300374, 12355.93822030884, 12475.064370172273, 1884.679604467244, 1885.2930151193302, 1917.0702209428416, 1924.8845069295887, 2024.7165396844453, 8501.61742721579, 9418.811623767486, 9660.584853786553, 11515.884841151565, 13193.670158246025, 1712.6745918275487, 1757.534253422844, 1766.3376233912284, 1766.9116544172869, 1778.3597904754279, 64396.67801661009, 64924.67537662329, 66169.66915165441, 69953.3004669957, 71838.0, 10006.19950403966, 10197.490125493696, 10290.485475726184, 10395.272330936761, 10518.211134164969, 14132.57602271913, 14139.43442262298, 14171.716565668628, 14235.0, 14246.791747278981, 7489.550626962399, 7601.391888648895, 7674.040744906887, 7702.614869256515, 7741.61291935401, 7418.443616728767, 7469.141048779351, 7572.545647261182, 7670.501417407851, 7695.384369250447, 4363.978180109143, 4370.803313850821, 4400.119976004812, 4449.13241917823, 4546.681732278775, 1584.429605342076, 1678.8208377156366, 1678.860530807398, 1692.69531484334, 1745.5810605454853, 879.8020445399734, 892.9464232146092, 923.3628796130782, 950.8954015058338, 955.7562821480617, 16862.156892155344, 16940.40708575194, 17081.31674732997, 17103.973761574347, 17385.91307043482, 792.5878543157526, 809.3039985612369, 825.6160885188297, 850.4812064640564, 856.0797143071223, 8202.630881610341, 9660.75848103803, 9870.802583948282, 9881.555330010167, 10082.395056296646, 394597.0, 402642.0, 405528.0, 406437.0, 407309.0, 76911.23088769152, 79360.0, 79615.0, 79965.60017199993, 80150.59924700456, 809.3039985612369, 852.5609311204735, 878.9648414063494, 882.139913584263, 883.8762573239752, 15313.693726125191, 15535.300911458786, 15593.142377169364, 15668.76496852571, 16084.276207570454, 37197.44203836891, 37494.250114998096, 37963.0, 38959.41560876646, 39062.2187556253, 48668.0, 48678.26982595193, 52381.0, 52678.0, 52719.0, 6574.539782215199, 6989.860202795814, 7132.928670713434, 7236.782896513113, 7294.96352518234, 10773.138148947908, 11162.218644694793, 11286.15353848481, 11577.479013444583, 11845.230060046415, 9735.9026409735, 9770.609175633179, 9833.16418104469, 9874.259430542594, 10120.645777397756, 9659.71020869375, 9962.701118966443, 10008.199344052604, 10071.597136114473, 10252.794944101226, 10158.288919775545, 10473.738156546147, 10546.0, 10568.947155264175, 10574.312669676447, 7078.079849619517, 7139.607321597362, 7222.458315626244, 7385.003024591611, 7405.7778266652085, 9532.52337383142, 10334.638287660197, 10370.688879333633, 10462.372257664565, 10468.63359782404], "value": 8130.941045297956, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1340.0619566303587, 1416.2069241224915, 1489.5997762103623, 1694.2291257477848, 1765.2674140231798, 7769.611519424035, 8215.83568328633, 8298.585070746454, 8307.750767476979, 8316.0, 6923.826904327382, 7566.319031287183, 7874.488158269708, 7882.527048377101, 7891.9210807891905, 2213.092632020872, 2273.499830037389, 2282.1784157703214, 2295.276987748862, 2297.081167532992, 1881.1722841949568, 2249.876256805875, 2250.077468238023, 2305.942351441219, 2306.4925716342377, 2117.841161912863, 2190.6823510590953, 2215.3353993801875, 2224.2659922225625, 2234.497238121426, 2217.46780772615, 2231.3306008197555, 2231.7768223177554, 2243.4279258789065, 2246.4608493961496, 2208.1829723002593, 2214.147553192033, 2216.6342553478657, 2216.8448208625405, 2243.32700189944, 8021.879671804928, 8067.677292908276, 8070.878936815952, 8075.232852878967, 8079.757607271791, 4646.628269738413, 4805.183118869801, 4808.975955120237, 4815.951840481585, 4816.8073277069225, 2802.6776920654183, 2973.3310005248863, 3010.202296391458, 3024.7882648214413, 3029.3486900316316, 928.5264515097282, 971.4851128901623, 980.8822941247024, 986.5856340337004, 991.1971303244395, 10819.621313254078, 10949.562017519289, 11037.11703063761, 11041.282316649393, 11056.668299951014, 4120.196561670446, 4415.757133357632, 4421.159979603929, 4421.823127074946, 4422.447194100738, 9602.231821454267, 9662.275329350327, 9672.613095476103, 9673.9032609673, 9677.758056048515, 4833.830815921497, 4849.151398505247, 4851.878703032382, 4852.344933434012, 4854.490278520775, 4262.680298977527, 4356.302991521341, 4360.4331436913, 4399.450068741407, 4423.51341352451, 3682.6869716074434, 3686.870959516404, 3778.6410291022307, 3813.504244448204, 3814.904627384338, 1107.7119948813368, 1191.1721353659298, 1196.4316949449117, 1230.4524486603375, 1233.7039110613389, 762.7063580521428, 778.1712476212815, 785.3050050705053, 797.2266901105918, 798.297498201579, 4681.087187998376, 4698.459677137173, 4738.360321356642, 4751.477337492873, 4794.5924596409695, 804.3082948664144, 837.4807619276088, 852.3607294529103, 853.9274161696201, 858.5235194467131, 3047.527633216855, 3120.7347375472887, 3137.341158356725, 3153.5112057631104, 3194.632617249, 9527.38072025316, 9887.209023278121, 9896.10935015852, 9906.55420506079, 10009.099181073738, 8610.741677749553, 9311.441313521074, 9907.900920990842, 9913.653022144335, 9919.40483570988, 7044.788656340318, 7122.323379278961, 7189.1013623297085, 7197.532160409662, 7200.451902840809, 5315.707636080053, 5354.732263386737, 5446.346438427414, 5518.586106042143, 5530.585206109477, 9074.500902450429, 9236.584353703965, 9383.859242111237, 9388.95305523468, 9389.577469013775, 9356.391834530734, 9440.858387124335, 9488.288378371511, 9656.855147172939, 9695.0, 6789.355011273921, 6823.283555226828, 6869.244383117753, 6910.7581234656545, 6919.238883722887, 7594.240575942362, 7727.729529466442, 7760.611969401394, 7790.9220907790195, 7796.532208067534, 6807.0, 6994.6852391643515, 7021.0872586565465, 7021.297870212938, 7064.964675176591, 6688.765893193715, 6718.966405167943, 6984.860302794017, 7006.159260888726, 7042.7887163385185, 6183.96908015457, 6217.720202590804, 6219.813405597839, 6242.531810114168, 6242.719077641608, 4389.100234451866, 4461.375407442895, 4485.349624304523, 4488.169688607488, 4505.369248305175, 4393.802278897521, 4452.755098469615, 4510.706804057726, 4658.20810462229, 4693.601043911306], "value": 4193.925751336497, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.988120475181, 300.0638009410639, 306.12906281628767, 313.2028986230043, 315.41805369094016, 4866.197077482211, 4874.829380971667, 4875.146849301375, 4901.852944411665, 4924.729139897304, 4809.783559739812, 4813.302071199674, 4839.637027222963, 4858.975705121469, 4862.756862156895, 3591.658792414723, 3695.5380577427823, 3751.981240093796, 3829.9617003829885, 3854.1713531590703, 3789.488419063419, 3821.866234681787, 3837.6354246346555, 3847.3074846527616, 3850.5571859236265, 3785.867494637688, 3794.601566835484, 3800.220954704293, 3811.1805961718223, 3821.464994900716, 3527.417976033951, 3648.872289469869, 3786.753860999054, 3789.7408228923105, 3797.5442946846556, 3374.5106959490736, 3375.476801095834, 3376.0547046826928, 3384.983075084609, 3385.7460690448315, 4743.667943243974, 4748.124490826139, 4754.524547545252, 4771.6898401603785, 4790.616750659939, 4228.72273987659, 4310.978445107754, 4357.738535687838, 4372.213001659732, 4384.868453946355, 5001.249812528114, 5031.245313203012, 5038.420581633122, 5040.621953353513, 5054.62090343222, 3699.0, 3703.6111208323277, 3704.685101766353, 3706.3328600851837, 3733.533308336458, 5192.792288308463, 5313.237116699294, 5330.440303768088, 5342.679439233659, 5357.4106848246665, 3761.4545890845675, 3764.5670747863796, 3771.585125636178, 3775.9433608495897, 3776.339140650375, 3853.190829925747, 3854.3447613905705, 3858.7298889077497, 3863.6715879150024, 3876.379779235309, 4332.393464914914, 4353.82584696615, 4357.825686972549, 4360.956390436118, 4372.715773474714, 4847.345608342828, 4994.1759609663995, 4999.150314383629, 5069.0, 5081.415637201695, 1302.9218246905216, 1314.2705798281854, 1321.6563693439775, 1322.5966080345586, 1328.9401976911063, 810.7121971700079, 859.8366310401004, 870.5429649433971, 900.2213085680839, 927.7197467494814, 4392.494863090722, 4407.735535867794, 4410.213863385334, 4425.84509542171, 4434.534373890695, 5116.641835071584, 5129.948700513021, 5138.871528211825, 5168.095583272912, 5201.895962080737, 4218.535961044283, 4353.25994580922, 4388.978055109768, 4391.98984233628, 4404.66964977628, 2783.5268004439295, 2787.665480142355, 2800.6079148919166, 2804.453131639311, 2822.1251412062325, 4970.925436118461, 4980.161308054374, 4994.303076338736, 4999.225120106389, 5004.174311238678, 5285.894282114413, 5368.355797304349, 5369.48989845964, 5461.098918678374, 5467.20725494809, 4867.829625963074, 4913.361263035782, 4934.851954441372, 4954.9752251238515, 4956.529129732669, 5169.4830516948, 5200.6879587224885, 5217.895642087213, 5229.607779416635, 5233.377652927605, 4885.5358740919555, 5114.514121158484, 5116.9232461512365, 5177.8187763428095, 5188.584913206859, 4919.3604831371695, 4933.457319694759, 4938.283948827472, 4938.876528086683, 4950.628702847229, 3742.1954279829965, 3766.0584853786554, 3772.43413487979, 3786.9017984784105, 3797.7911214883447, 5099.745012749422, 5279.8680032997945, 5285.894282114259, 5309.203619457112, 5347.171188465794, 5064.5441910228255, 5081.618878584195, 5101.240072175094, 5115.718635474936, 5120.641555091108, 5077.213031980049, 5121.641485096007, 5125.615578831677, 5144.356955380577, 5155.118381790545, 4907.73751808706, 4923.458419573915, 5003.649744517995, 5031.924521132113, 5058.772355244097, 4875.8049678012485, 5018.84943451697, 5142.588592912483, 5148.6910785353, 5169.302144210634, 4987.80048798044, 5033.395992480926, 5039.034776437119, 5041.143005689115, 5049.4094360276395], "value": 3848.4843997783632, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [637.5295729049932, 664.7507184805697, 674.7402250133697, 698.7004172239633, 752.059925093633, 11646.534138634455, 12836.422360993754, 12866.485340586389, 12898.871011289884, 12917.483300667975, 11860.881391186085, 11937.641870743892, 11945.104117191202, 11952.462139203735, 11974.580889668863, 618.8855061813556, 752.9887051694229, 755.3617193471536, 777.2460713108276, 781.6599779096083, 790.9920900790976, 792.5165648954134, 794.027316537243, 794.4756460735887, 796.040770871099, 829.5686243153557, 833.9082700902895, 835.2274146414572, 835.2566216067704, 835.51122593283, 653.3923451190415, 795.2842441802367, 813.772143799737, 816.9550674712889, 830.9501429914194, 599.865030368168, 599.9610025348383, 599.9670018149, 600.6756351570191, 600.7777122464717, 13111.47554097835, 13132.737345253137, 13135.277559734212, 13146.86853131466, 13149.21104733719, 12324.876751232463, 12712.364381780966, 12927.48290068396, 13031.087823852335, 13078.803817942739, 11619.825702614467, 11646.825297620542, 11674.591389301333, 11729.413529323585, 11862.0, 4082.5917408259234, 4131.690123240769, 4142.06803469217, 4155.148194620096, 4168.7290326128705, 59984.700076499335, 60140.0, 60164.99999999956, 60794.0, 61122.0, 9928.620357593209, 9976.60093596248, 10131.290809643402, 10206.13247873939, 10385.0, 18908.527286817665, 18979.810201897802, 18992.240310387708, 18993.715094273597, 19007.0, 6676.566023208476, 6815.863682726417, 6879.140107486564, 6905.896411553831, 6972.965135174393, 3782.527184101987, 3867.5358956925347, 3879.728419010642, 3910.9804450977563, 3920.3335432976464, 2888.725571070745, 2966.2139533023765, 2985.4924662807375, 2985.9552106718415, 2996.056242283674, 401.44199562608, 445.05425969814144, 449.0771464640131, 456.2084782901663, 456.7373760087963, 480.3563225278144, 526.6760942020629, 530.7850320620155, 557.9665220086807, 559.2394343692575, 7898.9210107899335, 8116.837663246702, 8310.127436619068, 8382.0, 8541.743747687578, 509.38110196111904, 549.7031602934451, 552.9797523569009, 560.2800401484074, 576.7808232871566, 3633.364161271767, 3669.743117981769, 3755.75587586806, 3807.562130354989, 3860.942085868714, 99508.0, 104939.475302623, 105765.0, 106103.0, 107465.46267268613, 90285.54857225672, 90797.0, 91107.54446227859, 91365.99999999868, 91444.0, 49346.259806102935, 51624.0, 57573.712131439075, 77939.61030194926, 80210.59894700606, 7379.594122323324, 7397.445191610758, 7410.407167426485, 7449.255074492507, 7471.215522370073, 47217.527824721314, 47756.2836557445, 48543.0, 48949.75525122351, 49064.018719626125, 66233.33766662271, 70809.0, 71252.28747712457, 71410.0, 73229.0, 9631.470269135265, 9778.41329520231, 9783.559739811868, 9825.9017409825, 9938.204943604638, 11521.711957201138, 11687.532498699957, 11688.240264382788, 11729.765404691687, 11884.881151188378, 8591.785205369915, 9310.0, 10520.263581549218, 10657.89342106569, 10932.945335273273, 9186.356955013085, 9471.526423678926, 9476.95261523688, 9762.316637835283, 9840.65557705477, 9613.086756758097, 9762.560684769345, 11708.297502149899, 12081.335526546125, 12259.264444133023, 10286.0, 10549.73625659334, 10923.0, 11073.778524429628, 11438.656840294805, 10614.89385106139, 10718.73203169927, 10750.946245269037, 10779.299345542828, 10858.0], "value": 6467.3302971008725, "unit": "score"}], "name": "dromaeo_css", "value": 6447.344987258204, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 113.0, 115.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 121.0, 125.0, 194.0, 121.0, 123.0, 155.0, 121.0, 153.0, 123.0], "value": 138.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 161.0, 161.0, 162.0, 163.0, 163.0, 161.0, 163.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 108.0, 77.0, 78.0, 76.0, 75.0, 102.0, 76.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 121.0, 84.0, 85.0, 84.0, 113.0, 84.0, 85.0, 128.0], "value": 95.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 118.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 61.0, 63.0, 62.0, 62.0, 71.0, 61.0, 74.0, 61.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 76.0, 66.0, 66.0, 65.0, 67.0, 66.0, 65.0, 66.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 82.0, 87.0, 84.0, 79.0, 78.0, 82.0, 79.0, 80.0, 78.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 128.0, 127.0, 140.0, 125.0, 127.0, 129.0, 129.0, 167.0, 127.0], "value": 133.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 164.0, 168.0, 162.0, 163.0, 161.0, 169.0, 165.0, 166.0], "value": 164.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 66.0, 66.0, 66.0, 67.0, 66.0, 64.0, 67.0, 65.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1523.6, "alertThreshold": 2.0}]} 04:59:41 INFO - Return code: 0 04:59:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:59:41 INFO - # TBPL SUCCESS # 04:59:41 INFO - Running post-action listener: _resource_record_post_action 04:59:41 INFO - ##### 04:59:41 INFO - ##### Finished run-tests step (success) 04:59:41 INFO - ##### 04:59:41 INFO - Running post-run listener: _resource_record_post_run 04:59:41 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 208896; Write bytes: 536039424; Read time: 348; Write time: 454668 04:59:41 INFO - TinderboxPrint: CPU usage
13.0% 04:59:41 INFO - TinderboxPrint: I/O read bytes / time
208,896 / 348 04:59:41 INFO - TinderboxPrint: I/O write bytes / time
536,039,424 / 454,668 04:59:41 INFO - TinderboxPrint: CPU idle
8,327.6 (87.0%) 04:59:41 INFO - TinderboxPrint: CPU user
1,202.1 (12.6%) 04:59:41 INFO - TinderboxPrint: Swap in / out
0 / 0 04:59:41 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247152640; Read time: 0; Write time: 263824 04:59:41 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 204800; Write bytes: 288886784; Read time: 332; Write time: 190844 04:59:41 INFO - Running post-run listener: _upload_blobber_files 04:59:41 INFO - Blob upload gear active. 04:59:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:59:41 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 04:59:41 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'] 04:59:41 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 04:59:42 INFO - (blobuploader) - INFO - Open directory for files ... 04:59:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:59:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:59:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:59:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:59:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:59:56 INFO - (blobuploader) - INFO - Done attempting. 04:59:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:59:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:59:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:59:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:59:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:59:57 INFO - (blobuploader) - INFO - Done attempting. 04:59:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:59:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:59:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:59:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:59:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:59:57 INFO - (blobuploader) - INFO - Done attempting. 04:59:57 INFO - (blobuploader) - INFO - Iteration through files over. 04:59:57 INFO - Return code: 0 04:59:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:59:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:59:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fc44b7d8a97e456756b8720c1075a6d35d742ea96f602087bb012294dbcda84f6cc843bafc815eba3b0c74d0bde6bfc5ac92dec481d51f86cd2ddb220116daa9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6173228fec136f92a16ae201d0b4eeaa515ce864dbc1a6b3b58bf3472a03ab4e314759b31c9ebb0a0f44d90cd29fde1088a5291f0c55ff4cd299e2b90e478946", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/da2954b483737d60593243323b3482ca133e2f5323efab226182cbd22c94bdf211a52eeea3d4b92326defc5730a04a937de9af6c8c83c9a490fb29a6eb461347"} 04:59:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:59:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:59:57 INFO - Contents: 04:59:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fc44b7d8a97e456756b8720c1075a6d35d742ea96f602087bb012294dbcda84f6cc843bafc815eba3b0c74d0bde6bfc5ac92dec481d51f86cd2ddb220116daa9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6173228fec136f92a16ae201d0b4eeaa515ce864dbc1a6b3b58bf3472a03ab4e314759b31c9ebb0a0f44d90cd29fde1088a5291f0c55ff4cd299e2b90e478946", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/da2954b483737d60593243323b3482ca133e2f5323efab226182cbd22c94bdf211a52eeea3d4b92326defc5730a04a937de9af6c8c83c9a490fb29a6eb461347"} 04:59:57 INFO - Running post-run listener: copy_logs_to_upload_dir 04:59:57 INFO - Copying logs to upload dir... 04:59:57 INFO - mkdir: /builds/slave/test/build/upload/logs 04:59:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.394034 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-07-16 04:59:57.846464) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 04:59:57.851779) ========= 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=1f5564757af27664ca02d71f000001b0-1468669012.189267-1996861812 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/fc44b7d8a97e456756b8720c1075a6d35d742ea96f602087bb012294dbcda84f6cc843bafc815eba3b0c74d0bde6bfc5ac92dec481d51f86cd2ddb220116daa9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6173228fec136f92a16ae201d0b4eeaa515ce864dbc1a6b3b58bf3472a03ab4e314759b31c9ebb0a0f44d90cd29fde1088a5291f0c55ff4cd299e2b90e478946", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/da2954b483737d60593243323b3482ca133e2f5323efab226182cbd22c94bdf211a52eeea3d4b92326defc5730a04a937de9af6c8c83c9a490fb29a6eb461347"} build_url:https://queue.taskcluster.net/v1/task/YhPIAQ-ZQoixyf7H4MRFUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011135 build_url: 'https://queue.taskcluster.net/v1/task/YhPIAQ-ZQoixyf7H4MRFUQ/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/fc44b7d8a97e456756b8720c1075a6d35d742ea96f602087bb012294dbcda84f6cc843bafc815eba3b0c74d0bde6bfc5ac92dec481d51f86cd2ddb220116daa9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6173228fec136f92a16ae201d0b4eeaa515ce864dbc1a6b3b58bf3472a03ab4e314759b31c9ebb0a0f44d90cd29fde1088a5291f0c55ff4cd299e2b90e478946", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/da2954b483737d60593243323b3482ca133e2f5323efab226182cbd22c94bdf211a52eeea3d4b92326defc5730a04a937de9af6c8c83c9a490fb29a6eb461347"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 04:59:57.877087) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 04:59:57.877439) ========= 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=1f5564757af27664ca02d71f000001b0-1468669012.189267-1996861812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004502 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 04:59:57.960093) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 04:59:57.960423) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 04:59:57.960740) ========= ========= Total master_lag: 0.17 =========