builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-047 starttime: 1468449241.08 results: success (0) buildid: 20160713150842 builduid: 1dc57e1b531147deace0d75c598d3151 revision: c492812c7932a78769ae2ddad321b725e09fd9ea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 15:34:01.078220) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 15:34:01.078733) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 15:34:01.079017) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 15:34:01.119768) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 15:34:01.120126) ========= 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=03627c79f6bb3d1578c4a402000001ba-1468448863.968818-1376647508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-13 15:34:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 32.6M=0s 2016-07-13 15:34:01 (32.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096224 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 15:34:01.229992) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 15:34:01.230284) ========= 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=03627c79f6bb3d1578c4a402000001ba-1468448863.968818-1376647508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014688 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 15:34:01.294754) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 15:34:01.295078) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c492812c7932a78769ae2ddad321b725e09fd9ea --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 c492812c7932a78769ae2ddad321b725e09fd9ea --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=03627c79f6bb3d1578c4a402000001ba-1468448863.968818-1376647508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-13 15:34:01,382 truncating revision to first 12 chars 2016-07-13 15:34:01,382 Setting DEBUG logging. 2016-07-13 15:34:01,382 attempt 1/10 2016-07-13 15:34:01,382 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c492812c7932?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 15:34:01,680 unpacking tar archive at: fx-team-c492812c7932/testing/mozharness/ program finished with exit code 0 elapsedTime=0.629031 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 15:34:01.937796) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 15:34:01.938084) ========= script_repo_revision: c492812c7932a78769ae2ddad321b725e09fd9ea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 15:34:01.938449) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 15:34:01.938724) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 15:34:01.948875) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-07-13 15:34:01.949157) ========= /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=03627c79f6bb3d1578c4a402000001ba-1468448863.968818-1376647508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:34:02 INFO - MultiFileLogger online at 20160713 15:34:02 in /builds/slave/test 15:34:02 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 15:34:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:34:02 INFO - {'append_to_log': False, 15:34:02 INFO - 'base_work_dir': '/builds/slave/test', 15:34:02 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:34:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:34:02 INFO - 'branch': 'Fx-Team-Non-PGO', 15:34:02 INFO - 'buildbot_json_path': 'buildprops.json', 15:34:02 INFO - 'config_files': ('talos/linux_config.py',), 15:34:02 INFO - 'default_actions': ('clobber', 15:34:02 INFO - 'read-buildbot-config', 15:34:02 INFO - 'download-and-extract', 15:34:02 INFO - 'populate-webroot', 15:34:02 INFO - 'create-virtualenv', 15:34:02 INFO - 'install', 15:34:02 INFO - 'run-tests'), 15:34:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:34:02 INFO - 'download_minidump_stackwalk': True, 15:34:02 INFO - 'download_symbols': 'ondemand', 15:34:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:34:02 INFO - 'tooltool.py': '/tools/tooltool.py', 15:34:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:34:02 INFO - '/tools/misc-python/virtualenv.py')}, 15:34:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:34:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:34:02 INFO - 'installer_path': 'installer.exe', 15:34:02 INFO - 'log_level': 'info', 15:34:02 INFO - 'log_name': 'talos', 15:34:02 INFO - 'log_to_console': True, 15:34:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:34:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:34:02 INFO - 'opt_config_files': (), 15:34:02 INFO - 'pip_index': False, 15:34:02 INFO - 'sps_profile': False, 15:34:02 INFO - 'sps_profile_interval': 0, 15:34:02 INFO - 'suite': 'dromaeojs', 15:34:02 INFO - 'system_bits': '32', 15:34:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:34:02 INFO - 'title': 'talos-linux64-ix-047', 15:34:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:34:02 INFO - 'use_talos_json': True, 15:34:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:34:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:34:02 INFO - 'work_dir': 'build'} 15:34:02 INFO - ##### 15:34:02 INFO - ##### Running clobber step. 15:34:02 INFO - ##### 15:34:02 INFO - Running pre-action listener: _resource_record_pre_action 15:34:02 INFO - Running main action method: clobber 15:34:02 INFO - rmtree: /builds/slave/test/build 15:34:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:34:02 INFO - Running post-action listener: _resource_record_post_action 15:34:02 INFO - ##### 15:34:02 INFO - ##### Finished clobber step (success) 15:34:02 INFO - ##### 15:34:02 INFO - ##### 15:34:02 INFO - ##### Running read-buildbot-config step. 15:34:02 INFO - ##### 15:34:02 INFO - Running pre-action listener: _resource_record_pre_action 15:34:02 INFO - Running main action method: read_buildbot_config 15:34:02 INFO - Using buildbot properties: 15:34:02 INFO - { 15:34:02 INFO - "project": "", 15:34:02 INFO - "product": "firefox", 15:34:02 INFO - "script_repo_revision": "production", 15:34:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:34:02 INFO - "repository": "", 15:34:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 15:34:02 INFO - "buildid": "20160713150842", 15:34:02 INFO - "pgo_build": "False", 15:34:02 INFO - "basedir": "/builds/slave/test", 15:34:02 INFO - "buildnumber": 1990, 15:34:02 INFO - "slavename": "talos-linux64-ix-047", 15:34:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:34:02 INFO - "platform": "ubuntu64_hw", 15:34:02 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:34:02 INFO - "branch": "fx-team", 15:34:02 INFO - "repo_path": "integration/fx-team", 15:34:02 INFO - "revision": "c492812c7932a78769ae2ddad321b725e09fd9ea", 15:34:02 INFO - "stage_platform": "linux64", 15:34:02 INFO - "builduid": "1dc57e1b531147deace0d75c598d3151", 15:34:02 INFO - "slavebuilddir": "test" 15:34:02 INFO - } 15:34:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/KyubbALUSB2giMToRnvy-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 15:34:02 INFO - Running post-action listener: _resource_record_post_action 15:34:02 INFO - ##### 15:34:02 INFO - ##### Finished read-buildbot-config step (success) 15:34:02 INFO - ##### 15:34:02 INFO - ##### 15:34:02 INFO - ##### Running download-and-extract step. 15:34:02 INFO - ##### 15:34:02 INFO - Running pre-action listener: _resource_record_pre_action 15:34:02 INFO - Running main action method: download_and_extract 15:34:02 INFO - mkdir: /builds/slave/test/build/tests 15:34: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')]} 15:34:02 INFO - https://queue.taskcluster.net/v1/task/KyubbALUSB2giMToRnvy-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:34:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KyubbALUSB2giMToRnvy-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:34:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KyubbALUSB2giMToRnvy-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:34:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KyubbALUSB2giMToRnvy-g/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 15:34:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KyubbALUSB2giMToRnvy-g/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 15:34:09 INFO - Downloaded 1361 bytes. 15:34:09 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:34:09 INFO - Using the following test package requirements: 15:34:09 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:34:09 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:34:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:34:09 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:34:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:34:09 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:34:09 INFO - u'jsshell-linux-x86_64.zip'], 15:34:09 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:34:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:34:09 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:34:09 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:34:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:34:09 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:34:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:34:09 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:34:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:34:09 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:34:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:34:09 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:34:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:34:09 INFO - https://queue.taskcluster.net/v1/task/KyubbALUSB2giMToRnvy-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:34:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KyubbALUSB2giMToRnvy-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:34:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KyubbALUSB2giMToRnvy-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:34:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KyubbALUSB2giMToRnvy-g/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 15:34:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KyubbALUSB2giMToRnvy-g/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 15:34:12 INFO - Downloaded 22755900 bytes. 15:34:12 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'] 15:34:12 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 15:34:14 INFO - Return code: 0 15:34:14 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 15:34:14 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')]} 15:34:14 INFO - https://queue.taskcluster.net/v1/task/KyubbALUSB2giMToRnvy-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:34:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KyubbALUSB2giMToRnvy-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:34:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KyubbALUSB2giMToRnvy-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:34:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KyubbALUSB2giMToRnvy-g/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 15:34:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KyubbALUSB2giMToRnvy-g/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 15:34:18 INFO - Downloaded 22755900 bytes. 15:34:18 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'] 15:34:18 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 15:34:19 INFO - Return code: 0 15:34:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:34:19 INFO - https://queue.taskcluster.net/v1/task/KyubbALUSB2giMToRnvy-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:34:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KyubbALUSB2giMToRnvy-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:34:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KyubbALUSB2giMToRnvy-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:34:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KyubbALUSB2giMToRnvy-g/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 15:34:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KyubbALUSB2giMToRnvy-g/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 15:34:21 INFO - Downloaded 14403317 bytes. 15:34:21 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'] 15:34:21 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 15:34:21 INFO - Return code: 0 15:34:21 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')]} 15:34:21 INFO - https://queue.taskcluster.net/v1/task/KyubbALUSB2giMToRnvy-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:34:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KyubbALUSB2giMToRnvy-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:34:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KyubbALUSB2giMToRnvy-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:34:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KyubbALUSB2giMToRnvy-g/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 15:34:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KyubbALUSB2giMToRnvy-g/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 15:34:24 INFO - Downloaded 57043804 bytes. 15:34:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KyubbALUSB2giMToRnvy-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:34:24 INFO - mkdir: /builds/slave/test/properties 15:34:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:34:24 INFO - Writing to file /builds/slave/test/properties/build_url 15:34:24 INFO - Contents: 15:34:24 INFO - build_url:https://queue.taskcluster.net/v1/task/KyubbALUSB2giMToRnvy-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:34:25 INFO - Running post-action listener: _resource_record_post_action 15:34:25 INFO - Running post-action listener: set_extra_try_arguments 15:34:25 INFO - ##### 15:34:25 INFO - ##### Finished download-and-extract step (success) 15:34:25 INFO - ##### 15:34:25 INFO - ##### 15:34:25 INFO - ##### Running populate-webroot step. 15:34:25 INFO - ##### 15:34:25 INFO - Running pre-action listener: _resource_record_pre_action 15:34:25 INFO - Running main action method: populate_webroot 15:34:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:34:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:34:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:34:25 INFO - '--tppagecycles', 15:34:25 INFO - '7'], 15:34:25 INFO - 'tests': ['tsvgm']}}, 15:34:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:34:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:34:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:34:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:34:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:34:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:34:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:25 INFO - 'talos_options': ['--disable-e10s'], 15:34:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:34:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:34:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:25 INFO - 'talos_options': ['--disable-e10s'], 15:34:25 INFO - 'tests': ['damp', 'tps']}, 15:34:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:25 INFO - 'tests': ['damp', 'tps']}, 15:34:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:34:25 INFO - 'tests': ['dromaeo_dom']}, 15:34:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:34:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:34:25 INFO - 'tests': ['basic_compositor_video']}, 15:34:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:34:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:34:25 INFO - 'tests': ['a11yr', 15:34:25 INFO - 'ts_paint', 15:34:25 INFO - 'tpaint', 15:34:25 INFO - 'sessionrestore', 15:34:25 INFO - 'sessionrestore_no_auto_restore', 15:34:25 INFO - 'tabpaint']}, 15:34:25 INFO - 'other-e10s': {'tests': ['a11yr', 15:34:25 INFO - 'ts_paint', 15:34:25 INFO - 'tpaint', 15:34:25 INFO - 'sessionrestore', 15:34:25 INFO - 'sessionrestore_no_auto_restore', 15:34:25 INFO - 'tabpaint']}, 15:34:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:34:25 INFO - 'ts_paint', 15:34:25 INFO - 'tpaint', 15:34:25 INFO - 'sessionrestore', 15:34:25 INFO - 'sessionrestore_no_auto_restore', 15:34:25 INFO - 'tabpaint']}, 15:34:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:34:25 INFO - 'ts_paint', 15:34:25 INFO - 'tpaint', 15:34:25 INFO - 'sessionrestore', 15:34:25 INFO - 'sessionrestore_no_auto_restore', 15:34:25 INFO - 'tabpaint']}, 15:34:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:34:25 INFO - 'tests': ['a11yr', 15:34:25 INFO - 'ts_paint', 15:34:25 INFO - 'tpaint', 15:34:25 INFO - 'sessionrestore', 15:34:25 INFO - 'sessionrestore_no_auto_restore', 15:34:25 INFO - 'tabpaint']}, 15:34:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:34:25 INFO - 'tests': ['a11yr', 15:34:25 INFO - 'ts_paint', 15:34:25 INFO - 'tpaint', 15:34:25 INFO - 'sessionrestore', 15:34:25 INFO - 'sessionrestore_no_auto_restore', 15:34:25 INFO - 'tabpaint']}, 15:34:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:34:25 INFO - 'tests': ['tsvgx', 15:34:25 INFO - 'tsvgr_opacity', 15:34:25 INFO - 'tart', 15:34:25 INFO - 'tscrollx', 15:34:25 INFO - 'cart']}, 15:34:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:34:25 INFO - 'tsvgr_opacity', 15:34:25 INFO - 'tart', 15:34:25 INFO - 'tscrollx', 15:34:25 INFO - 'cart']}, 15:34:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:25 INFO - 'talos_options': ['--disable-e10s'], 15:34:25 INFO - 'tests': ['tp5o']}, 15:34:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:25 INFO - 'tests': ['tp5o']}, 15:34:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:25 INFO - 'talos_options': ['--disable-e10s', 15:34:25 INFO - '--xperf_path', 15:34:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:34:25 INFO - 'tests': ['tp5n']}, 15:34:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:25 INFO - 'talos_options': ['--xperf_path', 15:34:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:34:25 INFO - 'tests': ['tp5n']}}, 15:34:25 INFO - 'talos.zip': {'path': '', 15:34:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:34:25 INFO - Running post-action listener: _resource_record_post_action 15:34:25 INFO - ##### 15:34:25 INFO - ##### Finished populate-webroot step (success) 15:34:25 INFO - ##### 15:34:25 INFO - ##### 15:34:25 INFO - ##### Running create-virtualenv step. 15:34:25 INFO - ##### 15:34:25 INFO - Running pre-action listener: _resource_record_pre_action 15:34:25 INFO - Running main action method: create_virtualenv 15:34:25 INFO - Creating virtualenv /builds/slave/test/build/venv 15:34:25 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 15:34:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:34:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:34:25 INFO - Using real prefix '/usr' 15:34:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:34:26 INFO - Installing distribute.............................................................................................................................................................................................done. 15:34:28 INFO - Installing pip.................done. 15:34:28 INFO - Return code: 0 15:34:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:34:28 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')]} 15:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:28 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')]} 15:34:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:28 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 0x2632030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f13b0>, '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 0x28f22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f2740>, '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': '03627c79f6bb3d1578c4a402000001ba-1468448863.968818-1376647508', '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 15:34:28 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 15:34:28 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 15:34:28 INFO - Using env: {'DISPLAY': ':0', 15:34:28 INFO - 'HOME': '/home/cltbld', 15:34:28 INFO - 'LANG': 'en_US.UTF-8', 15:34:28 INFO - 'LANGUAGE': 'en_US:en', 15:34:28 INFO - 'LOGNAME': 'cltbld', 15:34:28 INFO - 'MAIL': '/var/mail/cltbld', 15:34:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:28 INFO - 'MOZ_NO_REMOTE': '1', 15:34:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:28 INFO - 'NO_EM_RESTART': '1', 15:34:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:28 INFO - 'PWD': '/builds/slave/test', 15:34:28 INFO - 'SHELL': '/bin/bash', 15:34:28 INFO - 'SHLVL': '1', 15:34:28 INFO - 'TERM': 'linux', 15:34:28 INFO - 'TMOUT': '86400', 15:34:28 INFO - 'USER': 'cltbld', 15:34:28 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468448863.968818-1376647508', 15:34:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:28 INFO - '_': '/tools/buildbot/bin/python'} 15:34:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:28 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 15:34:28 INFO - Cleaning up... 15:34:28 INFO - Return code: 0 15:34:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:34:28 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')]} 15:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:28 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')]} 15:34:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:28 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 0x2632030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f13b0>, '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 0x28f22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f2740>, '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': '03627c79f6bb3d1578c4a402000001ba-1468448863.968818-1376647508', '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 15:34:28 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 15:34:28 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 15:34:28 INFO - Using env: {'DISPLAY': ':0', 15:34:28 INFO - 'HOME': '/home/cltbld', 15:34:28 INFO - 'LANG': 'en_US.UTF-8', 15:34:28 INFO - 'LANGUAGE': 'en_US:en', 15:34:28 INFO - 'LOGNAME': 'cltbld', 15:34:28 INFO - 'MAIL': '/var/mail/cltbld', 15:34:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:28 INFO - 'MOZ_NO_REMOTE': '1', 15:34:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:28 INFO - 'NO_EM_RESTART': '1', 15:34:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:28 INFO - 'PWD': '/builds/slave/test', 15:34:28 INFO - 'SHELL': '/bin/bash', 15:34:28 INFO - 'SHLVL': '1', 15:34:28 INFO - 'TERM': 'linux', 15:34:28 INFO - 'TMOUT': '86400', 15:34:28 INFO - 'USER': 'cltbld', 15:34:28 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468448863.968818-1376647508', 15:34:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:28 INFO - '_': '/tools/buildbot/bin/python'} 15:34:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:28 INFO - Downloading/unpacking psutil>=3.1.1 15:34: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 15:34: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 15:34: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 15:34: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 15:34: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 15:34: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 15:34:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:34:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:34:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:34:30 INFO - Installing collected packages: psutil 15:34:30 INFO - Running setup.py install for psutil 15:34:31 INFO - building 'psutil._psutil_linux' extension 15:34:31 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 15:34:31 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 15:34:31 INFO - building 'psutil._psutil_posix' extension 15:34:31 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 15:34:31 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 15:34:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:34:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:34:31 INFO - Successfully installed psutil 15:34:31 INFO - Cleaning up... 15:34:31 INFO - Return code: 0 15:34:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:34:31 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')]} 15:34:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:31 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')]} 15:34:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:31 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 0x2632030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f13b0>, '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 0x28f22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f2740>, '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': '03627c79f6bb3d1578c4a402000001ba-1468448863.968818-1376647508', '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 15:34:31 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 15:34:31 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 15:34:31 INFO - Using env: {'DISPLAY': ':0', 15:34:31 INFO - 'HOME': '/home/cltbld', 15:34:31 INFO - 'LANG': 'en_US.UTF-8', 15:34:31 INFO - 'LANGUAGE': 'en_US:en', 15:34:31 INFO - 'LOGNAME': 'cltbld', 15:34:31 INFO - 'MAIL': '/var/mail/cltbld', 15:34:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:31 INFO - 'MOZ_NO_REMOTE': '1', 15:34:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:31 INFO - 'NO_EM_RESTART': '1', 15:34:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:31 INFO - 'PWD': '/builds/slave/test', 15:34:31 INFO - 'SHELL': '/bin/bash', 15:34:31 INFO - 'SHLVL': '1', 15:34:31 INFO - 'TERM': 'linux', 15:34:31 INFO - 'TMOUT': '86400', 15:34:31 INFO - 'USER': 'cltbld', 15:34:31 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468448863.968818-1376647508', 15:34:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:31 INFO - '_': '/tools/buildbot/bin/python'} 15:34:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:34:31 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 15:34:31 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 15:34:31 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 15:34:31 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 15:34:31 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 15:34:31 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 15:34:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:34:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:34:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:34:33 INFO - Installing collected packages: mozsystemmonitor 15:34:33 INFO - Running setup.py install for mozsystemmonitor 15:34:33 INFO - Successfully installed mozsystemmonitor 15:34:33 INFO - Cleaning up... 15:34:33 INFO - Return code: 0 15:34:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:34: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')]} 15:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34: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')]} 15:34:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:33 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 0x2632030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f13b0>, '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 0x28f22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f2740>, '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': '03627c79f6bb3d1578c4a402000001ba-1468448863.968818-1376647508', '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 15:34:33 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 15:34:33 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 15:34:33 INFO - Using env: {'DISPLAY': ':0', 15:34:33 INFO - 'HOME': '/home/cltbld', 15:34:33 INFO - 'LANG': 'en_US.UTF-8', 15:34:33 INFO - 'LANGUAGE': 'en_US:en', 15:34:33 INFO - 'LOGNAME': 'cltbld', 15:34:33 INFO - 'MAIL': '/var/mail/cltbld', 15:34:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:33 INFO - 'MOZ_NO_REMOTE': '1', 15:34:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:33 INFO - 'NO_EM_RESTART': '1', 15:34:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:33 INFO - 'PWD': '/builds/slave/test', 15:34:33 INFO - 'SHELL': '/bin/bash', 15:34:33 INFO - 'SHLVL': '1', 15:34:33 INFO - 'TERM': 'linux', 15:34:33 INFO - 'TMOUT': '86400', 15:34:33 INFO - 'USER': 'cltbld', 15:34:33 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468448863.968818-1376647508', 15:34:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:33 INFO - '_': '/tools/buildbot/bin/python'} 15:34:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:34 INFO - Downloading/unpacking jsonschema==2.5.1 15:34:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:34:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:34:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:34:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:34:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:36 INFO - Downloading functools32-3.2.3-2.tar.gz 15:34:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:34:36 INFO - warning: no files found matching '*.txt' 15:34:36 INFO - no previously-included directories found matching 'build' 15:34:36 INFO - no previously-included directories found matching 'dist' 15:34:36 INFO - no previously-included directories found matching '.git*' 15:34:36 INFO - Installing collected packages: jsonschema, functools32 15:34:36 INFO - Running setup.py install for functools32 15:34:36 INFO - warning: no files found matching '*.txt' 15:34:36 INFO - no previously-included directories found matching 'build' 15:34:36 INFO - no previously-included directories found matching 'dist' 15:34:36 INFO - no previously-included directories found matching '.git*' 15:34:36 INFO - Successfully installed jsonschema functools32 15:34:36 INFO - Cleaning up... 15:34:36 INFO - Return code: 0 15:34:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:34:36 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')]} 15:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:36 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')]} 15:34:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:36 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 0x2632030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f13b0>, '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 0x28f22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f2740>, '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': '03627c79f6bb3d1578c4a402000001ba-1468448863.968818-1376647508', '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 15:34:36 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 15:34:36 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 15:34:36 INFO - Using env: {'DISPLAY': ':0', 15:34:36 INFO - 'HOME': '/home/cltbld', 15:34:36 INFO - 'LANG': 'en_US.UTF-8', 15:34:36 INFO - 'LANGUAGE': 'en_US:en', 15:34:36 INFO - 'LOGNAME': 'cltbld', 15:34:36 INFO - 'MAIL': '/var/mail/cltbld', 15:34:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:36 INFO - 'MOZ_NO_REMOTE': '1', 15:34:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:36 INFO - 'NO_EM_RESTART': '1', 15:34:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:36 INFO - 'PWD': '/builds/slave/test', 15:34:36 INFO - 'SHELL': '/bin/bash', 15:34:36 INFO - 'SHLVL': '1', 15:34:36 INFO - 'TERM': 'linux', 15:34:36 INFO - 'TMOUT': '86400', 15:34:36 INFO - 'USER': 'cltbld', 15:34:36 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468448863.968818-1376647508', 15:34:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:36 INFO - '_': '/tools/buildbot/bin/python'} 15:34:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:36 INFO - Downloading/unpacking blobuploader==1.2.4 15:34:36 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 15:34:36 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 15:34:36 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 15:34:36 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 15:34:36 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 15:34:36 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 15:34:38 INFO - Downloading blobuploader-1.2.4.tar.gz 15:34:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:34:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:34: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 15:34: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 15:34: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 15:34: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 15:34: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 15:34: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 15:34:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:34:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:34:39 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 15:34:39 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 15:34:39 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 15:34:39 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 15:34:39 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 15:34:39 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 15:34:39 INFO - Downloading docopt-0.6.1.tar.gz 15:34:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:34:39 INFO - Installing collected packages: blobuploader, requests, docopt 15:34:39 INFO - Running setup.py install for blobuploader 15:34:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:34:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:34:39 INFO - Running setup.py install for requests 15:34:39 INFO - Running setup.py install for docopt 15:34:39 INFO - Successfully installed blobuploader requests docopt 15:34:39 INFO - Cleaning up... 15:34:39 INFO - Return code: 0 15:34:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:34:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:34:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:34:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:39 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 0x2632030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f13b0>, '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 0x28f22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f2740>, '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': '03627c79f6bb3d1578c4a402000001ba-1468448863.968818-1376647508', '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 15:34:39 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 15:34:39 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 15:34:39 INFO - Using env: {'DISPLAY': ':0', 15:34:39 INFO - 'HOME': '/home/cltbld', 15:34:39 INFO - 'LANG': 'en_US.UTF-8', 15:34:39 INFO - 'LANGUAGE': 'en_US:en', 15:34:39 INFO - 'LOGNAME': 'cltbld', 15:34:39 INFO - 'MAIL': '/var/mail/cltbld', 15:34:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:39 INFO - 'MOZ_NO_REMOTE': '1', 15:34:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:39 INFO - 'NO_EM_RESTART': '1', 15:34:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:39 INFO - 'PWD': '/builds/slave/test', 15:34:39 INFO - 'SHELL': '/bin/bash', 15:34:39 INFO - 'SHLVL': '1', 15:34:39 INFO - 'TERM': 'linux', 15:34:39 INFO - 'TMOUT': '86400', 15:34:39 INFO - 'USER': 'cltbld', 15:34:39 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468448863.968818-1376647508', 15:34:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:39 INFO - '_': '/tools/buildbot/bin/python'} 15:34:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:34:40 INFO - Running setup.py (path:/tmp/pip-gYPek1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:34:40 INFO - Running setup.py (path:/tmp/pip-gDD791-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:34:40 INFO - Running setup.py (path:/tmp/pip-5h20dn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:34:40 INFO - Running setup.py (path:/tmp/pip-T8rCFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:34:40 INFO - Running setup.py (path:/tmp/pip-gBQaBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:34:40 INFO - Running setup.py (path:/tmp/pip-vROR1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:34:40 INFO - Running setup.py (path:/tmp/pip-u2iAhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:34:40 INFO - Running setup.py (path:/tmp/pip-QiRfMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:34:40 INFO - Running setup.py (path:/tmp/pip-dfNAd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:34:40 INFO - Running setup.py (path:/tmp/pip-s7fzvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:34:40 INFO - Running setup.py (path:/tmp/pip-8qfz9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:34:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:34:40 INFO - Running setup.py (path:/tmp/pip-DeJma2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:34:41 INFO - Running setup.py (path:/tmp/pip-X7iGWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:34:41 INFO - Running setup.py (path:/tmp/pip-uSqwYq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:34:41 INFO - Running setup.py (path:/tmp/pip-WAe7tk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:34:41 INFO - Running setup.py (path:/tmp/pip-aW_Rgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:34:41 INFO - Running setup.py (path:/tmp/pip-dDyFfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:34:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:34:41 INFO - Running setup.py install for manifestparser 15:34:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:34:41 INFO - Running setup.py install for mozcrash 15:34:41 INFO - Running setup.py install for mozdebug 15:34:41 INFO - Running setup.py install for mozdevice 15:34:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:34:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:34:41 INFO - Running setup.py install for mozfile 15:34:41 INFO - Running setup.py install for mozhttpd 15:34:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:34:42 INFO - Running setup.py install for mozinfo 15:34:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:34:42 INFO - Running setup.py install for mozInstall 15:34:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:34:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:34:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:34:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:34:42 INFO - Running setup.py install for mozleak 15:34:42 INFO - Running setup.py install for mozlog 15:34:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:34:42 INFO - Running setup.py install for moznetwork 15:34:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:34:42 INFO - Running setup.py install for mozprocess 15:34:42 INFO - Running setup.py install for mozprofile 15:34:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:34:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:34:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:34:42 INFO - Running setup.py install for mozrunner 15:34:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:34:42 INFO - Running setup.py install for mozscreenshot 15:34:43 INFO - Running setup.py install for moztest 15:34:43 INFO - Running setup.py install for mozversion 15:34:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:34:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:34:43 INFO - Cleaning up... 15:34:43 INFO - Return code: 0 15:34:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:34:43 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')]} 15:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:43 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')]} 15:34:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:43 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 0x2632030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f13b0>, '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 0x28f22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f2740>, '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': '03627c79f6bb3d1578c4a402000001ba-1468448863.968818-1376647508', '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 15:34:43 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 15:34:43 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 15:34:43 INFO - Using env: {'DISPLAY': ':0', 15:34:43 INFO - 'HOME': '/home/cltbld', 15:34:43 INFO - 'LANG': 'en_US.UTF-8', 15:34:43 INFO - 'LANGUAGE': 'en_US:en', 15:34:43 INFO - 'LOGNAME': 'cltbld', 15:34:43 INFO - 'MAIL': '/var/mail/cltbld', 15:34:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:43 INFO - 'MOZ_NO_REMOTE': '1', 15:34:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:43 INFO - 'NO_EM_RESTART': '1', 15:34:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:43 INFO - 'PWD': '/builds/slave/test', 15:34:43 INFO - 'SHELL': '/bin/bash', 15:34:43 INFO - 'SHLVL': '1', 15:34:43 INFO - 'TERM': 'linux', 15:34:43 INFO - 'TMOUT': '86400', 15:34:43 INFO - 'USER': 'cltbld', 15:34:43 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468448863.968818-1376647508', 15:34:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:43 INFO - '_': '/tools/buildbot/bin/python'} 15:34:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:34:43 INFO - Running setup.py (path:/tmp/pip-p0BrRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:34:43 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)) 15:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:34:43 INFO - Running setup.py (path:/tmp/pip-HSa1GQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:34:43 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)) 15:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:34:43 INFO - Running setup.py (path:/tmp/pip-21jmwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:34:43 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)) 15:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:34:43 INFO - Running setup.py (path:/tmp/pip-FoNuya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:34:43 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)) 15:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:34:43 INFO - Running setup.py (path:/tmp/pip-mCD4Ol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:34:43 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)) 15:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:34:43 INFO - Running setup.py (path:/tmp/pip-RsGNbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:34:43 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)) 15:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:34:43 INFO - Running setup.py (path:/tmp/pip-wM_VH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:34:43 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)) 15:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:34:43 INFO - Running setup.py (path:/tmp/pip-37de2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:34:44 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)) 15:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:34:44 INFO - Running setup.py (path:/tmp/pip-6Wr3To-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:34:44 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)) 15:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:34:44 INFO - Running setup.py (path:/tmp/pip-gOrFlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:34:44 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)) 15:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:34:44 INFO - Running setup.py (path:/tmp/pip-bGBYv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:34:44 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)) 15:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:34:44 INFO - Running setup.py (path:/tmp/pip-kWekKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:34:44 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)) 15:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:34:44 INFO - Running setup.py (path:/tmp/pip-ArOqoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:34:44 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)) 15:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:34:44 INFO - Running setup.py (path:/tmp/pip-2489Fm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:34:44 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)) 15:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:34:44 INFO - Running setup.py (path:/tmp/pip-3MxlQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:34:44 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)) 15:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:34:44 INFO - Running setup.py (path:/tmp/pip-xSffUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:34:44 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)) 15:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:34:44 INFO - Running setup.py (path:/tmp/pip-hvieAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:34:44 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)) 15:34:44 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)) 15:34:44 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)) 15:34:44 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)) 15:34:44 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)) 15:34:44 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)) 15:34:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:34:44 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 15:34:44 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 15:34:44 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 15:34:44 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 15:34:44 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 15:34:44 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 15:34:46 INFO - Downloading blessings-1.6.tar.gz 15:34:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:34:46 INFO - Installing collected packages: blessings 15:34:46 INFO - Running setup.py install for blessings 15:34:46 INFO - Successfully installed blessings 15:34:46 INFO - Cleaning up... 15:34:46 INFO - Return code: 0 15:34:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:34:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:34:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:34:47 INFO - Reading from file tmpfile_stdout 15:34:47 INFO - Current package versions: 15:34:47 INFO - argparse == 1.2.1 15:34:47 INFO - blessings == 1.6 15:34:47 INFO - blobuploader == 1.2.4 15:34:47 INFO - docopt == 0.6.1 15:34:47 INFO - functools32 == 3.2.3-2 15:34:47 INFO - jsonschema == 2.5.1 15:34:47 INFO - manifestparser == 1.1 15:34:47 INFO - mozInstall == 1.12 15:34:47 INFO - mozcrash == 0.17 15:34:47 INFO - mozdebug == 0.1 15:34:47 INFO - mozdevice == 0.48 15:34:47 INFO - mozfile == 1.2 15:34:47 INFO - mozhttpd == 0.7 15:34:47 INFO - mozinfo == 0.9 15:34:47 INFO - mozleak == 0.1 15:34:47 INFO - mozlog == 3.2 15:34:47 INFO - moznetwork == 0.27 15:34:47 INFO - mozprocess == 0.23 15:34:47 INFO - mozprofile == 0.28 15:34:47 INFO - mozrunner == 6.12 15:34:47 INFO - mozscreenshot == 0.1 15:34:47 INFO - mozsystemmonitor == 0.3 15:34:47 INFO - moztest == 0.7 15:34:47 INFO - mozversion == 1.4 15:34:47 INFO - psutil == 3.1.1 15:34:47 INFO - requests == 1.2.3 15:34:47 INFO - wsgiref == 0.1.2 15:34:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:34:47 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')]} 15:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:47 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')]} 15:34:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:47 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 0x2632030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f13b0>, '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 0x28f22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f2740>, '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': '03627c79f6bb3d1578c4a402000001ba-1468448863.968818-1376647508', '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 15:34:47 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 15:34:47 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 15:34:47 INFO - Using env: {'DISPLAY': ':0', 15:34:47 INFO - 'HOME': '/home/cltbld', 15:34:47 INFO - 'LANG': 'en_US.UTF-8', 15:34:47 INFO - 'LANGUAGE': 'en_US:en', 15:34:47 INFO - 'LOGNAME': 'cltbld', 15:34:47 INFO - 'MAIL': '/var/mail/cltbld', 15:34:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:47 INFO - 'MOZ_NO_REMOTE': '1', 15:34:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:47 INFO - 'NO_EM_RESTART': '1', 15:34:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:47 INFO - 'PWD': '/builds/slave/test', 15:34:47 INFO - 'SHELL': '/bin/bash', 15:34:47 INFO - 'SHLVL': '1', 15:34:47 INFO - 'TERM': 'linux', 15:34:47 INFO - 'TMOUT': '86400', 15:34:47 INFO - 'USER': 'cltbld', 15:34:47 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468448863.968818-1376647508', 15:34:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:47 INFO - '_': '/tools/buildbot/bin/python'} 15:34:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:47 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)) 15:34:47 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)) 15:34:47 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)) 15:34:47 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)) 15:34:47 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)) 15:34:47 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)) 15:34:47 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)) 15:34:47 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)) 15:34:47 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)) 15:34:47 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)) 15:34:47 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)) 15:34:47 INFO - Cleaning up... 15:34:47 INFO - Return code: 0 15:34:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:34:47 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')]} 15:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:47 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')]} 15:34:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:47 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 0x2632030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f13b0>, '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 0x28f22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f2740>, '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': '03627c79f6bb3d1578c4a402000001ba-1468448863.968818-1376647508', '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 15:34:47 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 15:34:47 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 15:34:47 INFO - Using env: {'DISPLAY': ':0', 15:34:47 INFO - 'HOME': '/home/cltbld', 15:34:47 INFO - 'LANG': 'en_US.UTF-8', 15:34:47 INFO - 'LANGUAGE': 'en_US:en', 15:34:47 INFO - 'LOGNAME': 'cltbld', 15:34:47 INFO - 'MAIL': '/var/mail/cltbld', 15:34:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:47 INFO - 'MOZ_NO_REMOTE': '1', 15:34:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:47 INFO - 'NO_EM_RESTART': '1', 15:34:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:47 INFO - 'PWD': '/builds/slave/test', 15:34:47 INFO - 'SHELL': '/bin/bash', 15:34:47 INFO - 'SHLVL': '1', 15:34:47 INFO - 'TERM': 'linux', 15:34:47 INFO - 'TMOUT': '86400', 15:34:47 INFO - 'USER': 'cltbld', 15:34:47 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468448863.968818-1376647508', 15:34:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:47 INFO - '_': '/tools/buildbot/bin/python'} 15:34:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:34:47 INFO - Cleaning up... 15:34:47 INFO - Return code: 0 15:34:47 INFO - Running post-action listener: _resource_record_post_action 15:34:47 INFO - Running post-action listener: _start_resource_monitoring 15:34:47 INFO - Starting resource monitoring. 15:34:47 INFO - ##### 15:34:47 INFO - ##### Finished create-virtualenv step (success) 15:34:47 INFO - ##### 15:34:47 INFO - ##### 15:34:47 INFO - ##### Running install step. 15:34:47 INFO - ##### 15:34:47 INFO - Running pre-action listener: _resource_record_pre_action 15:34:47 INFO - Running main action method: install 15:34:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:34:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:34:47 INFO - Reading from file tmpfile_stdout 15:34:47 INFO - Detecting whether we're running mozinstall >=1.0... 15:34:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:34:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:34:47 INFO - Reading from file tmpfile_stdout 15:34:47 INFO - Output received: 15:34:47 INFO - Usage: mozinstall [options] installer 15:34:47 INFO - Options: 15:34:47 INFO - -h, --help show this help message and exit 15:34:47 INFO - -d DEST, --destination=DEST 15:34:47 INFO - Directory to install application into. [default: 15:34:47 INFO - "/builds/slave/test"] 15:34:47 INFO - --app=APP Application being installed. [default: firefox] 15:34:47 INFO - mkdir: /builds/slave/test/build/application 15:34:47 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'] 15:34:47 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 15:35:04 INFO - Reading from file tmpfile_stdout 15:35:04 INFO - Output received: 15:35:04 INFO - /builds/slave/test/build/application/firefox/firefox 15:35:04 INFO - Running post-action listener: _resource_record_post_action 15:35:04 INFO - ##### 15:35:04 INFO - ##### Finished install step (success) 15:35:04 INFO - ##### 15:35:04 INFO - ##### 15:35:04 INFO - ##### Running run-tests step. 15:35:04 INFO - ##### 15:35:04 INFO - Running pre-action listener: _resource_record_pre_action 15:35:04 INFO - Running main action method: run_tests 15:35:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:35:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:35:04 INFO - Python 2.7.3 15:35:04 INFO - Return code: 0 15:35:04 INFO - grabbing minidump binary from tooltool 15:35: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')]} 15:35:04 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 0x28f13b0>, '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 0x28f22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28f2740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:35:04 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 15:35:04 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 15:35:04 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 15:35:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:35:04 INFO - Return code: 0 15:35:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:35:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:35:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:35:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:35:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:35:04 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/KyubbALUSB2giMToRnvy-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 15:35:04 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/KyubbALUSB2giMToRnvy-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 15:35:04 INFO - Using env: {'DISPLAY': ':0', 15:35:04 INFO - 'HOME': '/home/cltbld', 15:35:04 INFO - 'LANG': 'en_US.UTF-8', 15:35:04 INFO - 'LANGUAGE': 'en_US:en', 15:35:04 INFO - 'LOGNAME': 'cltbld', 15:35:04 INFO - 'MAIL': '/var/mail/cltbld', 15:35:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:35:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:35:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:04 INFO - 'MOZ_NO_REMOTE': '1', 15:35:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:35:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:04 INFO - 'NO_EM_RESTART': '1', 15:35:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:04 INFO - 'PWD': '/builds/slave/test', 15:35:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:35:04 INFO - 'SHELL': '/bin/bash', 15:35:04 INFO - 'SHLVL': '1', 15:35:04 INFO - 'TERM': 'linux', 15:35:04 INFO - 'TMOUT': '86400', 15:35:04 INFO - 'USER': 'cltbld', 15:35:04 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468448863.968818-1376647508', 15:35:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:04 INFO - '_': '/tools/buildbot/bin/python'} 15:35:04 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/KyubbALUSB2giMToRnvy-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 15:35:04 INFO - mozversion application_buildid: 20160713150842 15:35:04 INFO - mozversion application_changeset: c492812c7932a78769ae2ddad321b725e09fd9ea 15:35:04 INFO - mozversion application_display_name: Nightly 15:35:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:35:04 INFO - mozversion application_name: Firefox 15:35:04 INFO - mozversion application_remotingname: firefox 15:35:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:35:04 INFO - mozversion application_vendor: Mozilla 15:35:04 INFO - mozversion application_version: 50.0a1 15:35:04 INFO - mozversion platform_buildid: 20160713150842 15:35:04 INFO - mozversion platform_changeset: c492812c7932a78769ae2ddad321b725e09fd9ea 15:35:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:35:04 INFO - mozversion platform_version: 50.0a1 15:35:04 INFO - using testdate: 1468449304 15:35:04 INFO - actual date: 1468449304 15:35:04 INFO - starting webserver on 'localhost:35155' 15:35:04 INFO - SUITE-START | Running 2 tests 15:35:04 INFO - TEST-START | dromaeo_css 15:35:04 INFO - operating with platform_type : linux_ 15:35:04 INFO - Initialising browser for dromaeo_css test... 15:35:04 INFO - TEST-INFO | started process 17797 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOQlePC/profile http://localhost:35155/getInfo.html) 15:35:08 INFO - PROCESS | 17797 | __metrics Screen width/height:1600/1200 15:35:08 INFO - PROCESS | 17797 | colorDepth:24 15:35:08 INFO - PROCESS | 17797 | Browser inner width/height: 1024/697 15:35:08 INFO - PROCESS | 17797 | __metrics 15:35:09 INFO - PROCESS | 17797 | 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" 15:35:09 INFO - PROCESS | 17797 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:35:10 INFO - TEST-INFO | 17797: exit 0 15:35:10 INFO - Browser initialized. 15:35:10 INFO - Running cycle 1/1 for dromaeo_css test... 15:35:10 INFO - TEST-INFO | started process 17877 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOQlePC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:35:22 INFO - PROCESS | 17877 | RSS: Main: 158760960 15:35:22 INFO - PROCESS | 17877 | 15:36:13 INFO - PROCESS | 17877 | 1468449373520 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] 15:38:26 INFO - PROCESS | 17877 | Cycle 1(1): loaded http://localhost:35155/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35155/tests/dromaeo/cssquery-ext.html) 15:38:27 INFO - PROCESS | 17877 | RSS: Main: 235044864 15:38:27 INFO - PROCESS | 17877 | 15:41:29 INFO - PROCESS | 17877 | Cycle 1(1): loaded http://localhost:35155/tests/dromaeo/cssquery-ext.html (next: http://localhost:35155/tests/dromaeo/cssquery-jquery.html) 15:41:30 INFO - PROCESS | 17877 | RSS: Main: 247066624 15:41:30 INFO - PROCESS | 17877 | 15:44:32 INFO - PROCESS | 17877 | Cycle 1(1): loaded http://localhost:35155/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35155/tests/dromaeo/cssquery-mootools.html) 15:44:33 INFO - PROCESS | 17877 | RSS: Main: 242683904 15:44:33 INFO - PROCESS | 17877 | 15:47:35 INFO - PROCESS | 17877 | Cycle 1(1): loaded http://localhost:35155/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35155/tests/dromaeo/cssquery-prototype.html) 15:47:36 INFO - PROCESS | 17877 | RSS: Main: 241274880 15:47:36 INFO - PROCESS | 17877 | 15:50:39 INFO - PROCESS | 17877 | Cycle 1(1): loaded http://localhost:35155/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35155/tests/dromaeo/cssquery-yui.html) 15:50:39 INFO - PROCESS | 17877 | RSS: Main: 220962816 15:50:39 INFO - PROCESS | 17877 | 15:53:42 INFO - PROCESS | 17877 | Cycle 1(1): loaded http://localhost:35155/tests/dromaeo/cssquery-yui.html (next: http://localhost:35155/tests/dromaeo/cssquery-dojo.html) 15:53:42 INFO - PROCESS | 17877 | RSS: Main: 283168768 15:53:42 INFO - PROCESS | 17877 | 15:53:42 INFO - PROCESS | 17877 | __start_tp_report 15:53:42 INFO - PROCESS | 17877 | _x_x_mozilla_page_load 15:53:42 INFO - PROCESS | 17877 | _x_x_mozilla_page_load_details 15:53:42 INFO - PROCESS | 17877 | |i|pagename|runs| 15:53:42 INFO - PROCESS | 17877 | |0;dojo.html;2598.8570628615416;2600.453904680017;2629.30323464282;2638.947221055578;2650.4169082801777;4439.866803995886;4576.656750743691;4644.978104816939;4653.139169253686;4655.580997710205;4583.404157459534;4586.587207151356;4588.2658774596075;4609.654275929302;4624.329472226534;4018.8794336169963;4187.371894215869;4252.617264446199;4285.978570107145;4388.451443569554;4306.720063195898;4370.2133615949115;4373.978130109345;4378.080603073358;4398.208322501949;4100.302948498763;4130.091379896418;4271.765052922088;4279.529251782302;4286.249906266391;4264.936025959613;4275.722078064947;4306.310990241546;4312.396264522969;4316.050468896838;4299.656027517791;4308.78456077198;4311.267084595626;4329.458817647794;4347.978260108679;4486.5962063414445;4517.141743068839;4639.5824375806005;4641.86074417768;4661.324108004321;5001.349824522825;5026.84919452417;5033.0688822567945;5034.244863270502;5046.84859454217;4829.903401931977;5063.417706963673;5069.746512674388;5075.111855425286;5077.162268225738;4627.398438203046;4689.484156742756;4691.46048204454;4756.857294281177;4764.023375208074;5186.896262074737;5225.921611175835;5226.294450249167;5227.712475813867;5230.241614965808;4677.7193368398;4845.878853028632;4849.345338379274;4900.460949295574;4902.338184345068;4892.241702536113;4961.503849615082;4989.700617962933;4996.775145118479;5018.548330650259;4939.3084968104495;4943.382077240345;4950.455449900508;4952.108620448282;4993.925091123563;4710.24636058229;4828.444728856156;4929.531694489017;4933.432655244621;4980.90038199234;4136.048708796933;4142.1301526679135;4160.875173744793;4185.309423945015;4198.4961804583645;3655.798931058764;3662.908427289286;3673.7061035117126;3696.1683621185557;3713.3687273163628;4174.165166966558;4212.620864122183;4215.725977811432;4272.359146128106;4274.957250427518;4939.3084968104495;4966.428860680996;5022.121128802518;5036.622253331015;5042.268871013683;4297.376880352332;4317.050248945227;4326.351047342924;4362.760048197316;4367.58507941745;4286.142771445723;4354.194474022316;4478.932816007762;4485.170243504962;4485.923378389163;4726.621870250303;4751.382320298339;4773.355596994361;4778.546038126373;4823.155947709207;5026.070177017264;5028.4971502850885;5031.547160755549;5032.04391165692;5064.645474816727;4527.0493196429115;4677.742724150205;4720.929186062281;4816.518348165156;4823.27650852375;4904.092742842586;4905.6075513958085;4915.582175515121;4924.433690125681;4963.503649635008;4976.925346119739;4989.351384320015;4989.825356112518;4994.425641051325;5028.798848046037;4671.929921051119;4691.859244222679;4779.689320194177;4851.51484851512;4900.975495122501;4842.6368022399165;4851;4855.36880205571;4857.635677324144;4912.7543622818;4781.737004464788;4782.928256076092;4786.16242157614;4793.376861008047;4830.3237546742785;4707.458642256048;4775.594074503567;4822.855314340435;4854.368932038812;4868.586170175433;4749.881252968704;4759.619230461624;4772.809087636456;4774.904501910012;4815 15:53:42 INFO - PROCESS | 17877 | |1;ext.html;577.7053702611668;585.3941170888129;590.4302348233954;590.8670549126446;591.6124938165498;27150.72849271507;39371.80314098429;40555.594444055554;40637.39043914343;44089.338659920126;40166;40406;40562.59437405625;40595.391069133984;40608;7514.398848092167;7789.221077892222;7917.445778795458;7929.960350198241;7939.245771651713;7692.4615276930635;7791.649375778075;7792.376609871225;10043.296969212122;10327.07056364927;10382.844257336146;10414.27100102993;10418.426986515738;10421.947890260575;10454.790904181911;10312.639057632985;10344.06903378692;10386.428746418944;10398.948005259963;10404.479776011169;7512.586807725573;7752.883706744347;7757.922420775776;9879.604815807359;10312.071913527818;38216.808915955524;38577;38605.42091868624;38653.22693546141;38659.22681546353;3008.714172153642;3053.938921221585;3085.1670049086847;3103.379324135182;3166.857491412892;28442.288942776388;29896;29974;30060;30096;2833.702461241581;2855.114914376529;2857.3142445813064;2873.626428564294;2932.6627437844495;247917;248898;249370;249681;249964;52572;53117.468825311254;53183.20225196625;53201.46798531965;53235;55748;55838.16242756362;55999;56041.159382609294;56146.71926640341;13908.095973761672;14322.212278324792;14332.14007159553;14340.928295358664;14342.498012569718;9990.200783937267;10760.085392741548;10845.728856778485;10845.783084338269;10848.566057357617;14877.776833347509;15488.07071575709;15499.457518986781;15846;15981.520554383387;5833.370797180741;5927.851803704855;5944.910826337608;5969.820905372846;6065.757369705162;814.9755507334789;855.39267120344;877.9517126558101;914.679862048291;957.9425234485954;26530.336741581614;27532.278050925564;27561;27878.16365509038;28015.439691206062;944.367273926471;966.4008314844841;969.471637957315;1009.9949500252599;1051.81593221186;14384.424623015171;14803.777943330859;15098.698026039418;15761.369545218064;15821.367145314289;350654;351294;351560;353586;354032;49245.50754492409;49592;49703;49712.50287497151;49857.50142498601;1097.286763603648;1152.124385467051;1167.8073117935446;1216.403962058585;1225.2893321873291;26797;28015.719842802126;28394.29014274577;28949.7105028947;29121.41757164887;40959.59040409677;41109.58890411058;41387;41622.37566436445;41638.791806040776;289277;290509;290664;291491;291502;21303.893480532497;23516.412089697893;24410.755892441557;24418.63372049385;24562.263132106065;40649.79675101605;40715.79642101889;40775.18449630932;41261.38107928324;41619.7919010403;32962.83518582392;35228.47157292591;35465.290694186486;35862.820685896404;35934.460983085795;34960.650393496755;35656.28687426185;35677.108072297364;35761;35944.64055359518;34268.65731342655;34418.48372274368;34647.13382165466;34749.13127171841;35222.29555408929;31227;31620.525692115098;31738.36523269568;31823.045308640776;31951.520727188647;23336.533269334857;23392.595106661454;23757.524849503257;23907;23917.76082239225 15:53:42 INFO - PROCESS | 17877 | |2;jquery.html;376.8285430129291;376.8662124945644;377.7487970499618;381.92934307153195;391.1492503804227;16807.49577512675;17073.40243091492;17800.55498612532;18019.63960720785;18032;10804.13566914647;11155.107591392669;11189.888101118986;11208.327500349964;11210.383428911407;4313.978430107861;4644.117617652652;5288.048151332759;5290.074237008508;5293;5151.407588127376;5198.064348417283;5203.115470370046;5208.166693329068;5218.686878787266;4641.814327426899;4767.189577771787;4772.642051846108;4784.306275590037;5189.558887494568;4746.169420351424;4763.928541071887;4799.7360145192;4801.855944321676;4809.975950120262;4567.200739870543;4609.469910960215;4651.813927442899;4655.068986202773;4695.131400690883;12669.873301266962;12760.106792524526;12767.42546585406;12827.871721282761;19881.60236795256;1793.4081753021471;1800.0549711401488;1803.1615298886081;1810.185416562552;2282.4750307429217;9529.428234305964;9846.704598862045;9860.211183105333;9869.90130098697;11071.667849964513;1728.5073753980055;1747.4670225581192;1766.8763186576946;1808.4213051823422;1814.4647329037966;66973.3302666972;70465;72978;73157;73394;10242.231832612435;10302.433366164933;10333.896661033445;10363.896361036444;10444.895551044392;14043.438262469386;14095.295235238196;14232.715345693028;14235.78646320306;14237.505061968344;6760.290169532227;6802.863942721118;6897;6918.792436226921;6950.721971121098;6198.597091189058;6243.875122497525;6282.151909492251;6407.903881441782;6423.261324947597;4295.4415925929425;4331.263685173528;4362.9781851091175;4393.406890069864;4526.411566496335;1599.528139198939;1774.4055741326542;1793.1124093573765;1836.1186630417474;1873.7189421586597;793.9682412703543;807.6123460738878;826.6445428465697;866.27233124176;883.3463237204422;17026.404075857285;17288.308467661405;17399.56501087483;17579.648407032044;17945.461636150936;846.3229416466802;859.574510617236;877.1842186766369;878.7934835313696;910.0580898769741;9561.187299079516;9734.221262299;10136.746581335525;10579.89420105789;10587.947060264803;394597;396031;396242;397250;402277;84597;87777;87915;89827;90295.54852225828;874.7141701698494;878.2096113497903;902.3818684201212;912.2884150362728;919.5678031325266;12333.444994975069;16397.42609008679;16412.343506259615;16490;16770.664586707953;26677.199684009513;30151.547726783676;39164.6083539161;39315.80342098271;39840.60159398369;45741;54405;55488.445115548326;55758.72120639371;56270;7354.448416368687;7630.923690763021;7723.613819309125;7754.922450775645;7809.3362064225175;8309.792255193668;10865.456727163451;11226.831597525881;11458.427078645867;11470.254433461798;10149.949250253701;10216.642417515352;10266.538005789907;10364.585416583252;10580.576776928836;9698.56356463975;9852.802943941224;9900.158486528439;9973.900260997587;10105.646302379382;5397.919031214614;8011.6795328188555;10261.127804136433;10393.480325983519;10561.207909406672;7627.656755446129;7628.084629844454;7691.769246922601;7836.84326313482;7916.643751031333;8888.422252553562;10027.348222365523;10075.596976120873;10174.389536627827;10209.54057067419 15:53:42 INFO - PROCESS | 17877 | |3;mootools.html;1363.781794912814;1412.7668934625785;1478.1943840606868;1702.4807433732706;1704.0883127526777;7709.730159444413;8174.9781277340335;8268.338532917367;8268.627911743972;8274.420790544656;6959;7169.964150179255;7677.23227677232;7968.243016913399;8123.47197432168;2202.8104823395347;2229.7993180613744;2229.9296337757887;2232.7097477327925;2232.821374290061;1815.8093400192988;2202.812760915316;2216.8891555422247;2253.188852013282;2259.7740225977436;2133.5839511295303;2192.7916847899423;2200.702905107806;2206.4042708468705;2210.071769856656;2170.8806015669134;2179.1936983316195;2183.1049269799387;2185.672149177636;2240.708707867983;2200.9119635214734;2204.9669254961186;2205.2722601541454;2207.4371035385875;2207.812335951446;8210.548419836907;8214.26071653554;8274.213949674771;8279.54462504562;8280.668773249063;4357.607815296638;4507.2788353863225;4515.683902126852;4515.774211289422;4521.909561808746;2603.2450589329073;2729.849858257795;2731.754142127198;2733.9453210935867;2743.8490883001427;820;833.5123952487802;841.8442588121156;857.901341345747;858.1675774498726;10616.150707943347;10631.415272160028;10634.415107169103;10645.84031239532;10654.4140072296;4072.429859819628;4157.875263742093;4305.870823875289;4310.051788606502;4310.978445107817;8994.775130621787;9057.501837399006;9095.181433671001;9095.272378209727;9097.636094556143;4540.77296135192;4545.749983750859;4545.931811022837;4546.204414227497;4548.226801443762;4008.659263962596;4094.8566800161852;4096.262672718939;4098.098418347959;4100.5489396166395;3806.8667596633986;3813.256414999104;3851.6340947609933;3939.330313846653;3952.6837852971694;1073.9463026848625;1218.7196944702769;1251.9436625351882;1261.7161138743893;1262.7979523276415;613.3774219167549;714.7819914925893;717.3651318583092;741.935322811756;851.7572491839796;5196.350456192976;5295.761690723926;5393.110136827458;5489.368722596872;5570.080936645408;778.5134291068082;854.5257382152964;855.9771073567027;870.7520946868091;877.0308808766349;3365.1060879898696;3622.836972336251;3663.1025398776937;3708.5364329458816;3716.591174970751;9909.405435673883;10050.899491005142;10054;10268.537915793808;10277.845832312521;8849.69026084084;10115;10121.59513619447;10129.088382045504;10143.08712215904;7233.89149162763;7620.085589729268;7622.2758837910305;7824.491408058458;7824.491408058458;5277.366715994105;5437.429069947599;5477.917831232615;5485.232067510631;5643.88712225745;9216.723498295061;9272.119148680864;9480.95259523698;9523.047695230422;9524.476153811607;9350.251979841732;9419.246460283024;9436.85844712316;9637;9713.222942164468;6640.269570347355;6743.797686069426;6780.084688566981;6798.082258894986;6798.354156355138;7647.655855486405;7822;7863.292303692695;7863.567503787347;7870.9606451967375;6730.966345168243;6768.08630834831;6965.373116419547;7023.051887995055;7043.718251269892;6918.238993710788;7115.1106111736035;7136.500444968802;7210.206877243604;7276.818079548054;6401.039844023434;6490.870182596227;6549.934500654933;6647.368499992493;6660.100886380276;4705.106029854317;4864.416270047475;4870.4155501340065;4895.7062576245535;4982.975085124551;4927.260910863399;4958.305837182726;4971.353724015855;4978.228374601942;5161.22581612746 15:53:42 INFO - PROCESS | 17877 | |4;prototype.html;298.4195739287087;308.39092791736323;312.5046800820699;315.77895473168786;316.21893922012623;4846.85459436217;4881.023795240957;4897.412310522738;4925.556699897009;4964.379452568429;4830.710157390559;4866.58634016109;4870.074685809703;4875.853724388265;4879.218845258204;3639.7998110103936;3727.440883867428;3759.154190307186;3818.1409182933894;3833.386658134699;3793.905152371185;3801.4107813288983;3807.591191259238;3819.3316169670334;3823.139793546444;3622.56908521134;3777.0368556018175;3798;3800.6959443244473;3809.3333666608232;3687.1703866630064;3837.808109594509;3840.116773142165;3842.3660096084113;3844.634759697838;3392.542006829071;3399.6430374810784;3404.6254911959663;3404.8297585120645;3411.624721280657;4748.527956333513;4758.191107511731;4763.523647635208;4764.665893549812;4765.618750499952;4242.91514169718;4393.319035549463;4399.868003959854;4414.293713005935;4421.182081314967;5082;5090.880006398586;5093.694378337274;5112.948870511284;5116.155834287338;3713.517242758424;3722.5431215397707;3733.4026555750947;3736.1406876418578;3751.643593858579;5149.716765577892;5221.347331583552;5322.7072511011875;5325.973370133163;5343.8510720195345;3764.7176461765475;3798.67046533711;3799.2903193562456;3805.809709514513;3815.6565909068318;3873.3028054949814;3880.7477513961503;3881.9611803882162;3885.048163200034;3886.84452621892;4368.4102646143;4370.584794444522;4373.409589705413;4387.100644367897;4397.296432570837;4891.608671306287;5093.9490605094215;5099.464556221544;5117.669405954479;5119.3088932994315;1318.4264844792547;1332.1948759431025;1339.5800451521418;1342.3221273257138;1342.912710673803;849.6049337058298;874.3355050161923;876.8334016536837;877.3419935048713;878.0780180810124;4273.743575385487;4336.4145840311785;4460.397846290709;4461.866144015685;4475.820967161277;5172;5174.922376164361;5222.1383471727495;5226.895462090737;5231.450697676765;4256;4428.269335559661;4429.313456414261;4442.089371678798;4489.2592722201125;2758.7517123458983;2771.3487330477324;2786.857388470717;2791.441711657636;2793.231861238176;4960.429550601727;4975.925361119586;4982.676126051795;4984.77568509418;4993.151164302078;5089.440161582223;5306.54894333986;5365.812196573102;5366.141417373202;5376.838694839161;4932.260160975882;4946.777395017233;4972.353594032753;4983.07813054586;4989.775460104304;5117.692938423706;5156.484351564814;5224.477552244897;5252.868678282921;5256.316678831728;5004.199328107486;5056.9013859248;5094.465081166424;5102.923456148086;5172.275881376535;4885.877853053702;4918.532739389752;4930.433000204879;4940.407151141886;4953.455119936732;3787.9242415150993;3793.506844110248;3803.6766874814844;3815.8664446744233;3825.2923209206388;5006.674566153189;5207.843764687065;5231.55531779803;5268.2361057647195;5283.973580132075;5060.266261392151;5065.797368105382;5086.135356989246;5086.21163719624;5086.61850361217;5065.13892638245;5110.8466745997675;5131.204663277198;5147.6654017488745;5154.664946778447;4702.341672165831;4878.195097808822;4942.481039490802;5001.64988450805;5071.39143302806;4902.558769710743;5047.520485553867;5057.8735531612;5092.796288148433;5100.719460429712;4968.8757781055765;4984.850454486371;4988.351514303263;4994.6503744738975;4995.375578052744 15:53:42 INFO - PROCESS | 17877 | |5;yui.html;582.2954225387281;595.4224402329738;611.129140974112;689.6999805084788;698.7065432518342;12827.807582886253;13931.164130152185;14046.578602641925;14785.112893226415;15371.385144594231;15104.697906041873;15397.84602153978;15398.153101579408;15398.615034624112;15531.767023494656;634.7461015593753;646.3407324528978;780.9648565814538;807.4832107451207;808.9878651820227;765.6248438265238;774.0865778381535;791.0941971442695;792.4096548071694;793.2226418110256;831.8170002599419;833.3624777045565;834.8413801377749;835.8035861572556;836.0343802907652;657.1227411405779;675.1627981303197;817.3257062923053;820.9753707388788;821.109096630157;498.49402856101085;498.55379435405473;595.0776296740036;599.9580029397944;614.3794767285029;13707.520236791765;13717.0398072135;13722.176669399869;13724.794128088086;13775.173489590657;12394.75210495785;12984.15602985803;12987.610371688865;12994.350282485932;13123.354334564088;11800.291982481078;12089.758204835854;12125.21186122908;12199.329036902967;12347.876521234763;4178.686598505094;4202.201581699467;4227.577242275778;4229.492460904711;4231.069164783743;58098.70950645262;58147.127793083564;58392;58623;58878.705606471696;10222.284440089123;10287.691369258935;10306.896931030744;10531.368117912796;10710.250282480152;17718.822811771974;17771.733423998652;17774.644507110042;17792.288308467516;17806.198721057583;6402.551821372459;6544.869102617921;6547.738090476328;6553.63954982471;6562.934370656232;3765.548134223911;3829.9042523937123;3849.172427928009;3903.277893589695;3924.7056470764805;2710.2817753295394;2805.76151027165;2806.214260007201;2812.4656315300026;2813.817101888412;485.4902352529829;486.77851577532135;487.1742396637665;498.6858279284028;500.43450900482225;453.605363333895;468.92497200447764;481.8747125747331;487.2763945540869;517.4230732733051;6848.315168483212;7018.789436316919;7145.499815013003;7218.061651985208;7242.746503872445;429.90971895901583;436.7859748723166;465.8858579648008;476.3902205177379;507.8933423980931;3475.548178736748;3675.5038069860225;3715.6098609646137;3797.715171362159;3952.9209415811524;92136;93122;94552.52723736475;95885;96243.03756962481;81944.59027704943;82168;83244;85321;86272;71487;72678.2732172682;72875.2712472879;73151.63424182845;73954;7228.63856807147;7422.480426370103;7426.962865185639;7445.10658720957;7514.436417268617;41247.793761031004;41432.79283603562;41867.37198942079;42051;43746;59119.40880591139;59539.106913395466;60225;60944.695276523336;61112;9505.097015783489;9617;9653.420794752337;10052.296339256474;10229.948850255701;9749.463779492196;9896.406215627085;9989.250806189419;10298.897011029794;11192.104631629287;9528.14246717771;9648.324617276723;9768.902310976799;9917.65288214909;9955.452450115314;8912.777180570538;9061.456312621263;9116.179543841086;9431;9431.764205894633;9380.765480863032;9781.217502599633;9794.804103918024;9910.603575856885;9958.751031223988;8341.16588341161;8561.743147705578;8614.18165274298;8666.7066514724;8781.648734050821;8156.796080098045;8440.409171358191;8649.783755405913;8702.912970870464;8854.601542930712 15:53:42 INFO - PROCESS | 17877 | __end_tp_report 15:53:42 INFO - PROCESS | 17877 | __start_cc_report 15:53:42 INFO - PROCESS | 17877 | _x_x_mozilla_cycle_collect,1064 15:53:42 INFO - PROCESS | 17877 | __end_cc_report 15:53:42 INFO - PROCESS | 17877 | __startTimestamp1468450422871__endTimestamp 15:53:42 INFO - PROCESS | 17877 | 15:53:42 INFO - PROCESS | 17877 | ------- Summary: start ------- 15:53:42 INFO - PROCESS | 17877 | Number of tests: 6 15:53:42 INFO - PROCESS | 17877 | 15:53:42 INFO - PROCESS | 17877 | [#0] dojo.html Cycles:165 Average:4597.79 Median:4749.88 stddev:488.39 (10.3%) stddev-sans-first:464.03 15:53:42 INFO - PROCESS | 17877 | Values: 2598.9 2600.5 2629.3 2638.9 2650.4 4439.9 4576.7 4645.0 4653.1 4655.6 4583.4 4586.6 4588.3 4609.7 4624.3 4018.9 4187.4 4252.6 4286.0 4388.5 4306.7 4370.2 4374.0 4378.1 4398.2 4100.3 4130.1 4271.8 4279.5 4286.2 4264.9 4275.7 4306.3 4312.4 4316.1 4299.7 4308.8 4311.3 4329.5 4348.0 4486.6 4517.1 4639.6 4641.9 4661.3 5001.3 5026.8 5033.1 5034.2 5046.8 4829.9 5063.4 5069.7 5075.1 5077.2 4627.4 4689.5 4691.5 4756.9 4764.0 5186.9 5225.9 5226.3 5227.7 5230.2 4677.7 4845.9 4849.3 4900.5 4902.3 4892.2 4961.5 4989.7 4996.8 5018.5 4939.3 4943.4 4950.5 4952.1 4993.9 4710.2 4828.4 4929.5 4933.4 4980.9 4136.0 4142.1 4160.9 4185.3 4198.5 3655.8 3662.9 3673.7 3696.2 3713.4 4174.2 4212.6 4215.7 4272.4 4275.0 4939.3 4966.4 5022.1 5036.6 5042.3 4297.4 4317.1 4326.4 4362.8 4367.6 4286.1 4354.2 4478.9 4485.2 4485.9 4726.6 4751.4 4773.4 4778.5 4823.2 5026.1 5028.5 5031.5 5032.0 5064.6 4527.0 4677.7 4720.9 4816.5 4823.3 4904.1 4905.6 4915.6 4924.4 4963.5 4976.9 4989.4 4989.8 4994.4 5028.8 4671.9 4691.9 4779.7 4851.5 4901.0 4842.6 4851.0 4855.4 4857.6 4912.8 4781.7 4782.9 4786.2 4793.4 4830.3 4707.5 4775.6 4822.9 4854.4 4868.6 4749.9 4759.6 4772.8 4774.9 4815.0 15:53:42 INFO - PROCESS | 17877 | 15:53:42 INFO - PROCESS | 17877 | [#1] ext.html Cycles:180 Average:45481.96 Median:33615.75 stddev:78773.28 (234.3%) stddev-sans-first:78922.11 15:53:42 INFO - PROCESS | 17877 | Values: 577.7 585.4 590.4 590.9 591.6 27150.7 39371.8 40555.6 40637.4 44089.3 40166.0 40406.0 40562.6 40595.4 40608.0 7514.4 7789.2 7917.4 7930.0 7939.2 7692.5 7791.6 7792.4 10043.3 10327.1 10382.8 10414.3 10418.4 10421.9 10454.8 10312.6 10344.1 10386.4 10398.9 10404.5 7512.6 7752.9 7757.9 9879.6 10312.1 38216.8 38577.0 38605.4 38653.2 38659.2 3008.7 3053.9 3085.2 3103.4 3166.9 28442.3 29896.0 29974.0 30060.0 30096.0 2833.7 2855.1 2857.3 2873.6 2932.7 247917.0 248898.0 249370.0 249681.0 249964.0 52572.0 53117.5 53183.2 53201.5 53235.0 55748.0 55838.2 55999.0 56041.2 56146.7 13908.1 14322.2 14332.1 14340.9 14342.5 9990.2 10760.1 10845.7 10845.8 10848.6 14877.8 15488.1 15499.5 15846.0 15981.5 5833.4 5927.9 5944.9 5969.8 6065.8 815.0 855.4 878.0 914.7 957.9 26530.3 27532.3 27561.0 27878.2 28015.4 944.4 966.4 969.5 1010.0 1051.8 14384.4 14803.8 15098.7 15761.4 15821.4 350654.0 351294.0 351560.0 353586.0 354032.0 49245.5 49592.0 49703.0 49712.5 49857.5 1097.3 1152.1 1167.8 1216.4 1225.3 26797.0 28015.7 28394.3 28949.7 29121.4 40959.6 41109.6 41387.0 41622.4 41638.8 289277.0 290509.0 290664.0 291491.0 291502.0 21303.9 23516.4 24410.8 24418.6 24562.3 40649.8 40715.8 40775.2 41261.4 41619.8 32962.8 35228.5 35465.3 35862.8 35934.5 34960.7 35656.3 35677.1 35761.0 35944.6 34268.7 34418.5 34647.1 34749.1 35222.3 31227.0 31620.5 31738.4 31823.0 31951.5 23336.5 23392.6 23757.5 23907.0 23917.8 15:53:42 INFO - PROCESS | 17877 | 15:53:42 INFO - PROCESS | 17877 | [#2] jquery.html Cycles:180 Average:24484.43 Median:4459.91 stddev:65974.42 (1479.3%) stddev-sans-first:66134.67 15:53:42 INFO - PROCESS | 17877 | Values: 376.8 376.9 377.7 381.9 391.1 16807.5 17073.4 17800.6 18019.6 18032.0 10804.1 11155.1 11189.9 11208.3 11210.4 4314.0 4644.1 5288.0 5290.1 5293.0 5151.4 5198.1 5203.1 5208.2 5218.7 4641.8 4767.2 4772.6 4784.3 5189.6 4746.2 4763.9 4799.7 4801.9 4810.0 4567.2 4609.5 4651.8 4655.1 4695.1 12669.9 12760.1 12767.4 12827.9 19881.6 1793.4 1800.1 1803.2 1810.2 2282.5 9529.4 9846.7 9860.2 9869.9 11071.7 1728.5 1747.5 1766.9 1808.4 1814.5 66973.3 70465.0 72978.0 73157.0 73394.0 10242.2 10302.4 10333.9 10363.9 10444.9 14043.4 14095.3 14232.7 14235.8 14237.5 6760.3 6802.9 6897.0 6918.8 6950.7 6198.6 6243.9 6282.2 6407.9 6423.3 4295.4 4331.3 4363.0 4393.4 4526.4 1599.5 1774.4 1793.1 1836.1 1873.7 794.0 807.6 826.6 866.3 883.3 17026.4 17288.3 17399.6 17579.6 17945.5 846.3 859.6 877.2 878.8 910.1 9561.2 9734.2 10136.7 10579.9 10587.9 394597.0 396031.0 396242.0 397250.0 402277.0 84597.0 87777.0 87915.0 89827.0 90295.5 874.7 878.2 902.4 912.3 919.6 12333.4 16397.4 16412.3 16490.0 16770.7 26677.2 30151.5 39164.6 39315.8 39840.6 45741.0 54405.0 55488.4 55758.7 56270.0 7354.4 7630.9 7723.6 7754.9 7809.3 8309.8 10865.5 11226.8 11458.4 11470.3 10149.9 10216.6 10266.5 10364.6 10580.6 9698.6 9852.8 9900.2 9973.9 10105.6 5397.9 8011.7 10261.1 10393.5 10561.2 7627.7 7628.1 7691.8 7836.8 7916.6 8888.4 10027.3 10075.6 10174.4 10209.5 15:53:42 INFO - PROCESS | 17877 | 15:53:42 INFO - PROCESS | 17877 | [#3] mootools.html Cycles:180 Average:5270.27 Median:4980.60 stddev:2994.19 (60.1%) stddev-sans-first:2988.20 15:53:42 INFO - PROCESS | 17877 | Values: 1363.8 1412.8 1478.2 1702.5 1704.1 7709.7 8175.0 8268.3 8268.6 8274.4 6959.0 7170.0 7677.2 7968.2 8123.5 2202.8 2229.8 2229.9 2232.7 2232.8 1815.8 2202.8 2216.9 2253.2 2259.8 2133.6 2192.8 2200.7 2206.4 2210.1 2170.9 2179.2 2183.1 2185.7 2240.7 2200.9 2205.0 2205.3 2207.4 2207.8 8210.5 8214.3 8274.2 8279.5 8280.7 4357.6 4507.3 4515.7 4515.8 4521.9 2603.2 2729.8 2731.8 2733.9 2743.8 820.0 833.5 841.8 857.9 858.2 10616.2 10631.4 10634.4 10645.8 10654.4 4072.4 4157.9 4305.9 4310.1 4311.0 8994.8 9057.5 9095.2 9095.3 9097.6 4540.8 4545.7 4545.9 4546.2 4548.2 4008.7 4094.9 4096.3 4098.1 4100.5 3806.9 3813.3 3851.6 3939.3 3952.7 1073.9 1218.7 1251.9 1261.7 1262.8 613.4 714.8 717.4 741.9 851.8 5196.4 5295.8 5393.1 5489.4 5570.1 778.5 854.5 856.0 870.8 877.0 3365.1 3622.8 3663.1 3708.5 3716.6 9909.4 10050.9 10054.0 10268.5 10277.8 8849.7 10115.0 10121.6 10129.1 10143.1 7233.9 7620.1 7622.3 7824.5 7824.5 5277.4 5437.4 5477.9 5485.2 5643.9 9216.7 9272.1 9481.0 9523.0 9524.5 9350.3 9419.2 9436.9 9637.0 9713.2 6640.3 6743.8 6780.1 6798.1 6798.4 7647.7 7822.0 7863.3 7863.6 7871.0 6731.0 6768.1 6965.4 7023.1 7043.7 6918.2 7115.1 7136.5 7210.2 7276.8 6401.0 6490.9 6549.9 6647.4 6660.1 4705.1 4864.4 4870.4 4895.7 4983.0 4927.3 4958.3 4971.4 4978.2 5161.2 15:53:42 INFO - PROCESS | 17877 | 15:53:42 INFO - PROCESS | 17877 | [#4] prototype.html Cycles:180 Average:4238.56 Median:4877.02 stddev:1213.78 (24.9%) stddev-sans-first:1180.61 15:53:42 INFO - PROCESS | 17877 | Values: 298.4 308.4 312.5 315.8 316.2 4846.9 4881.0 4897.4 4925.6 4964.4 4830.7 4866.6 4870.1 4875.9 4879.2 3639.8 3727.4 3759.2 3818.1 3833.4 3793.9 3801.4 3807.6 3819.3 3823.1 3622.6 3777.0 3798.0 3800.7 3809.3 3687.2 3837.8 3840.1 3842.4 3844.6 3392.5 3399.6 3404.6 3404.8 3411.6 4748.5 4758.2 4763.5 4764.7 4765.6 4242.9 4393.3 4399.9 4414.3 4421.2 5082.0 5090.9 5093.7 5112.9 5116.2 3713.5 3722.5 3733.4 3736.1 3751.6 5149.7 5221.3 5322.7 5326.0 5343.9 3764.7 3798.7 3799.3 3805.8 3815.7 3873.3 3880.7 3882.0 3885.0 3886.8 4368.4 4370.6 4373.4 4387.1 4397.3 4891.6 5093.9 5099.5 5117.7 5119.3 1318.4 1332.2 1339.6 1342.3 1342.9 849.6 874.3 876.8 877.3 878.1 4273.7 4336.4 4460.4 4461.9 4475.8 5172.0 5174.9 5222.1 5226.9 5231.5 4256.0 4428.3 4429.3 4442.1 4489.3 2758.8 2771.3 2786.9 2791.4 2793.2 4960.4 4975.9 4982.7 4984.8 4993.2 5089.4 5306.5 5365.8 5366.1 5376.8 4932.3 4946.8 4972.4 4983.1 4989.8 5117.7 5156.5 5224.5 5252.9 5256.3 5004.2 5056.9 5094.5 5102.9 5172.3 4885.9 4918.5 4930.4 4940.4 4953.5 3787.9 3793.5 3803.7 3815.9 3825.3 5006.7 5207.8 5231.6 5268.2 5284.0 5060.3 5065.8 5086.1 5086.2 5086.6 5065.1 5110.8 5131.2 5147.7 5154.7 4702.3 4878.2 4942.5 5001.6 5071.4 4902.6 5047.5 5057.9 5092.8 5100.7 4968.9 4984.9 4988.4 4994.7 4995.4 15:53:42 INFO - PROCESS | 17877 | 15:53:42 INFO - PROCESS | 17877 | [#5] yui.html Cycles:180 Average:17095.42 Median:30069.53 stddev:24631.56 (81.9%) stddev-sans-first:24669.45 15:53:42 INFO - PROCESS | 17877 | Values: 582.3 595.4 611.1 689.7 698.7 12827.8 13931.2 14046.6 14785.1 15371.4 15104.7 15397.8 15398.2 15398.6 15531.8 634.7 646.3 781.0 807.5 809.0 765.6 774.1 791.1 792.4 793.2 831.8 833.4 834.8 835.8 836.0 657.1 675.2 817.3 821.0 821.1 498.5 498.6 595.1 600.0 614.4 13707.5 13717.0 13722.2 13724.8 13775.2 12394.8 12984.2 12987.6 12994.4 13123.4 11800.3 12089.8 12125.2 12199.3 12347.9 4178.7 4202.2 4227.6 4229.5 4231.1 58098.7 58147.1 58392.0 58623.0 58878.7 10222.3 10287.7 10306.9 10531.4 10710.3 17718.8 17771.7 17774.6 17792.3 17806.2 6402.6 6544.9 6547.7 6553.6 6562.9 3765.5 3829.9 3849.2 3903.3 3924.7 2710.3 2805.8 2806.2 2812.5 2813.8 485.5 486.8 487.2 498.7 500.4 453.6 468.9 481.9 487.3 517.4 6848.3 7018.8 7145.5 7218.1 7242.7 429.9 436.8 465.9 476.4 507.9 3475.5 3675.5 3715.6 3797.7 3952.9 92136.0 93122.0 94552.5 95885.0 96243.0 81944.6 82168.0 83244.0 85321.0 86272.0 71487.0 72678.3 72875.3 73151.6 73954.0 7228.6 7422.5 7427.0 7445.1 7514.4 41247.8 41432.8 41867.4 42051.0 43746.0 59119.4 59539.1 60225.0 60944.7 61112.0 9505.1 9617.0 9653.4 10052.3 10229.9 9749.5 9896.4 9989.3 10298.9 11192.1 9528.1 9648.3 9768.9 9917.7 9955.5 8912.8 9061.5 9116.2 9431.0 9431.8 9380.8 9781.2 9794.8 9910.6 9958.8 8341.2 8561.7 8614.2 8666.7 8781.6 8156.8 8440.4 8649.8 8702.9 8854.6 15:53:42 INFO - PROCESS | 17877 | -------- Summary: end -------- 15:53:42 INFO - PROCESS | 17877 | 15:53:43 INFO - TEST-INFO | 17877: exit 0 15:53:43 INFO - TEST-OK | dromaeo_css | took 1119176ms 15:53:43 INFO - TEST-START | kraken 15:53:43 INFO - operating with platform_type : linux_ 15:53:43 INFO - Initialising browser for kraken test... 15:53:43 INFO - TEST-INFO | started process 18066 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuM7ftv/profile http://localhost:35155/getInfo.html) 15:53:48 INFO - PROCESS | 18066 | __metrics Screen width/height:1600/1200 15:53:48 INFO - PROCESS | 18066 | colorDepth:24 15:53:48 INFO - PROCESS | 18066 | Browser inner width/height: 1024/697 15:53:48 INFO - PROCESS | 18066 | __metrics 15:53:48 INFO - PROCESS | 18066 | 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" 15:53:48 INFO - PROCESS | 18066 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:53:49 INFO - TEST-INFO | 18066: exit 0 15:53:49 INFO - Browser initialized. 15:53:49 INFO - Running cycle 1/1 for kraken test... 15:53:49 INFO - TEST-INFO | started process 18148 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuM7ftv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:54:01 INFO - PROCESS | 18148 | RSS: Main: 159145984 15:54:01 INFO - PROCESS | 18148 | 15:54:04 INFO - PROCESS | 18148 | Cycle 1(1): loaded http://localhost:35155/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35155/tests/kraken/driver.html?testName=audio-beat-detection) 15:54:05 INFO - PROCESS | 18148 | RSS: Main: 216842240 15:54:05 INFO - PROCESS | 18148 | 15:54:08 INFO - PROCESS | 18148 | Cycle 1(1): loaded http://localhost:35155/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35155/tests/kraken/driver.html?testName=audio-dft) 15:54:08 INFO - PROCESS | 18148 | RSS: Main: 203747328 15:54:08 INFO - PROCESS | 18148 | 15:54:12 INFO - PROCESS | 18148 | Cycle 1(1): loaded http://localhost:35155/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35155/tests/kraken/driver.html?testName=audio-fft) 15:54:12 INFO - PROCESS | 18148 | RSS: Main: 271101952 15:54:12 INFO - PROCESS | 18148 | 15:54:14 INFO - PROCESS | 18148 | Cycle 1(1): loaded http://localhost:35155/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35155/tests/kraken/driver.html?testName=audio-oscillator) 15:54:15 INFO - PROCESS | 18148 | RSS: Main: 181653504 15:54:15 INFO - PROCESS | 18148 | 15:54:17 INFO - PROCESS | 18148 | Cycle 1(1): loaded http://localhost:35155/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35155/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:54:18 INFO - PROCESS | 18148 | RSS: Main: 186847232 15:54:18 INFO - PROCESS | 18148 | 15:54:21 INFO - PROCESS | 18148 | Cycle 1(1): loaded http://localhost:35155/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35155/tests/kraken/driver.html?testName=imaging-darkroom) 15:54:22 INFO - PROCESS | 18148 | RSS: Main: 222310400 15:54:22 INFO - PROCESS | 18148 | 15:54:25 INFO - PROCESS | 18148 | Cycle 1(1): loaded http://localhost:35155/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35155/tests/kraken/driver.html?testName=imaging-desaturate) 15:54:26 INFO - PROCESS | 18148 | RSS: Main: 217833472 15:54:26 INFO - PROCESS | 18148 | 15:54:29 INFO - PROCESS | 18148 | Cycle 1(1): loaded http://localhost:35155/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35155/tests/kraken/driver.html?testName=json-parse-financial) 15:54:29 INFO - PROCESS | 18148 | RSS: Main: 221437952 15:54:29 INFO - PROCESS | 18148 | 15:54:31 INFO - PROCESS | 18148 | Cycle 1(1): loaded http://localhost:35155/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35155/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:54:32 INFO - PROCESS | 18148 | RSS: Main: 206032896 15:54:32 INFO - PROCESS | 18148 | 15:54:33 INFO - PROCESS | 18148 | Cycle 1(1): loaded http://localhost:35155/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35155/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:54:34 INFO - PROCESS | 18148 | RSS: Main: 211582976 15:54:34 INFO - PROCESS | 18148 | 15:54:36 INFO - PROCESS | 18148 | Cycle 1(1): loaded http://localhost:35155/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35155/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:54:37 INFO - PROCESS | 18148 | RSS: Main: 210493440 15:54:37 INFO - PROCESS | 18148 | 15:54:40 INFO - PROCESS | 18148 | Cycle 1(1): loaded http://localhost:35155/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35155/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:54:40 INFO - PROCESS | 18148 | RSS: Main: 222216192 15:54:40 INFO - PROCESS | 18148 | 15:54:43 INFO - PROCESS | 18148 | Cycle 1(1): loaded http://localhost:35155/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35155/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:54:44 INFO - PROCESS | 18148 | RSS: Main: 225099776 15:54:44 INFO - PROCESS | 18148 | 15:54:45 INFO - PROCESS | 18148 | Cycle 1(1): loaded http://localhost:35155/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35155/tests/kraken/driver.html?testName=ai-astar) 15:54:46 INFO - PROCESS | 18148 | RSS: Main: 267018240 15:54:46 INFO - PROCESS | 18148 | 15:54:46 INFO - PROCESS | 18148 | __start_tp_report 15:54:46 INFO - PROCESS | 18148 | _x_x_mozilla_page_load 15:54:46 INFO - PROCESS | 18148 | _x_x_mozilla_page_load_details 15:54:46 INFO - PROCESS | 18148 | |i|pagename|runs| 15:54:46 INFO - PROCESS | 18148 | |0;ai-astar;105;114;114;114;114;113;113;116;113;115 15:54:46 INFO - PROCESS | 18148 | |1;audio-beat-detection;146;121;122;175;122;129;153;122;190;127 15:54:46 INFO - PROCESS | 18148 | |2;audio-dft;161;161;162;162;162;162;162;162;162;163 15:54:46 INFO - PROCESS | 18148 | |3;audio-fft;75;75;76;132;76;76;76;75;102;75 15:54:46 INFO - PROCESS | 18148 | |4;audio-oscillator;86;86;123;85;85;85;126;85;84;123 15:54:46 INFO - PROCESS | 18148 | |5;imaging-gaussian-blur;117;118;117;117;117;116;117;117;117;118 15:54:46 INFO - PROCESS | 18148 | |6;imaging-darkroom;147;147;147;146;146;146;153;147;146;146 15:54:46 INFO - PROCESS | 18148 | |7;imaging-desaturate;94;95;95;95;95;94;94;96;94;94 15:54:46 INFO - PROCESS | 18148 | |8;json-parse-financial;64;65;72;65;66;64;66;64;64;65 15:54:46 INFO - PROCESS | 18148 | |9;json-stringify-tinderbox;65;65;65;65;66;64;65;66;66;65 15:54:46 INFO - PROCESS | 18148 | |10;stanford-crypto-aes;78;78;79;79;79;79;82;79;78;79 15:54:46 INFO - PROCESS | 18148 | |11;stanford-crypto-ccm;128;127;131;129;126;125;129;128;208;143 15:54:46 INFO - PROCESS | 18148 | |12;stanford-crypto-pbkdf2;165;164;161;163;167;163;162;165;163;167 15:54:46 INFO - PROCESS | 18148 | |13;stanford-crypto-sha256-iterative;66;67;69;66;69;66;66;66;66;66 15:54:46 INFO - PROCESS | 18148 | __end_tp_report 15:54:46 INFO - PROCESS | 18148 | __start_cc_report 15:54:46 INFO - PROCESS | 18148 | _x_x_mozilla_cycle_collect,1896 15:54:46 INFO - PROCESS | 18148 | __end_cc_report 15:54:46 INFO - PROCESS | 18148 | __startTimestamp1468450486105__endTimestamp 15:54:46 INFO - PROCESS | 18148 | 15:54:46 INFO - PROCESS | 18148 | ------- Summary: start ------- 15:54:46 INFO - PROCESS | 18148 | Number of tests: 14 15:54:46 INFO - PROCESS | 18148 | 15:54:46 INFO - PROCESS | 18148 | [#0] ai-astar Cycles:10 Average:113.10 Median:114.00 stddev:3.00 (2.6%) stddev-sans-first:1.00 15:54:46 INFO - PROCESS | 18148 | Values: 105.0 114.0 114.0 114.0 114.0 113.0 113.0 116.0 113.0 115.0 15:54:46 INFO - PROCESS | 18148 | 15:54:46 INFO - PROCESS | 18148 | [#1] audio-beat-detection Cycles:10 Average:140.70 Median:137.50 stddev:24.83 (18.1%) stddev-sans-first:26.26 15:54:46 INFO - PROCESS | 18148 | Values: 146.0 121.0 122.0 175.0 122.0 129.0 153.0 122.0 190.0 127.0 15:54:46 INFO - PROCESS | 18148 | 15:54:46 INFO - PROCESS | 18148 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 15:54:46 INFO - PROCESS | 18148 | Values: 161.0 161.0 162.0 162.0 162.0 162.0 162.0 162.0 162.0 163.0 15:54:46 INFO - PROCESS | 18148 | 15:54:46 INFO - PROCESS | 18148 | [#3] audio-fft Cycles:10 Average:83.80 Median:75.50 stddev:18.88 (25.0%) stddev-sans-first:19.75 15:54:46 INFO - PROCESS | 18148 | Values: 75.0 75.0 76.0 132.0 76.0 76.0 76.0 75.0 102.0 75.0 15:54:46 INFO - PROCESS | 18148 | 15:54:46 INFO - PROCESS | 18148 | [#4] audio-oscillator Cycles:10 Average:96.80 Median:85.00 stddev:18.80 (22.1%) stddev-sans-first:19.53 15:54:46 INFO - PROCESS | 18148 | Values: 86.0 86.0 123.0 85.0 85.0 85.0 126.0 85.0 84.0 123.0 15:54:46 INFO - PROCESS | 18148 | 15:54:46 INFO - PROCESS | 18148 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 15:54:46 INFO - PROCESS | 18148 | Values: 117.0 118.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 118.0 15:54:46 INFO - PROCESS | 18148 | 15:54:46 INFO - PROCESS | 18148 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:2.13 (1.5%) stddev-sans-first:2.26 15:54:46 INFO - PROCESS | 18148 | Values: 147.0 147.0 147.0 146.0 146.0 146.0 153.0 147.0 146.0 146.0 15:54:46 INFO - PROCESS | 18148 | 15:54:46 INFO - PROCESS | 18148 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 15:54:46 INFO - PROCESS | 18148 | Values: 94.0 95.0 95.0 95.0 95.0 94.0 94.0 96.0 94.0 94.0 15:54:46 INFO - PROCESS | 18148 | 15:54:46 INFO - PROCESS | 18148 | [#8] json-parse-financial Cycles:10 Average:65.50 Median:65.00 stddev:2.42 (3.7%) stddev-sans-first:2.50 15:54:46 INFO - PROCESS | 18148 | Values: 64.0 65.0 72.0 65.0 66.0 64.0 66.0 64.0 64.0 65.0 15:54:46 INFO - PROCESS | 18148 | 15:54:46 INFO - PROCESS | 18148 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 15:54:46 INFO - PROCESS | 18148 | Values: 65.0 65.0 65.0 65.0 66.0 64.0 65.0 66.0 66.0 65.0 15:54:46 INFO - PROCESS | 18148 | 15:54:46 INFO - PROCESS | 18148 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:79.00 stddev:1.15 (1.5%) stddev-sans-first:1.17 15:54:46 INFO - PROCESS | 18148 | Values: 78.0 78.0 79.0 79.0 79.0 79.0 82.0 79.0 78.0 79.0 15:54:46 INFO - PROCESS | 18148 | 15:54:46 INFO - PROCESS | 18148 | [#11] stanford-crypto-ccm Cycles:10 Average:137.40 Median:129.00 stddev:25.31 (19.6%) stddev-sans-first:26.62 15:54:46 INFO - PROCESS | 18148 | Values: 128.0 127.0 131.0 129.0 126.0 125.0 129.0 128.0 208.0 143.0 15:54:46 INFO - PROCESS | 18148 | 15:54:46 INFO - PROCESS | 18148 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.00 Median:164.50 stddev:2.00 (1.2%) stddev-sans-first:2.09 15:54:46 INFO - PROCESS | 18148 | Values: 165.0 164.0 161.0 163.0 167.0 163.0 162.0 165.0 163.0 167.0 15:54:46 INFO - PROCESS | 18148 | 15:54:46 INFO - PROCESS | 18148 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:66.00 stddev:1.25 (1.9%) stddev-sans-first:1.30 15:54:46 INFO - PROCESS | 18148 | Values: 66.0 67.0 69.0 66.0 69.0 66.0 66.0 66.0 66.0 66.0 15:54:46 INFO - PROCESS | 18148 | -------- Summary: end -------- 15:54:46 INFO - PROCESS | 18148 | 15:54:47 INFO - TEST-INFO | 18148: exit 0 15:54:47 INFO - TEST-OK | kraken | took 63450ms 15:54:47 INFO - SUITE-END | took 1182s 15:54:47 INFO - Completed test suite (00:19:42) 15:54:47 INFO - javascript benchmark 15:54:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2598.8570628615416, 2600.453904680017, 2629.30323464282, 2638.947221055578, 2650.4169082801777, 4439.866803995886, 4576.656750743691, 4644.978104816939, 4653.139169253686, 4655.580997710205, 4583.404157459534, 4586.587207151356, 4588.2658774596075, 4609.654275929302, 4624.329472226534, 4018.8794336169963, 4187.371894215869, 4252.617264446199, 4285.978570107145, 4388.451443569554, 4306.720063195898, 4370.2133615949115, 4373.978130109345, 4378.080603073358, 4398.208322501949, 4100.302948498763, 4130.091379896418, 4271.765052922088, 4279.529251782302, 4286.249906266391, 4264.936025959613, 4275.722078064947, 4306.310990241546, 4312.396264522969, 4316.050468896838, 4299.656027517791, 4308.78456077198, 4311.267084595626, 4329.458817647794, 4347.978260108679, 4486.5962063414445, 4517.141743068839, 4639.5824375806005, 4641.86074417768, 4661.324108004321, 5001.349824522825, 5026.84919452417, 5033.0688822567945, 5034.244863270502, 5046.84859454217, 4829.903401931977, 5063.417706963673, 5069.746512674388, 5075.111855425286, 5077.162268225738, 4627.398438203046, 4689.484156742756, 4691.46048204454, 4756.857294281177, 4764.023375208074, 5186.896262074737, 5225.921611175835, 5226.294450249167, 5227.712475813867, 5230.241614965808, 4677.7193368398, 4845.878853028632, 4849.345338379274, 4900.460949295574, 4902.338184345068, 4892.241702536113, 4961.503849615082, 4989.700617962933, 4996.775145118479, 5018.548330650259, 4939.3084968104495, 4943.382077240345, 4950.455449900508, 4952.108620448282, 4993.925091123563, 4710.24636058229, 4828.444728856156, 4929.531694489017, 4933.432655244621, 4980.90038199234, 4136.048708796933, 4142.1301526679135, 4160.875173744793, 4185.309423945015, 4198.4961804583645, 3655.798931058764, 3662.908427289286, 3673.7061035117126, 3696.1683621185557, 3713.3687273163628, 4174.165166966558, 4212.620864122183, 4215.725977811432, 4272.359146128106, 4274.957250427518, 4939.3084968104495, 4966.428860680996, 5022.121128802518, 5036.622253331015, 5042.268871013683, 4297.376880352332, 4317.050248945227, 4326.351047342924, 4362.760048197316, 4367.58507941745, 4286.142771445723, 4354.194474022316, 4478.932816007762, 4485.170243504962, 4485.923378389163, 4726.621870250303, 4751.382320298339, 4773.355596994361, 4778.546038126373, 4823.155947709207, 5026.070177017264, 5028.4971502850885, 5031.547160755549, 5032.04391165692, 5064.645474816727, 4527.0493196429115, 4677.742724150205, 4720.929186062281, 4816.518348165156, 4823.27650852375, 4904.092742842586, 4905.6075513958085, 4915.582175515121, 4924.433690125681, 4963.503649635008, 4976.925346119739, 4989.351384320015, 4989.825356112518, 4994.425641051325, 5028.798848046037, 4671.929921051119, 4691.859244222679, 4779.689320194177, 4851.51484851512, 4900.975495122501, 4842.6368022399165, 4851.0, 4855.36880205571, 4857.635677324144, 4912.7543622818, 4781.737004464788, 4782.928256076092, 4786.16242157614, 4793.376861008047, 4830.3237546742785, 4707.458642256048, 4775.594074503567, 4822.855314340435, 4854.368932038812, 4868.586170175433, 4749.881252968704, 4759.619230461624, 4772.809087636456, 4774.904501910012, 4815.0], "value": 4566.744775412422, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.7053702611668, 585.3941170888129, 590.4302348233954, 590.8670549126446, 591.6124938165498, 27150.72849271507, 39371.80314098429, 40555.594444055554, 40637.39043914343, 44089.338659920126, 40166.0, 40406.0, 40562.59437405625, 40595.391069133984, 40608.0, 7514.398848092167, 7789.221077892222, 7917.445778795458, 7929.960350198241, 7939.245771651713, 7692.4615276930635, 7791.649375778075, 7792.376609871225, 10043.296969212122, 10327.07056364927, 10382.844257336146, 10414.27100102993, 10418.426986515738, 10421.947890260575, 10454.790904181911, 10312.639057632985, 10344.06903378692, 10386.428746418944, 10398.948005259963, 10404.479776011169, 7512.586807725573, 7752.883706744347, 7757.922420775776, 9879.604815807359, 10312.071913527818, 38216.808915955524, 38577.0, 38605.42091868624, 38653.22693546141, 38659.22681546353, 3008.714172153642, 3053.938921221585, 3085.1670049086847, 3103.379324135182, 3166.857491412892, 28442.288942776388, 29896.0, 29974.0, 30060.0, 30096.0, 2833.702461241581, 2855.114914376529, 2857.3142445813064, 2873.626428564294, 2932.6627437844495, 247917.0, 248898.0, 249370.0, 249681.0, 249964.0, 52572.0, 53117.468825311254, 53183.20225196625, 53201.46798531965, 53235.0, 55748.0, 55838.16242756362, 55999.0, 56041.159382609294, 56146.71926640341, 13908.095973761672, 14322.212278324792, 14332.14007159553, 14340.928295358664, 14342.498012569718, 9990.200783937267, 10760.085392741548, 10845.728856778485, 10845.783084338269, 10848.566057357617, 14877.776833347509, 15488.07071575709, 15499.457518986781, 15846.0, 15981.520554383387, 5833.370797180741, 5927.851803704855, 5944.910826337608, 5969.820905372846, 6065.757369705162, 814.9755507334789, 855.39267120344, 877.9517126558101, 914.679862048291, 957.9425234485954, 26530.336741581614, 27532.278050925564, 27561.0, 27878.16365509038, 28015.439691206062, 944.367273926471, 966.4008314844841, 969.471637957315, 1009.9949500252599, 1051.81593221186, 14384.424623015171, 14803.777943330859, 15098.698026039418, 15761.369545218064, 15821.367145314289, 350654.0, 351294.0, 351560.0, 353586.0, 354032.0, 49245.50754492409, 49592.0, 49703.0, 49712.50287497151, 49857.50142498601, 1097.286763603648, 1152.124385467051, 1167.8073117935446, 1216.403962058585, 1225.2893321873291, 26797.0, 28015.719842802126, 28394.29014274577, 28949.7105028947, 29121.41757164887, 40959.59040409677, 41109.58890411058, 41387.0, 41622.37566436445, 41638.791806040776, 289277.0, 290509.0, 290664.0, 291491.0, 291502.0, 21303.893480532497, 23516.412089697893, 24410.755892441557, 24418.63372049385, 24562.263132106065, 40649.79675101605, 40715.79642101889, 40775.18449630932, 41261.38107928324, 41619.7919010403, 32962.83518582392, 35228.47157292591, 35465.290694186486, 35862.820685896404, 35934.460983085795, 34960.650393496755, 35656.28687426185, 35677.108072297364, 35761.0, 35944.64055359518, 34268.65731342655, 34418.48372274368, 34647.13382165466, 34749.13127171841, 35222.29555408929, 31227.0, 31620.525692115098, 31738.36523269568, 31823.045308640776, 31951.520727188647, 23336.533269334857, 23392.595106661454, 23757.524849503257, 23907.0, 23917.76082239225], "value": 17433.8562996519, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.8285430129291, 376.8662124945644, 377.7487970499618, 381.92934307153195, 391.1492503804227, 16807.49577512675, 17073.40243091492, 17800.55498612532, 18019.63960720785, 18032.0, 10804.13566914647, 11155.107591392669, 11189.888101118986, 11208.327500349964, 11210.383428911407, 4313.978430107861, 4644.117617652652, 5288.048151332759, 5290.074237008508, 5293.0, 5151.407588127376, 5198.064348417283, 5203.115470370046, 5208.166693329068, 5218.686878787266, 4641.814327426899, 4767.189577771787, 4772.642051846108, 4784.306275590037, 5189.558887494568, 4746.169420351424, 4763.928541071887, 4799.7360145192, 4801.855944321676, 4809.975950120262, 4567.200739870543, 4609.469910960215, 4651.813927442899, 4655.068986202773, 4695.131400690883, 12669.873301266962, 12760.106792524526, 12767.42546585406, 12827.871721282761, 19881.60236795256, 1793.4081753021471, 1800.0549711401488, 1803.1615298886081, 1810.185416562552, 2282.4750307429217, 9529.428234305964, 9846.704598862045, 9860.211183105333, 9869.90130098697, 11071.667849964513, 1728.5073753980055, 1747.4670225581192, 1766.8763186576946, 1808.4213051823422, 1814.4647329037966, 66973.3302666972, 70465.0, 72978.0, 73157.0, 73394.0, 10242.231832612435, 10302.433366164933, 10333.896661033445, 10363.896361036444, 10444.895551044392, 14043.438262469386, 14095.295235238196, 14232.715345693028, 14235.78646320306, 14237.505061968344, 6760.290169532227, 6802.863942721118, 6897.0, 6918.792436226921, 6950.721971121098, 6198.597091189058, 6243.875122497525, 6282.151909492251, 6407.903881441782, 6423.261324947597, 4295.4415925929425, 4331.263685173528, 4362.9781851091175, 4393.406890069864, 4526.411566496335, 1599.528139198939, 1774.4055741326542, 1793.1124093573765, 1836.1186630417474, 1873.7189421586597, 793.9682412703543, 807.6123460738878, 826.6445428465697, 866.27233124176, 883.3463237204422, 17026.404075857285, 17288.308467661405, 17399.56501087483, 17579.648407032044, 17945.461636150936, 846.3229416466802, 859.574510617236, 877.1842186766369, 878.7934835313696, 910.0580898769741, 9561.187299079516, 9734.221262299, 10136.746581335525, 10579.89420105789, 10587.947060264803, 394597.0, 396031.0, 396242.0, 397250.0, 402277.0, 84597.0, 87777.0, 87915.0, 89827.0, 90295.54852225828, 874.7141701698494, 878.2096113497903, 902.3818684201212, 912.2884150362728, 919.5678031325266, 12333.444994975069, 16397.42609008679, 16412.343506259615, 16490.0, 16770.664586707953, 26677.199684009513, 30151.547726783676, 39164.6083539161, 39315.80342098271, 39840.60159398369, 45741.0, 54405.0, 55488.445115548326, 55758.72120639371, 56270.0, 7354.448416368687, 7630.923690763021, 7723.613819309125, 7754.922450775645, 7809.3362064225175, 8309.792255193668, 10865.456727163451, 11226.831597525881, 11458.427078645867, 11470.254433461798, 10149.949250253701, 10216.642417515352, 10266.538005789907, 10364.585416583252, 10580.576776928836, 9698.56356463975, 9852.802943941224, 9900.158486528439, 9973.900260997587, 10105.646302379382, 5397.919031214614, 8011.6795328188555, 10261.127804136433, 10393.480325983519, 10561.207909406672, 7627.656755446129, 7628.084629844454, 7691.769246922601, 7836.84326313482, 7916.643751031333, 8888.422252553562, 10027.348222365523, 10075.596976120873, 10174.389536627827, 10209.54057067419], "value": 7930.052615188381, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1363.781794912814, 1412.7668934625785, 1478.1943840606868, 1702.4807433732706, 1704.0883127526777, 7709.730159444413, 8174.9781277340335, 8268.338532917367, 8268.627911743972, 8274.420790544656, 6959.0, 7169.964150179255, 7677.23227677232, 7968.243016913399, 8123.47197432168, 2202.8104823395347, 2229.7993180613744, 2229.9296337757887, 2232.7097477327925, 2232.821374290061, 1815.8093400192988, 2202.812760915316, 2216.8891555422247, 2253.188852013282, 2259.7740225977436, 2133.5839511295303, 2192.7916847899423, 2200.702905107806, 2206.4042708468705, 2210.071769856656, 2170.8806015669134, 2179.1936983316195, 2183.1049269799387, 2185.672149177636, 2240.708707867983, 2200.9119635214734, 2204.9669254961186, 2205.2722601541454, 2207.4371035385875, 2207.812335951446, 8210.548419836907, 8214.26071653554, 8274.213949674771, 8279.54462504562, 8280.668773249063, 4357.607815296638, 4507.2788353863225, 4515.683902126852, 4515.774211289422, 4521.909561808746, 2603.2450589329073, 2729.849858257795, 2731.754142127198, 2733.9453210935867, 2743.8490883001427, 820.0, 833.5123952487802, 841.8442588121156, 857.901341345747, 858.1675774498726, 10616.150707943347, 10631.415272160028, 10634.415107169103, 10645.84031239532, 10654.4140072296, 4072.429859819628, 4157.875263742093, 4305.870823875289, 4310.051788606502, 4310.978445107817, 8994.775130621787, 9057.501837399006, 9095.181433671001, 9095.272378209727, 9097.636094556143, 4540.77296135192, 4545.749983750859, 4545.931811022837, 4546.204414227497, 4548.226801443762, 4008.659263962596, 4094.8566800161852, 4096.262672718939, 4098.098418347959, 4100.5489396166395, 3806.8667596633986, 3813.256414999104, 3851.6340947609933, 3939.330313846653, 3952.6837852971694, 1073.9463026848625, 1218.7196944702769, 1251.9436625351882, 1261.7161138743893, 1262.7979523276415, 613.3774219167549, 714.7819914925893, 717.3651318583092, 741.935322811756, 851.7572491839796, 5196.350456192976, 5295.761690723926, 5393.110136827458, 5489.368722596872, 5570.080936645408, 778.5134291068082, 854.5257382152964, 855.9771073567027, 870.7520946868091, 877.0308808766349, 3365.1060879898696, 3622.836972336251, 3663.1025398776937, 3708.5364329458816, 3716.591174970751, 9909.405435673883, 10050.899491005142, 10054.0, 10268.537915793808, 10277.845832312521, 8849.69026084084, 10115.0, 10121.59513619447, 10129.088382045504, 10143.08712215904, 7233.89149162763, 7620.085589729268, 7622.2758837910305, 7824.491408058458, 7824.491408058458, 5277.366715994105, 5437.429069947599, 5477.917831232615, 5485.232067510631, 5643.88712225745, 9216.723498295061, 9272.119148680864, 9480.95259523698, 9523.047695230422, 9524.476153811607, 9350.251979841732, 9419.246460283024, 9436.85844712316, 9637.0, 9713.222942164468, 6640.269570347355, 6743.797686069426, 6780.084688566981, 6798.082258894986, 6798.354156355138, 7647.655855486405, 7822.0, 7863.292303692695, 7863.567503787347, 7870.9606451967375, 6730.966345168243, 6768.08630834831, 6965.373116419547, 7023.051887995055, 7043.718251269892, 6918.238993710788, 7115.1106111736035, 7136.500444968802, 7210.206877243604, 7276.818079548054, 6401.039844023434, 6490.870182596227, 6549.934500654933, 6647.368499992493, 6660.100886380276, 4705.106029854317, 4864.416270047475, 4870.4155501340065, 4895.7062576245535, 4982.975085124551, 4927.260910863399, 4958.305837182726, 4971.353724015855, 4978.228374601942, 5161.22581612746], "value": 4197.044463193489, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.4195739287087, 308.39092791736323, 312.5046800820699, 315.77895473168786, 316.21893922012623, 4846.85459436217, 4881.023795240957, 4897.412310522738, 4925.556699897009, 4964.379452568429, 4830.710157390559, 4866.58634016109, 4870.074685809703, 4875.853724388265, 4879.218845258204, 3639.7998110103936, 3727.440883867428, 3759.154190307186, 3818.1409182933894, 3833.386658134699, 3793.905152371185, 3801.4107813288983, 3807.591191259238, 3819.3316169670334, 3823.139793546444, 3622.56908521134, 3777.0368556018175, 3798.0, 3800.6959443244473, 3809.3333666608232, 3687.1703866630064, 3837.808109594509, 3840.116773142165, 3842.3660096084113, 3844.634759697838, 3392.542006829071, 3399.6430374810784, 3404.6254911959663, 3404.8297585120645, 3411.624721280657, 4748.527956333513, 4758.191107511731, 4763.523647635208, 4764.665893549812, 4765.618750499952, 4242.91514169718, 4393.319035549463, 4399.868003959854, 4414.293713005935, 4421.182081314967, 5082.0, 5090.880006398586, 5093.694378337274, 5112.948870511284, 5116.155834287338, 3713.517242758424, 3722.5431215397707, 3733.4026555750947, 3736.1406876418578, 3751.643593858579, 5149.716765577892, 5221.347331583552, 5322.7072511011875, 5325.973370133163, 5343.8510720195345, 3764.7176461765475, 3798.67046533711, 3799.2903193562456, 3805.809709514513, 3815.6565909068318, 3873.3028054949814, 3880.7477513961503, 3881.9611803882162, 3885.048163200034, 3886.84452621892, 4368.4102646143, 4370.584794444522, 4373.409589705413, 4387.100644367897, 4397.296432570837, 4891.608671306287, 5093.9490605094215, 5099.464556221544, 5117.669405954479, 5119.3088932994315, 1318.4264844792547, 1332.1948759431025, 1339.5800451521418, 1342.3221273257138, 1342.912710673803, 849.6049337058298, 874.3355050161923, 876.8334016536837, 877.3419935048713, 878.0780180810124, 4273.743575385487, 4336.4145840311785, 4460.397846290709, 4461.866144015685, 4475.820967161277, 5172.0, 5174.922376164361, 5222.1383471727495, 5226.895462090737, 5231.450697676765, 4256.0, 4428.269335559661, 4429.313456414261, 4442.089371678798, 4489.2592722201125, 2758.7517123458983, 2771.3487330477324, 2786.857388470717, 2791.441711657636, 2793.231861238176, 4960.429550601727, 4975.925361119586, 4982.676126051795, 4984.77568509418, 4993.151164302078, 5089.440161582223, 5306.54894333986, 5365.812196573102, 5366.141417373202, 5376.838694839161, 4932.260160975882, 4946.777395017233, 4972.353594032753, 4983.07813054586, 4989.775460104304, 5117.692938423706, 5156.484351564814, 5224.477552244897, 5252.868678282921, 5256.316678831728, 5004.199328107486, 5056.9013859248, 5094.465081166424, 5102.923456148086, 5172.275881376535, 4885.877853053702, 4918.532739389752, 4930.433000204879, 4940.407151141886, 4953.455119936732, 3787.9242415150993, 3793.506844110248, 3803.6766874814844, 3815.8664446744233, 3825.2923209206388, 5006.674566153189, 5207.843764687065, 5231.55531779803, 5268.2361057647195, 5283.973580132075, 5060.266261392151, 5065.797368105382, 5086.135356989246, 5086.21163719624, 5086.61850361217, 5065.13892638245, 5110.8466745997675, 5131.204663277198, 5147.6654017488745, 5154.664946778447, 4702.341672165831, 4878.195097808822, 4942.481039490802, 5001.64988450805, 5071.39143302806, 4902.558769710743, 5047.520485553867, 5057.8735531612, 5092.796288148433, 5100.719460429712, 4968.8757781055765, 4984.850454486371, 4988.351514303263, 4994.6503744738975, 4995.375578052744], "value": 3855.4521177031743, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.2954225387281, 595.4224402329738, 611.129140974112, 689.6999805084788, 698.7065432518342, 12827.807582886253, 13931.164130152185, 14046.578602641925, 14785.112893226415, 15371.385144594231, 15104.697906041873, 15397.84602153978, 15398.153101579408, 15398.615034624112, 15531.767023494656, 634.7461015593753, 646.3407324528978, 780.9648565814538, 807.4832107451207, 808.9878651820227, 765.6248438265238, 774.0865778381535, 791.0941971442695, 792.4096548071694, 793.2226418110256, 831.8170002599419, 833.3624777045565, 834.8413801377749, 835.8035861572556, 836.0343802907652, 657.1227411405779, 675.1627981303197, 817.3257062923053, 820.9753707388788, 821.109096630157, 498.49402856101085, 498.55379435405473, 595.0776296740036, 599.9580029397944, 614.3794767285029, 13707.520236791765, 13717.0398072135, 13722.176669399869, 13724.794128088086, 13775.173489590657, 12394.75210495785, 12984.15602985803, 12987.610371688865, 12994.350282485932, 13123.354334564088, 11800.291982481078, 12089.758204835854, 12125.21186122908, 12199.329036902967, 12347.876521234763, 4178.686598505094, 4202.201581699467, 4227.577242275778, 4229.492460904711, 4231.069164783743, 58098.70950645262, 58147.127793083564, 58392.0, 58623.0, 58878.705606471696, 10222.284440089123, 10287.691369258935, 10306.896931030744, 10531.368117912796, 10710.250282480152, 17718.822811771974, 17771.733423998652, 17774.644507110042, 17792.288308467516, 17806.198721057583, 6402.551821372459, 6544.869102617921, 6547.738090476328, 6553.63954982471, 6562.934370656232, 3765.548134223911, 3829.9042523937123, 3849.172427928009, 3903.277893589695, 3924.7056470764805, 2710.2817753295394, 2805.76151027165, 2806.214260007201, 2812.4656315300026, 2813.817101888412, 485.4902352529829, 486.77851577532135, 487.1742396637665, 498.6858279284028, 500.43450900482225, 453.605363333895, 468.92497200447764, 481.8747125747331, 487.2763945540869, 517.4230732733051, 6848.315168483212, 7018.789436316919, 7145.499815013003, 7218.061651985208, 7242.746503872445, 429.90971895901583, 436.7859748723166, 465.8858579648008, 476.3902205177379, 507.8933423980931, 3475.548178736748, 3675.5038069860225, 3715.6098609646137, 3797.715171362159, 3952.9209415811524, 92136.0, 93122.0, 94552.52723736475, 95885.0, 96243.03756962481, 81944.59027704943, 82168.0, 83244.0, 85321.0, 86272.0, 71487.0, 72678.2732172682, 72875.2712472879, 73151.63424182845, 73954.0, 7228.63856807147, 7422.480426370103, 7426.962865185639, 7445.10658720957, 7514.436417268617, 41247.793761031004, 41432.79283603562, 41867.37198942079, 42051.0, 43746.0, 59119.40880591139, 59539.106913395466, 60225.0, 60944.695276523336, 61112.0, 9505.097015783489, 9617.0, 9653.420794752337, 10052.296339256474, 10229.948850255701, 9749.463779492196, 9896.406215627085, 9989.250806189419, 10298.897011029794, 11192.104631629287, 9528.14246717771, 9648.324617276723, 9768.902310976799, 9917.65288214909, 9955.452450115314, 8912.777180570538, 9061.456312621263, 9116.179543841086, 9431.0, 9431.764205894633, 9380.765480863032, 9781.217502599633, 9794.804103918024, 9910.603575856885, 9958.751031223988, 8341.16588341161, 8561.743147705578, 8614.18165274298, 8666.7066514724, 8781.648734050821, 8156.796080098045, 8440.409171358191, 8649.783755405913, 8702.912970870464, 8854.601542930712], "value": 6229.560736010012, "unit": "score"}], "name": "dromaeo_css", "value": 6318.783354632303, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 114.0, 114.0, 114.0, 113.0, 113.0, 116.0, 113.0, 115.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 121.0, 122.0, 175.0, 122.0, 129.0, 153.0, 122.0, 190.0, 127.0], "value": 140.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 162.0, 162.0, 162.0, 162.0, 162.0, 162.0, 163.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 132.0, 76.0, 76.0, 76.0, 75.0, 102.0, 75.0], "value": 83.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 123.0, 85.0, 85.0, 85.0, 126.0, 85.0, 84.0, 123.0], "value": 96.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 153.0, 147.0, 146.0, 146.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 96.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 72.0, 65.0, 66.0, 64.0, 66.0, 64.0, 64.0, 65.0], "value": 65.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 66.0, 64.0, 65.0, 66.0, 66.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 79.0, 79.0, 79.0, 79.0, 82.0, 79.0, 78.0, 79.0], "value": 79.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 127.0, 131.0, 129.0, 126.0, 125.0, 129.0, 128.0, 208.0, 143.0], "value": 137.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 161.0, 163.0, 167.0, 163.0, 162.0, 165.0, 163.0, 167.0], "value": 164.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 69.0, 66.0, 69.0, 66.0, 66.0, 66.0, 66.0, 66.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1532.9, "alertThreshold": 2.0}]} 15:54:47 INFO - Return code: 0 15:54:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:54:47 INFO - # TBPL SUCCESS # 15:54:47 INFO - Running post-action listener: _resource_record_post_action 15:54:47 INFO - ##### 15:54:47 INFO - ##### Finished run-tests step (success) 15:54:47 INFO - ##### 15:54:47 INFO - Running post-run listener: _resource_record_post_run 15:54:47 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 69632; Write bytes: 535990272; Read time: 180; Write time: 339836 15:54:47 INFO - TinderboxPrint: CPU usage
13.0% 15:54:47 INFO - TinderboxPrint: I/O read bytes / time
69,632 / 180 15:54:47 INFO - TinderboxPrint: I/O write bytes / time
535,990,272 / 339,836 15:54:47 INFO - TinderboxPrint: CPU idle
8,328.8 (87.0%) 15:54:47 INFO - TinderboxPrint: CPU user
1,201.1 (12.5%) 15:54:47 INFO - TinderboxPrint: Swap in / out
0 / 0 15:54:47 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 57344; Write bytes: 246951936; Read time: 140; Write time: 179916 15:54:47 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 12288; Write bytes: 289038336; Read time: 40; Write time: 159920 15:54:48 INFO - Running post-run listener: _upload_blobber_files 15:54:48 INFO - Blob upload gear active. 15:54:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:54:48 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 15:54:48 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'] 15:54:48 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 15:54:48 INFO - (blobuploader) - INFO - Open directory for files ... 15:54:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:54:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:54:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:54:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:54:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:54:52 INFO - (blobuploader) - INFO - Done attempting. 15:54:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:54:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:54:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:54:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:54:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:54:52 INFO - (blobuploader) - INFO - Done attempting. 15:54:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:54:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:54:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:54:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:54:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:54:53 INFO - (blobuploader) - INFO - Done attempting. 15:54:53 INFO - (blobuploader) - INFO - Iteration through files over. 15:54:53 INFO - Return code: 0 15:54:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:54:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:54:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1b263735c5ac8ec11f0004486ac19d3a83236f14d0e9fe44bd0bf73cae7d2b9cdd172d4dec5d96347c33ae30ffaebda36f7ea09cd10a29f2f4d167217139f3de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c76b98d1c201838edb7002b2cce2d90584498c0d42debf04b16787612f1451d95cb17a4305758262fe5f3ffc9dfd86bebb2a7767650a8526b07afe72eb6a5601", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e4f8f2eb40321622cd1f2911fd45d4471e7117a536669d086195e1446003bc231731ad2a45416c898b45464402ff1101bdb9f0c99c8d7c526936684343c9640c"} 15:54:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:54:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:54:53 INFO - Contents: 15:54:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1b263735c5ac8ec11f0004486ac19d3a83236f14d0e9fe44bd0bf73cae7d2b9cdd172d4dec5d96347c33ae30ffaebda36f7ea09cd10a29f2f4d167217139f3de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c76b98d1c201838edb7002b2cce2d90584498c0d42debf04b16787612f1451d95cb17a4305758262fe5f3ffc9dfd86bebb2a7767650a8526b07afe72eb6a5601", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e4f8f2eb40321622cd1f2911fd45d4471e7117a536669d086195e1446003bc231731ad2a45416c898b45464402ff1101bdb9f0c99c8d7c526936684343c9640c"} 15:54:53 INFO - Running post-run listener: copy_logs_to_upload_dir 15:54:53 INFO - Copying logs to upload dir... 15:54:53 INFO - mkdir: /builds/slave/test/build/upload/logs 15:54:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.556329 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-07-13 15:54:53.526456) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 15:54:53.529894) ========= 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=03627c79f6bb3d1578c4a402000001ba-1468448863.968818-1376647508 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/1b263735c5ac8ec11f0004486ac19d3a83236f14d0e9fe44bd0bf73cae7d2b9cdd172d4dec5d96347c33ae30ffaebda36f7ea09cd10a29f2f4d167217139f3de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c76b98d1c201838edb7002b2cce2d90584498c0d42debf04b16787612f1451d95cb17a4305758262fe5f3ffc9dfd86bebb2a7767650a8526b07afe72eb6a5601", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e4f8f2eb40321622cd1f2911fd45d4471e7117a536669d086195e1446003bc231731ad2a45416c898b45464402ff1101bdb9f0c99c8d7c526936684343c9640c"} build_url:https://queue.taskcluster.net/v1/task/KyubbALUSB2giMToRnvy-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011471 build_url: 'https://queue.taskcluster.net/v1/task/KyubbALUSB2giMToRnvy-g/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/1b263735c5ac8ec11f0004486ac19d3a83236f14d0e9fe44bd0bf73cae7d2b9cdd172d4dec5d96347c33ae30ffaebda36f7ea09cd10a29f2f4d167217139f3de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c76b98d1c201838edb7002b2cce2d90584498c0d42debf04b16787612f1451d95cb17a4305758262fe5f3ffc9dfd86bebb2a7767650a8526b07afe72eb6a5601", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e4f8f2eb40321622cd1f2911fd45d4471e7117a536669d086195e1446003bc231731ad2a45416c898b45464402ff1101bdb9f0c99c8d7c526936684343c9640c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 15:54:53.555207) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 15:54:53.555490) ========= 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=03627c79f6bb3d1578c4a402000001ba-1468448863.968818-1376647508 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004737 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 15:54:53.642664) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 15:54:53.642970) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 15:54:53.643244) ========= ========= Total master_lag: 0.19 =========