builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-039 starttime: 1468356421.18 results: success (0) buildid: 20160712132427 builduid: 727475b2753b4e579bb246d17fbab1c4 revision: a03a6fd88c3d0ea6e36a41a5d295fc870ce874b1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 13:47:01.184170) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 13:47:01.184624) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 13:47:01.184896) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 13:47:01.347492) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 13:47:01.347775) ========= 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=5bd038846534b2fdfa68eeae000001e2-1468355688.496615-1670034750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-12 13:47: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-07-12 13:47:01 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100696 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 13:47:01.461967) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 13:47:01.462270) ========= 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=5bd038846534b2fdfa68eeae000001e2-1468355688.496615-1670034750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015853 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 13:47:01.516075) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-12 13:47:01.516401) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a03a6fd88c3d0ea6e36a41a5d295fc870ce874b1 --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 a03a6fd88c3d0ea6e36a41a5d295fc870ce874b1 --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=5bd038846534b2fdfa68eeae000001e2-1468355688.496615-1670034750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-12 13:47:02,066 truncating revision to first 12 chars 2016-07-12 13:47:02,066 Setting DEBUG logging. 2016-07-12 13:47:02,066 attempt 1/10 2016-07-12 13:47:02,066 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a03a6fd88c3d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 13:47:03,212 unpacking tar archive at: fx-team-a03a6fd88c3d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.477131 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-12 13:47:03.007876) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 13:47:03.008221) ========= script_repo_revision: a03a6fd88c3d0ea6e36a41a5d295fc870ce874b1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 13:47:03.008628) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 13:47:03.008889) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 13:47:03.017850) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-07-12 13:47:03.018161) ========= /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=5bd038846534b2fdfa68eeae000001e2-1468355688.496615-1670034750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:47:03 INFO - MultiFileLogger online at 20160712 13:47:03 in /builds/slave/test 13:47:03 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 13:47:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:47:03 INFO - {'append_to_log': False, 13:47:03 INFO - 'base_work_dir': '/builds/slave/test', 13:47:03 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:47:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:47:03 INFO - 'branch': 'Fx-Team-Non-PGO', 13:47:03 INFO - 'buildbot_json_path': 'buildprops.json', 13:47:03 INFO - 'config_files': ('talos/linux_config.py',), 13:47:03 INFO - 'default_actions': ('clobber', 13:47:03 INFO - 'read-buildbot-config', 13:47:03 INFO - 'download-and-extract', 13:47:03 INFO - 'populate-webroot', 13:47:03 INFO - 'create-virtualenv', 13:47:03 INFO - 'install', 13:47:03 INFO - 'run-tests'), 13:47:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:47:03 INFO - 'download_minidump_stackwalk': True, 13:47:03 INFO - 'download_symbols': 'ondemand', 13:47:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:47:03 INFO - 'tooltool.py': '/tools/tooltool.py', 13:47:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:47:03 INFO - '/tools/misc-python/virtualenv.py')}, 13:47:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:47:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:47:03 INFO - 'installer_path': 'installer.exe', 13:47:03 INFO - 'log_level': 'info', 13:47:03 INFO - 'log_name': 'talos', 13:47:03 INFO - 'log_to_console': True, 13:47:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:47:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:47:03 INFO - 'opt_config_files': (), 13:47:03 INFO - 'pip_index': False, 13:47:03 INFO - 'sps_profile': False, 13:47:03 INFO - 'sps_profile_interval': 0, 13:47:03 INFO - 'suite': 'dromaeojs', 13:47:03 INFO - 'system_bits': '32', 13:47:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:47:03 INFO - 'title': 'talos-linux64-ix-039', 13:47:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:47:03 INFO - 'use_talos_json': True, 13:47:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:47:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:47:03 INFO - 'work_dir': 'build'} 13:47:03 INFO - ##### 13:47:03 INFO - ##### Running clobber step. 13:47:03 INFO - ##### 13:47:03 INFO - Running pre-action listener: _resource_record_pre_action 13:47:03 INFO - Running main action method: clobber 13:47:03 INFO - rmtree: /builds/slave/test/build 13:47:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:47:04 INFO - Running post-action listener: _resource_record_post_action 13:47:04 INFO - ##### 13:47:04 INFO - ##### Finished clobber step (success) 13:47:04 INFO - ##### 13:47:04 INFO - ##### 13:47:04 INFO - ##### Running read-buildbot-config step. 13:47:04 INFO - ##### 13:47:04 INFO - Running pre-action listener: _resource_record_pre_action 13:47:04 INFO - Running main action method: read_buildbot_config 13:47:04 INFO - Using buildbot properties: 13:47:04 INFO - { 13:47:04 INFO - "project": "", 13:47:04 INFO - "product": "firefox", 13:47:04 INFO - "script_repo_revision": "production", 13:47:04 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:47:04 INFO - "repository": "", 13:47:04 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 13:47:04 INFO - "buildid": "20160712132427", 13:47:04 INFO - "pgo_build": "False", 13:47:04 INFO - "basedir": "/builds/slave/test", 13:47:04 INFO - "buildnumber": 1980, 13:47:04 INFO - "slavename": "talos-linux64-ix-039", 13:47:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:47:04 INFO - "platform": "ubuntu64_hw", 13:47:04 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:47:04 INFO - "branch": "fx-team", 13:47:04 INFO - "repo_path": "integration/fx-team", 13:47:04 INFO - "revision": "a03a6fd88c3d0ea6e36a41a5d295fc870ce874b1", 13:47:04 INFO - "stage_platform": "linux64", 13:47:04 INFO - "builduid": "727475b2753b4e579bb246d17fbab1c4", 13:47:04 INFO - "slavebuilddir": "test" 13:47:04 INFO - } 13:47:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/Nr8C3QtUSp2F5tPP9hbLDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:47:04 INFO - Running post-action listener: _resource_record_post_action 13:47:04 INFO - ##### 13:47:04 INFO - ##### Finished read-buildbot-config step (success) 13:47:04 INFO - ##### 13:47:04 INFO - ##### 13:47:04 INFO - ##### Running download-and-extract step. 13:47:04 INFO - ##### 13:47:04 INFO - Running pre-action listener: _resource_record_pre_action 13:47:04 INFO - Running main action method: download_and_extract 13:47:04 INFO - mkdir: /builds/slave/test/build/tests 13:47: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')]} 13:47:04 INFO - https://queue.taskcluster.net/v1/task/Nr8C3QtUSp2F5tPP9hbLDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:47:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nr8C3QtUSp2F5tPP9hbLDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:47:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nr8C3QtUSp2F5tPP9hbLDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:47:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nr8C3QtUSp2F5tPP9hbLDw/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 13:47:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nr8C3QtUSp2F5tPP9hbLDw/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 13:47:10 INFO - Downloaded 1361 bytes. 13:47:10 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:47:10 INFO - Using the following test package requirements: 13:47:10 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:47:10 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:47:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:47:10 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:47:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:47:10 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:47:10 INFO - u'jsshell-linux-x86_64.zip'], 13:47:10 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:47:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:47:10 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:47:10 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:47:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:47:10 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:47:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:47:10 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:47:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:47:10 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:47:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:47:10 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:47:10 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')]} 13:47:10 INFO - https://queue.taskcluster.net/v1/task/Nr8C3QtUSp2F5tPP9hbLDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:47:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nr8C3QtUSp2F5tPP9hbLDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:47:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nr8C3QtUSp2F5tPP9hbLDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:47:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nr8C3QtUSp2F5tPP9hbLDw/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 13:47:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nr8C3QtUSp2F5tPP9hbLDw/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 13:47:14 INFO - Downloaded 22750521 bytes. 13:47:14 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'] 13:47:14 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 13:47:15 INFO - Return code: 0 13:47:15 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 13:47:15 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')]} 13:47:15 INFO - https://queue.taskcluster.net/v1/task/Nr8C3QtUSp2F5tPP9hbLDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:47:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nr8C3QtUSp2F5tPP9hbLDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:47:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nr8C3QtUSp2F5tPP9hbLDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:47:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nr8C3QtUSp2F5tPP9hbLDw/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 13:47:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nr8C3QtUSp2F5tPP9hbLDw/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 13:47:17 INFO - Downloaded 22750521 bytes. 13:47:17 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'] 13:47:17 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 13:47:18 INFO - Return code: 0 13:47:18 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')]} 13:47:18 INFO - https://queue.taskcluster.net/v1/task/Nr8C3QtUSp2F5tPP9hbLDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:47:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nr8C3QtUSp2F5tPP9hbLDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:47:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nr8C3QtUSp2F5tPP9hbLDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:47:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nr8C3QtUSp2F5tPP9hbLDw/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 13:47:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nr8C3QtUSp2F5tPP9hbLDw/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 13:47:19 INFO - Downloaded 14403317 bytes. 13:47:19 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'] 13:47:19 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 13:47:20 INFO - Return code: 0 13:47:20 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')]} 13:47:20 INFO - https://queue.taskcluster.net/v1/task/Nr8C3QtUSp2F5tPP9hbLDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:47:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nr8C3QtUSp2F5tPP9hbLDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:47:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nr8C3QtUSp2F5tPP9hbLDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:47:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nr8C3QtUSp2F5tPP9hbLDw/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 13:47:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nr8C3QtUSp2F5tPP9hbLDw/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 13:47:21 INFO - Downloaded 56663860 bytes. 13:47:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Nr8C3QtUSp2F5tPP9hbLDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:47:21 INFO - mkdir: /builds/slave/test/properties 13:47:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:47:21 INFO - Writing to file /builds/slave/test/properties/build_url 13:47:21 INFO - Contents: 13:47:21 INFO - build_url:https://queue.taskcluster.net/v1/task/Nr8C3QtUSp2F5tPP9hbLDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:47:22 INFO - Running post-action listener: _resource_record_post_action 13:47:22 INFO - Running post-action listener: set_extra_try_arguments 13:47:22 INFO - ##### 13:47:22 INFO - ##### Finished download-and-extract step (success) 13:47:22 INFO - ##### 13:47:22 INFO - ##### 13:47:22 INFO - ##### Running populate-webroot step. 13:47:22 INFO - ##### 13:47:22 INFO - Running pre-action listener: _resource_record_pre_action 13:47:22 INFO - Running main action method: populate_webroot 13:47:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:47:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:47:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:47:22 INFO - '--tppagecycles', 13:47:22 INFO - '7'], 13:47:22 INFO - 'tests': ['tsvgm']}}, 13:47:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:47:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:47:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:47:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:47:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:47:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:47:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:47:22 INFO - 'talos_options': ['--disable-e10s'], 13:47:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:47:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:47:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:47:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:47:22 INFO - 'talos_options': ['--disable-e10s'], 13:47:22 INFO - 'tests': ['damp', 'tps']}, 13:47:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:47:22 INFO - 'tests': ['damp', 'tps']}, 13:47:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:47:22 INFO - 'tests': ['dromaeo_dom']}, 13:47:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:47:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:47:22 INFO - 'tests': ['basic_compositor_video']}, 13:47:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:47:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:47:22 INFO - 'tests': ['a11yr', 13:47:22 INFO - 'ts_paint', 13:47:22 INFO - 'tpaint', 13:47:22 INFO - 'sessionrestore', 13:47:22 INFO - 'sessionrestore_no_auto_restore', 13:47:22 INFO - 'tabpaint']}, 13:47:22 INFO - 'other-e10s': {'tests': ['a11yr', 13:47:22 INFO - 'ts_paint', 13:47:22 INFO - 'tpaint', 13:47:22 INFO - 'sessionrestore', 13:47:22 INFO - 'sessionrestore_no_auto_restore', 13:47:22 INFO - 'tabpaint']}, 13:47:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:47:22 INFO - 'ts_paint', 13:47:22 INFO - 'tpaint', 13:47:22 INFO - 'sessionrestore', 13:47:22 INFO - 'sessionrestore_no_auto_restore', 13:47:22 INFO - 'tabpaint']}, 13:47:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:47:22 INFO - 'ts_paint', 13:47:22 INFO - 'tpaint', 13:47:22 INFO - 'sessionrestore', 13:47:22 INFO - 'sessionrestore_no_auto_restore', 13:47:22 INFO - 'tabpaint']}, 13:47:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:47:22 INFO - 'tests': ['a11yr', 13:47:22 INFO - 'ts_paint', 13:47:22 INFO - 'tpaint', 13:47:22 INFO - 'sessionrestore', 13:47:22 INFO - 'sessionrestore_no_auto_restore', 13:47:22 INFO - 'tabpaint']}, 13:47:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:47:22 INFO - 'tests': ['a11yr', 13:47:22 INFO - 'ts_paint', 13:47:22 INFO - 'tpaint', 13:47:22 INFO - 'sessionrestore', 13:47:22 INFO - 'sessionrestore_no_auto_restore', 13:47:22 INFO - 'tabpaint']}, 13:47:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:47:22 INFO - 'tests': ['tsvgx', 13:47:22 INFO - 'tsvgr_opacity', 13:47:22 INFO - 'tart', 13:47:22 INFO - 'tscrollx', 13:47:22 INFO - 'cart']}, 13:47:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:47:22 INFO - 'tsvgr_opacity', 13:47:22 INFO - 'tart', 13:47:22 INFO - 'tscrollx', 13:47:22 INFO - 'cart']}, 13:47:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:47:22 INFO - 'talos_options': ['--disable-e10s'], 13:47:22 INFO - 'tests': ['tp5o']}, 13:47:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:47:22 INFO - 'tests': ['tp5o']}, 13:47:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:47:22 INFO - 'talos_options': ['--disable-e10s', 13:47:22 INFO - '--xperf_path', 13:47:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:47:22 INFO - 'tests': ['tp5n']}, 13:47:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:47:22 INFO - 'talos_options': ['--xperf_path', 13:47:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:47:22 INFO - 'tests': ['tp5n']}}, 13:47:22 INFO - 'talos.zip': {'path': '', 13:47:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:47:22 INFO - Running post-action listener: _resource_record_post_action 13:47:22 INFO - ##### 13:47:22 INFO - ##### Finished populate-webroot step (success) 13:47:22 INFO - ##### 13:47:22 INFO - ##### 13:47:22 INFO - ##### Running create-virtualenv step. 13:47:22 INFO - ##### 13:47:22 INFO - Running pre-action listener: _resource_record_pre_action 13:47:22 INFO - Running main action method: create_virtualenv 13:47:22 INFO - Creating virtualenv /builds/slave/test/build/venv 13:47:22 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 13:47:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:47:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:47:22 INFO - Using real prefix '/usr' 13:47:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:47:22 INFO - Installing distribute.............................................................................................................................................................................................done. 13:47:24 INFO - Installing pip.................done. 13:47:24 INFO - Return code: 0 13:47:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:47:24 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')]} 13:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:47:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:24 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')]} 13:47:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:47:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:24 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 0x2359030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x261a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26183b0>, '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 0x26192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2619740>, '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': '5bd038846534b2fdfa68eeae000001e2-1468355688.496615-1670034750', '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 13:47:24 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 13:47:24 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 13:47:24 INFO - Using env: {'DISPLAY': ':0', 13:47:24 INFO - 'HOME': '/home/cltbld', 13:47:24 INFO - 'LANG': 'en_US.UTF-8', 13:47:24 INFO - 'LANGUAGE': 'en_US:en', 13:47:24 INFO - 'LOGNAME': 'cltbld', 13:47:24 INFO - 'MAIL': '/var/mail/cltbld', 13:47:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:47:24 INFO - 'MOZ_NO_REMOTE': '1', 13:47:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:47:24 INFO - 'NO_EM_RESTART': '1', 13:47:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:47:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:47:24 INFO - 'PWD': '/builds/slave/test', 13:47:24 INFO - 'SHELL': '/bin/bash', 13:47:24 INFO - 'SHLVL': '1', 13:47:24 INFO - 'TERM': 'linux', 13:47:24 INFO - 'TMOUT': '86400', 13:47:24 INFO - 'USER': 'cltbld', 13:47:24 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468355688.496615-1670034750', 13:47:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:47:24 INFO - '_': '/tools/buildbot/bin/python'} 13:47:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:47:24 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 13:47:24 INFO - Cleaning up... 13:47:25 INFO - Return code: 0 13:47:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:47:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:47:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:47:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:47:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2359030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x261a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26183b0>, '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 0x26192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2619740>, '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': '5bd038846534b2fdfa68eeae000001e2-1468355688.496615-1670034750', '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 13:47:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:47:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:47:25 INFO - Using env: {'DISPLAY': ':0', 13:47:25 INFO - 'HOME': '/home/cltbld', 13:47:25 INFO - 'LANG': 'en_US.UTF-8', 13:47:25 INFO - 'LANGUAGE': 'en_US:en', 13:47:25 INFO - 'LOGNAME': 'cltbld', 13:47:25 INFO - 'MAIL': '/var/mail/cltbld', 13:47:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:47:25 INFO - 'MOZ_NO_REMOTE': '1', 13:47:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:47:25 INFO - 'NO_EM_RESTART': '1', 13:47:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:47:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:47:25 INFO - 'PWD': '/builds/slave/test', 13:47:25 INFO - 'SHELL': '/bin/bash', 13:47:25 INFO - 'SHLVL': '1', 13:47:25 INFO - 'TERM': 'linux', 13:47:25 INFO - 'TMOUT': '86400', 13:47:25 INFO - 'USER': 'cltbld', 13:47:25 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468355688.496615-1670034750', 13:47:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:47:25 INFO - '_': '/tools/buildbot/bin/python'} 13:47:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:47:25 INFO - Downloading/unpacking psutil>=3.1.1 13:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:47:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:47:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:47:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:47:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:47:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:47:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:47:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:47:27 INFO - Installing collected packages: psutil 13:47:27 INFO - Running setup.py install for psutil 13:47:27 INFO - building 'psutil._psutil_linux' extension 13:47:27 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 13:47:27 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 13:47:27 INFO - building 'psutil._psutil_posix' extension 13:47:27 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 13:47:27 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 13:47:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:47:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:47:27 INFO - Successfully installed psutil 13:47:27 INFO - Cleaning up... 13:47:27 INFO - Return code: 0 13:47:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:47:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:47:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:47:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:47:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:47:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2359030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x261a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26183b0>, '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 0x26192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2619740>, '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': '5bd038846534b2fdfa68eeae000001e2-1468355688.496615-1670034750', '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 13:47:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:47:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:47:27 INFO - Using env: {'DISPLAY': ':0', 13:47:27 INFO - 'HOME': '/home/cltbld', 13:47:27 INFO - 'LANG': 'en_US.UTF-8', 13:47:27 INFO - 'LANGUAGE': 'en_US:en', 13:47:27 INFO - 'LOGNAME': 'cltbld', 13:47:27 INFO - 'MAIL': '/var/mail/cltbld', 13:47:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:47:27 INFO - 'MOZ_NO_REMOTE': '1', 13:47:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:47:27 INFO - 'NO_EM_RESTART': '1', 13:47:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:47:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:47:27 INFO - 'PWD': '/builds/slave/test', 13:47:27 INFO - 'SHELL': '/bin/bash', 13:47:27 INFO - 'SHLVL': '1', 13:47:27 INFO - 'TERM': 'linux', 13:47:27 INFO - 'TMOUT': '86400', 13:47:27 INFO - 'USER': 'cltbld', 13:47:27 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468355688.496615-1670034750', 13:47:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:47:27 INFO - '_': '/tools/buildbot/bin/python'} 13:47:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:47:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:47:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:47:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:47:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:47:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:47:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:47:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:47:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:47:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:47:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:47:29 INFO - Installing collected packages: mozsystemmonitor 13:47:29 INFO - Running setup.py install for mozsystemmonitor 13:47:30 INFO - Successfully installed mozsystemmonitor 13:47:30 INFO - Cleaning up... 13:47:30 INFO - Return code: 0 13:47:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:47:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:47:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:47:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2359030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x261a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26183b0>, '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 0x26192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2619740>, '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': '5bd038846534b2fdfa68eeae000001e2-1468355688.496615-1670034750', '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 13:47:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:47:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:47:30 INFO - Using env: {'DISPLAY': ':0', 13:47:30 INFO - 'HOME': '/home/cltbld', 13:47:30 INFO - 'LANG': 'en_US.UTF-8', 13:47:30 INFO - 'LANGUAGE': 'en_US:en', 13:47:30 INFO - 'LOGNAME': 'cltbld', 13:47:30 INFO - 'MAIL': '/var/mail/cltbld', 13:47:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:47:30 INFO - 'MOZ_NO_REMOTE': '1', 13:47:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:47:30 INFO - 'NO_EM_RESTART': '1', 13:47:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:47:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:47:30 INFO - 'PWD': '/builds/slave/test', 13:47:30 INFO - 'SHELL': '/bin/bash', 13:47:30 INFO - 'SHLVL': '1', 13:47:30 INFO - 'TERM': 'linux', 13:47:30 INFO - 'TMOUT': '86400', 13:47:30 INFO - 'USER': 'cltbld', 13:47:30 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468355688.496615-1670034750', 13:47:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:47:30 INFO - '_': '/tools/buildbot/bin/python'} 13:47:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:47:30 INFO - Downloading/unpacking jsonschema==2.5.1 13:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:47:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:47:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:47:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:47:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:47:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:47:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:47:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:47:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:47:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:47:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:47:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:47:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:47:32 INFO - Downloading functools32-3.2.3-2.tar.gz 13:47:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:47:32 INFO - warning: no files found matching '*.txt' 13:47:32 INFO - no previously-included directories found matching 'build' 13:47:32 INFO - no previously-included directories found matching 'dist' 13:47:32 INFO - no previously-included directories found matching '.git*' 13:47:32 INFO - Installing collected packages: jsonschema, functools32 13:47:32 INFO - Running setup.py install for functools32 13:47:32 INFO - warning: no files found matching '*.txt' 13:47:32 INFO - no previously-included directories found matching 'build' 13:47:32 INFO - no previously-included directories found matching 'dist' 13:47:32 INFO - no previously-included directories found matching '.git*' 13:47:32 INFO - Successfully installed jsonschema functools32 13:47:32 INFO - Cleaning up... 13:47:32 INFO - Return code: 0 13:47:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:47:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:47:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:47:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:47:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:47:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2359030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x261a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26183b0>, '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 0x26192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2619740>, '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': '5bd038846534b2fdfa68eeae000001e2-1468355688.496615-1670034750', '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 13:47:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:47:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:47:32 INFO - Using env: {'DISPLAY': ':0', 13:47:32 INFO - 'HOME': '/home/cltbld', 13:47:32 INFO - 'LANG': 'en_US.UTF-8', 13:47:32 INFO - 'LANGUAGE': 'en_US:en', 13:47:32 INFO - 'LOGNAME': 'cltbld', 13:47:32 INFO - 'MAIL': '/var/mail/cltbld', 13:47:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:47:32 INFO - 'MOZ_NO_REMOTE': '1', 13:47:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:47:32 INFO - 'NO_EM_RESTART': '1', 13:47:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:47:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:47:32 INFO - 'PWD': '/builds/slave/test', 13:47:32 INFO - 'SHELL': '/bin/bash', 13:47:32 INFO - 'SHLVL': '1', 13:47:32 INFO - 'TERM': 'linux', 13:47:32 INFO - 'TMOUT': '86400', 13:47:32 INFO - 'USER': 'cltbld', 13:47:32 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468355688.496615-1670034750', 13:47:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:47:32 INFO - '_': '/tools/buildbot/bin/python'} 13:47:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:47:32 INFO - Downloading/unpacking blobuploader==1.2.4 13:47:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:47:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:47:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:47:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:47:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:47:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:47:34 INFO - Downloading blobuploader-1.2.4.tar.gz 13:47:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:47:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:47: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 13:47: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 13:47: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 13:47: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 13:47: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 13:47: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 13:47:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:47:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:47: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 13:47: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 13:47: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 13:47: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 13:47: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 13:47: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 13:47:35 INFO - Downloading docopt-0.6.1.tar.gz 13:47:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:47:35 INFO - Installing collected packages: blobuploader, requests, docopt 13:47:35 INFO - Running setup.py install for blobuploader 13:47:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:47:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:47:35 INFO - Running setup.py install for requests 13:47:35 INFO - Running setup.py install for docopt 13:47:36 INFO - Successfully installed blobuploader requests docopt 13:47:36 INFO - Cleaning up... 13:47:36 INFO - Return code: 0 13:47:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:47: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')]} 13:47:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:47:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47: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')]} 13:47:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:47:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:36 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 0x2359030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x261a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26183b0>, '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 0x26192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2619740>, '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': '5bd038846534b2fdfa68eeae000001e2-1468355688.496615-1670034750', '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 13:47:36 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 13:47:36 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 13:47:36 INFO - Using env: {'DISPLAY': ':0', 13:47:36 INFO - 'HOME': '/home/cltbld', 13:47:36 INFO - 'LANG': 'en_US.UTF-8', 13:47:36 INFO - 'LANGUAGE': 'en_US:en', 13:47:36 INFO - 'LOGNAME': 'cltbld', 13:47:36 INFO - 'MAIL': '/var/mail/cltbld', 13:47:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:47:36 INFO - 'MOZ_NO_REMOTE': '1', 13:47:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:47:36 INFO - 'NO_EM_RESTART': '1', 13:47:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:47:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:47:36 INFO - 'PWD': '/builds/slave/test', 13:47:36 INFO - 'SHELL': '/bin/bash', 13:47:36 INFO - 'SHLVL': '1', 13:47:36 INFO - 'TERM': 'linux', 13:47:36 INFO - 'TMOUT': '86400', 13:47:36 INFO - 'USER': 'cltbld', 13:47:36 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468355688.496615-1670034750', 13:47:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:47:36 INFO - '_': '/tools/buildbot/bin/python'} 13:47:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:47:36 INFO - Running setup.py (path:/tmp/pip-8XPwzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:47:36 INFO - Running setup.py (path:/tmp/pip-q2cx9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:47:36 INFO - Running setup.py (path:/tmp/pip-3MFSGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:47:36 INFO - Running setup.py (path:/tmp/pip-ToLSOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:47:36 INFO - Running setup.py (path:/tmp/pip-KOr7zM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:47:36 INFO - Running setup.py (path:/tmp/pip-MfKAVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:47:36 INFO - Running setup.py (path:/tmp/pip-osIH3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:47:36 INFO - Running setup.py (path:/tmp/pip-ddzgIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:47:36 INFO - Running setup.py (path:/tmp/pip-JCUIHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:47:37 INFO - Running setup.py (path:/tmp/pip-JKtMLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:47:37 INFO - Running setup.py (path:/tmp/pip-ZmTSOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:47:37 INFO - Running setup.py (path:/tmp/pip-cIXexR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:47:37 INFO - Running setup.py (path:/tmp/pip-xvgzot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:47:37 INFO - Running setup.py (path:/tmp/pip-xxmRF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:47:37 INFO - Running setup.py (path:/tmp/pip-o8Gwyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:47:37 INFO - Running setup.py (path:/tmp/pip-6gkOcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:47:37 INFO - Running setup.py (path:/tmp/pip-x1jpBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:47:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:47:37 INFO - Running setup.py install for manifestparser 13:47:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:47:37 INFO - Running setup.py install for mozcrash 13:47:37 INFO - Running setup.py install for mozdebug 13:47:37 INFO - Running setup.py install for mozdevice 13:47:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:47:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:47:37 INFO - Running setup.py install for mozfile 13:47:38 INFO - Running setup.py install for mozhttpd 13:47:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:47:38 INFO - Running setup.py install for mozinfo 13:47:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:47:38 INFO - Running setup.py install for mozInstall 13:47:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:47:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:47:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:47:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:47:38 INFO - Running setup.py install for mozleak 13:47:38 INFO - Running setup.py install for mozlog 13:47:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:47:38 INFO - Running setup.py install for moznetwork 13:47:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:47:38 INFO - Running setup.py install for mozprocess 13:47:38 INFO - Running setup.py install for mozprofile 13:47:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:47:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:47:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:47:38 INFO - Running setup.py install for mozrunner 13:47:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:47:39 INFO - Running setup.py install for mozscreenshot 13:47:39 INFO - Running setup.py install for moztest 13:47:39 INFO - Running setup.py install for mozversion 13:47:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:47:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:47:39 INFO - Cleaning up... 13:47:39 INFO - Return code: 0 13:47:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:47: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')]} 13:47:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:47:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47: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')]} 13:47:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:47:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:39 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 0x2359030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x261a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26183b0>, '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 0x26192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2619740>, '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': '5bd038846534b2fdfa68eeae000001e2-1468355688.496615-1670034750', '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 13:47:39 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 13:47:39 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 13:47:39 INFO - Using env: {'DISPLAY': ':0', 13:47:39 INFO - 'HOME': '/home/cltbld', 13:47:39 INFO - 'LANG': 'en_US.UTF-8', 13:47:39 INFO - 'LANGUAGE': 'en_US:en', 13:47:39 INFO - 'LOGNAME': 'cltbld', 13:47:39 INFO - 'MAIL': '/var/mail/cltbld', 13:47:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:47:39 INFO - 'MOZ_NO_REMOTE': '1', 13:47:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:47:39 INFO - 'NO_EM_RESTART': '1', 13:47:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:47:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:47:39 INFO - 'PWD': '/builds/slave/test', 13:47:39 INFO - 'SHELL': '/bin/bash', 13:47:39 INFO - 'SHLVL': '1', 13:47:39 INFO - 'TERM': 'linux', 13:47:39 INFO - 'TMOUT': '86400', 13:47:39 INFO - 'USER': 'cltbld', 13:47:39 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468355688.496615-1670034750', 13:47:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:47:39 INFO - '_': '/tools/buildbot/bin/python'} 13:47:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:47:39 INFO - Running setup.py (path:/tmp/pip-AtEUFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:47:39 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)) 13:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:47:39 INFO - Running setup.py (path:/tmp/pip-YDk2Sf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:47:39 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)) 13:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:47:39 INFO - Running setup.py (path:/tmp/pip-AyfqEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:47:39 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)) 13:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:47:39 INFO - Running setup.py (path:/tmp/pip-b0fnSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:47:39 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)) 13:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:47:39 INFO - Running setup.py (path:/tmp/pip-aCRUDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:47:39 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)) 13:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:47:39 INFO - Running setup.py (path:/tmp/pip-Pk45zq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:47:40 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)) 13:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:47:40 INFO - Running setup.py (path:/tmp/pip-58LpUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:47:40 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)) 13:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:47:40 INFO - Running setup.py (path:/tmp/pip-5gl1We-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:47:40 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)) 13:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:47:40 INFO - Running setup.py (path:/tmp/pip-WWYjtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:47:40 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)) 13:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:47:40 INFO - Running setup.py (path:/tmp/pip-kmyFFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:47:40 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)) 13:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:47:40 INFO - Running setup.py (path:/tmp/pip-TZrDig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:47:40 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)) 13:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:47:40 INFO - Running setup.py (path:/tmp/pip-IoMtYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:47:40 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)) 13:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:47:40 INFO - Running setup.py (path:/tmp/pip-DNsmNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:47:40 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)) 13:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:47:40 INFO - Running setup.py (path:/tmp/pip-BYTX_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:47:40 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)) 13:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:47:40 INFO - Running setup.py (path:/tmp/pip-PMiYQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:47:40 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)) 13:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:47:40 INFO - Running setup.py (path:/tmp/pip-9JdN7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:47:40 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)) 13:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:47:40 INFO - Running setup.py (path:/tmp/pip-jiTswE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:47:40 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)) 13:47:40 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)) 13:47:40 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)) 13:47:40 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)) 13:47:40 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)) 13:47:40 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)) 13:47:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:47:40 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 13:47:40 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 13:47:40 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 13:47:40 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 13:47:40 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 13:47:40 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 13:47:42 INFO - Downloading blessings-1.6.tar.gz 13:47:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:47:42 INFO - Installing collected packages: blessings 13:47:42 INFO - Running setup.py install for blessings 13:47:42 INFO - Successfully installed blessings 13:47:42 INFO - Cleaning up... 13:47:43 INFO - Return code: 0 13:47:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:47:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:47:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:47:43 INFO - Reading from file tmpfile_stdout 13:47:43 INFO - Current package versions: 13:47:43 INFO - argparse == 1.2.1 13:47:43 INFO - blessings == 1.6 13:47:43 INFO - blobuploader == 1.2.4 13:47:43 INFO - docopt == 0.6.1 13:47:43 INFO - functools32 == 3.2.3-2 13:47:43 INFO - jsonschema == 2.5.1 13:47:43 INFO - manifestparser == 1.1 13:47:43 INFO - mozInstall == 1.12 13:47:43 INFO - mozcrash == 0.17 13:47:43 INFO - mozdebug == 0.1 13:47:43 INFO - mozdevice == 0.48 13:47:43 INFO - mozfile == 1.2 13:47:43 INFO - mozhttpd == 0.7 13:47:43 INFO - mozinfo == 0.9 13:47:43 INFO - mozleak == 0.1 13:47:43 INFO - mozlog == 3.2 13:47:43 INFO - moznetwork == 0.27 13:47:43 INFO - mozprocess == 0.23 13:47:43 INFO - mozprofile == 0.28 13:47:43 INFO - mozrunner == 6.12 13:47:43 INFO - mozscreenshot == 0.1 13:47:43 INFO - mozsystemmonitor == 0.3 13:47:43 INFO - moztest == 0.7 13:47:43 INFO - mozversion == 1.4 13:47:43 INFO - psutil == 3.1.1 13:47:43 INFO - requests == 1.2.3 13:47:43 INFO - wsgiref == 0.1.2 13:47:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:47: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')]} 13:47:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:47:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47: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')]} 13:47:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:47:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:43 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 0x2359030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x261a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26183b0>, '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 0x26192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2619740>, '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': '5bd038846534b2fdfa68eeae000001e2-1468355688.496615-1670034750', '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 13:47:43 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 13:47:43 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 13:47:43 INFO - Using env: {'DISPLAY': ':0', 13:47:43 INFO - 'HOME': '/home/cltbld', 13:47:43 INFO - 'LANG': 'en_US.UTF-8', 13:47:43 INFO - 'LANGUAGE': 'en_US:en', 13:47:43 INFO - 'LOGNAME': 'cltbld', 13:47:43 INFO - 'MAIL': '/var/mail/cltbld', 13:47:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:47:43 INFO - 'MOZ_NO_REMOTE': '1', 13:47:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:47:43 INFO - 'NO_EM_RESTART': '1', 13:47:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:47:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:47:43 INFO - 'PWD': '/builds/slave/test', 13:47:43 INFO - 'SHELL': '/bin/bash', 13:47:43 INFO - 'SHLVL': '1', 13:47:43 INFO - 'TERM': 'linux', 13:47:43 INFO - 'TMOUT': '86400', 13:47:43 INFO - 'USER': 'cltbld', 13:47:43 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468355688.496615-1670034750', 13:47:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:47:43 INFO - '_': '/tools/buildbot/bin/python'} 13:47:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:47:43 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)) 13:47:43 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)) 13:47:43 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)) 13:47:43 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)) 13:47:43 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)) 13:47:43 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)) 13:47:43 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)) 13:47:43 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)) 13:47:43 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)) 13:47:43 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)) 13:47:43 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)) 13:47:43 INFO - Cleaning up... 13:47:43 INFO - Return code: 0 13:47:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:47: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')]} 13:47:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:47:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47: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')]} 13:47:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:47:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:43 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 0x2359030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x261a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26183b0>, '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 0x26192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2619740>, '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': '5bd038846534b2fdfa68eeae000001e2-1468355688.496615-1670034750', '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 13:47:43 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 13:47:43 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 13:47:43 INFO - Using env: {'DISPLAY': ':0', 13:47:43 INFO - 'HOME': '/home/cltbld', 13:47:43 INFO - 'LANG': 'en_US.UTF-8', 13:47:43 INFO - 'LANGUAGE': 'en_US:en', 13:47:43 INFO - 'LOGNAME': 'cltbld', 13:47:43 INFO - 'MAIL': '/var/mail/cltbld', 13:47:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:47:43 INFO - 'MOZ_NO_REMOTE': '1', 13:47:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:47:43 INFO - 'NO_EM_RESTART': '1', 13:47:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:47:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:47:43 INFO - 'PWD': '/builds/slave/test', 13:47:43 INFO - 'SHELL': '/bin/bash', 13:47:43 INFO - 'SHLVL': '1', 13:47:43 INFO - 'TERM': 'linux', 13:47:43 INFO - 'TMOUT': '86400', 13:47:43 INFO - 'USER': 'cltbld', 13:47:43 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468355688.496615-1670034750', 13:47:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:47:43 INFO - '_': '/tools/buildbot/bin/python'} 13:47:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:47:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:47:43 INFO - Cleaning up... 13:47:43 INFO - Return code: 0 13:47:43 INFO - Running post-action listener: _resource_record_post_action 13:47:43 INFO - Running post-action listener: _start_resource_monitoring 13:47:43 INFO - Starting resource monitoring. 13:47:43 INFO - ##### 13:47:43 INFO - ##### Finished create-virtualenv step (success) 13:47:43 INFO - ##### 13:47:43 INFO - ##### 13:47:43 INFO - ##### Running install step. 13:47:43 INFO - ##### 13:47:43 INFO - Running pre-action listener: _resource_record_pre_action 13:47:43 INFO - Running main action method: install 13:47:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:47:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:47:43 INFO - Reading from file tmpfile_stdout 13:47:43 INFO - Detecting whether we're running mozinstall >=1.0... 13:47:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:47:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:47:43 INFO - Reading from file tmpfile_stdout 13:47:43 INFO - Output received: 13:47:43 INFO - Usage: mozinstall [options] installer 13:47:43 INFO - Options: 13:47:43 INFO - -h, --help show this help message and exit 13:47:43 INFO - -d DEST, --destination=DEST 13:47:43 INFO - Directory to install application into. [default: 13:47:43 INFO - "/builds/slave/test"] 13:47:43 INFO - --app=APP Application being installed. [default: firefox] 13:47:43 INFO - mkdir: /builds/slave/test/build/application 13:47:43 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'] 13:47:43 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 13:48:00 INFO - Reading from file tmpfile_stdout 13:48:00 INFO - Output received: 13:48:00 INFO - /builds/slave/test/build/application/firefox/firefox 13:48:00 INFO - Running post-action listener: _resource_record_post_action 13:48:00 INFO - ##### 13:48:00 INFO - ##### Finished install step (success) 13:48:00 INFO - ##### 13:48:00 INFO - ##### 13:48:00 INFO - ##### Running run-tests step. 13:48:00 INFO - ##### 13:48:00 INFO - Running pre-action listener: _resource_record_pre_action 13:48:00 INFO - Running main action method: run_tests 13:48:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:48:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:48:00 INFO - Python 2.7.3 13:48:00 INFO - Return code: 0 13:48:00 INFO - grabbing minidump binary from tooltool 13:48:00 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')]} 13:48:00 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 0x26183b0>, '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 0x26192b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2619740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:48:00 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 13:48:00 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 13:48:00 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 13:48:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:48:00 INFO - Return code: 0 13:48:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:48:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:48:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:48:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:48:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:48:00 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/Nr8C3QtUSp2F5tPP9hbLDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 13:48:00 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/Nr8C3QtUSp2F5tPP9hbLDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --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 13:48:00 INFO - Using env: {'DISPLAY': ':0', 13:48:00 INFO - 'HOME': '/home/cltbld', 13:48:00 INFO - 'LANG': 'en_US.UTF-8', 13:48:00 INFO - 'LANGUAGE': 'en_US:en', 13:48:00 INFO - 'LOGNAME': 'cltbld', 13:48:00 INFO - 'MAIL': '/var/mail/cltbld', 13:48:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:48:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:48:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:00 INFO - 'MOZ_NO_REMOTE': '1', 13:48:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:48:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:48:00 INFO - 'NO_EM_RESTART': '1', 13:48:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:48:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:48:00 INFO - 'PWD': '/builds/slave/test', 13:48:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:48:00 INFO - 'SHELL': '/bin/bash', 13:48:00 INFO - 'SHLVL': '1', 13:48:00 INFO - 'TERM': 'linux', 13:48:00 INFO - 'TMOUT': '86400', 13:48:00 INFO - 'USER': 'cltbld', 13:48:00 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468355688.496615-1670034750', 13:48:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:00 INFO - '_': '/tools/buildbot/bin/python'} 13:48:00 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/Nr8C3QtUSp2F5tPP9hbLDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 13:48:00 INFO - mozversion application_buildid: 20160712132427 13:48:00 INFO - mozversion application_changeset: a03a6fd88c3d0ea6e36a41a5d295fc870ce874b1 13:48:00 INFO - mozversion application_display_name: Nightly 13:48:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:48:00 INFO - mozversion application_name: Firefox 13:48:00 INFO - mozversion application_remotingname: firefox 13:48:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:48:00 INFO - mozversion application_vendor: Mozilla 13:48:00 INFO - mozversion application_version: 50.0a1 13:48:00 INFO - mozversion platform_buildid: 20160712132427 13:48:00 INFO - mozversion platform_changeset: a03a6fd88c3d0ea6e36a41a5d295fc870ce874b1 13:48:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:48:00 INFO - mozversion platform_version: 50.0a1 13:48:00 INFO - using testdate: 1468356480 13:48:00 INFO - actual date: 1468356480 13:48:00 INFO - starting webserver on 'localhost:33925' 13:48:00 INFO - SUITE-START | Running 2 tests 13:48:00 INFO - TEST-START | dromaeo_css 13:48:00 INFO - operating with platform_type : linux_ 13:48:00 INFO - Initialising browser for dromaeo_css test... 13:48:00 INFO - TEST-INFO | started process 29828 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSZ4xW7/profile http://localhost:33925/getInfo.html) 13:48:05 INFO - PROCESS | 29828 | __metrics Screen width/height:1600/1200 13:48:05 INFO - PROCESS | 29828 | colorDepth:24 13:48:05 INFO - PROCESS | 29828 | Browser inner width/height: 1024/697 13:48:05 INFO - PROCESS | 29828 | __metrics 13:48:05 INFO - PROCESS | 29828 | 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" 13:48:05 INFO - PROCESS | 29828 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:48:06 INFO - TEST-INFO | 29828: exit 0 13:48:06 INFO - Browser initialized. 13:48:06 INFO - Running cycle 1/1 for dromaeo_css test... 13:48:06 INFO - TEST-INFO | started process 29911 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSZ4xW7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:48:18 INFO - PROCESS | 29911 | RSS: Main: 159154176 13:48:18 INFO - PROCESS | 29911 | 13:49:09 INFO - PROCESS | 29911 | 1468356549985 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] 13:51:23 INFO - PROCESS | 29911 | Cycle 1(1): loaded http://localhost:33925/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33925/tests/dromaeo/cssquery-ext.html) 13:51:24 INFO - PROCESS | 29911 | RSS: Main: 268369920 13:51:24 INFO - PROCESS | 29911 | 13:54:26 INFO - PROCESS | 29911 | Cycle 1(1): loaded http://localhost:33925/tests/dromaeo/cssquery-ext.html (next: http://localhost:33925/tests/dromaeo/cssquery-jquery.html) 13:54:27 INFO - PROCESS | 29911 | RSS: Main: 233435136 13:54:27 INFO - PROCESS | 29911 | 13:57:29 INFO - PROCESS | 29911 | Cycle 1(1): loaded http://localhost:33925/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33925/tests/dromaeo/cssquery-mootools.html) 13:57:30 INFO - PROCESS | 29911 | RSS: Main: 248258560 13:57:30 INFO - PROCESS | 29911 | 14:00:32 INFO - PROCESS | 29911 | Cycle 1(1): loaded http://localhost:33925/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33925/tests/dromaeo/cssquery-prototype.html) 14:00:33 INFO - PROCESS | 29911 | RSS: Main: 231821312 14:00:33 INFO - PROCESS | 29911 | 14:03:36 INFO - PROCESS | 29911 | Cycle 1(1): loaded http://localhost:33925/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33925/tests/dromaeo/cssquery-yui.html) 14:03:36 INFO - PROCESS | 29911 | RSS: Main: 227659776 14:03:36 INFO - PROCESS | 29911 | 14:06:39 INFO - PROCESS | 29911 | Cycle 1(1): loaded http://localhost:33925/tests/dromaeo/cssquery-yui.html (next: http://localhost:33925/tests/dromaeo/cssquery-dojo.html) 14:06:39 INFO - PROCESS | 29911 | RSS: Main: 289202176 14:06:39 INFO - PROCESS | 29911 | 14:06:39 INFO - PROCESS | 29911 | __start_tp_report 14:06:39 INFO - PROCESS | 29911 | _x_x_mozilla_page_load 14:06:39 INFO - PROCESS | 29911 | _x_x_mozilla_page_load_details 14:06:39 INFO - PROCESS | 29911 | |i|pagename|runs| 14:06:39 INFO - PROCESS | 29911 | |0;dojo.html;2663.533881570725;2679.3301674581353;2703;2705.864706764661;2715.253305341032;4676;4770.045990801845;4795.856124316268;4875.707457552545;4917.532834380732;4704.082703872747;4724;4748.596369308613;4767.47557768646;4781.0676918001;4300.6989510734265;4345.3047512398025;4377.430933978579;4422.823087076513;4520.186366454037;4460.1525710114975;4489.1695036418205;4495.797689103982;4526.569975852289;4540.160070386973;4308.504521979981;4331.242032644274;4333.761643109628;4355.237833379178;4397.494288156871;4309.116631090619;4312.029793296515;4317.201317756225;4386.868393948154;4455.977720111378;4322.178786030676;4328.740275583444;4342.261815491374;4349;4392.648588112976;4705.200115980258;4729.290606409032;4742.359781429497;4787.042591481682;4788.162071637485;5102.260172275037;5150.742462876879;5157.329547158883;5158.690478571298;5162.819301324435;5138;5172.896542069175;5183.041137389558;5190.4550022247495;5191.662541934762;4694;4773.832915847928;4778.116048531033;4811.663183577186;4830.082284365959;5289.2330612061805;5311.336082989626;5312.990531799023;5354;5372.946270537323;5093.9745301274;5137.12668846297;5147.639665223398;5151.459096794858;5153.252778347193;4994.650374473825;5104.566111880457;5162.586993040548;5164.948350516522;5166.43169251382;5125.538701516882;5134.2298655201275;5148.845534633892;5149.150390185652;5150.459201783834;5063.772130254148;5064.670796398296;5077.543021128116;5110.029094472038;5165.276861239429;4216.262154123016;4244.427002354642;4248.235317642854;4276.615104640598;4312.439382880269;3785.167263202091;3786.5645450772963;3826.426036094608;3827.1962887793875;3854.383298672199;4425.933610995838;4434.800433980478;4436.290193569013;4481.081378317437;4483.21543729846;4954.628402869799;4993.1262029144755;5121.667091639031;5146.588272938231;5209.817656382009;4433.069055498317;4463;4465.910681786346;4491.326301054803;4509.323601459741;4636.652251081115;4638;4642.141203877293;4676.111538807683;4689.929651055237;4655.06898620284;4723.480417154042;4831.106245344622;4867.099586576494;4883.438404583376;5053.292539044463;5075.898482030265;5078.085944529872;5080.288759573737;5131.974340128425;4775.283707443911;4776.09254241693;4781.928271075867;4782.282657601388;4840.564349208588;4912.091263116335;5013.799448022184;5033.446320904624;5064.645474816874;5077.822276220315;5118.283440318432;5155.458676838878;5158.329417175743;5158.793648254028;5194.194899790538;5021.347224860745;5026.994601079872;5029.924551131663;5031.245313203049;5080.898382032265;4784.067106914118;4795.808167673254;4861.270809378621;4940.061388336205;5014.874628134326;4863.416390033219;4874;4885.877853053702;4895.241237608177;4927.28554359623;4963.181075122564;4984;4985.6011519077665;4985.875353116201;5036.169032109661;4798.808047678054;4892.461829198714;4934.5805606523845;4943.134951383421;4954.752262386794 14:06:39 INFO - PROCESS | 29911 | |1;ext.html;548.6403062860074;573.6443405088845;575.2550447170911;582.4524946550246;594.111802854732;27494.31264218393;29972.85013574929;29977.1006869794;30038.249043773918;30063.69936300639;30055.549166762463;40797.79601101998;41299.58700412995;41480.792596037056;45699.31451028229;7717.151113377524;7829.451938364316;7830;7840.803979900491;7842.960785196066;7552.735654252102;7708.229177082275;7768.262015108584;7783.571903545303;7795.6491957861745;7797.57113358765;7852.882206766903;9989.500524973759;10314.432706201156;10327.380357178556;10271;10324.690259292232;10332.896671033268;10345.379277243313;10348.637797677084;7509.737159199456;10133.847992280049;10183.7454063649;10199.949000255025;10205.489725513695;39097.41353879694;39991.60008399937;39994.60005399938;43705.34441983341;43714;2894.2619631993707;2908.1857080017417;3063.127008802503;3089.474789285827;3416.8120753358558;29174.562381564294;30813.845930770425;30893.53659695084;31129.066128016195;31187.376252474824;3525.5240542526685;3596.2088340565033;3615.8011309377976;3622.9275414491826;3678.282734866702;277790;278007;278914;279661;281815;56638.15042774362;57065.42934570684;57196.428035719946;57274.42725572774;57325.713371432874;59535;59547;59639;59690.403095969355;59708;15200.619984500256;15783.526494205193;15798;15807.68384632324;15820.208989550476;11153.386563739072;11252.718682032852;11268.887311126784;11327.150463715254;11377.431128443544;15853.365865365256;17658.205380757896;18120.456386308433;18610.81389186118;18938.14778334978;6779.322067793181;6847.657617119125;6905.136857892763;7042.873140297528;7109.649166658319;845.8477474054606;916.0381599320687;922.7370199493113;928.0811996123924;1014.6398028699853;28501.857490712828;29145.417091658474;29414.852925735235;29560.408791824473;29650.703492965225;919.4115765909823;973.7906350134614;977.5014742481386;1017.7201269650757;1036.5180191211123;15159.545213643609;15345.846541534665;15420.922895385676;15672.529824105295;15838.841611583737;418452;464260;473661;473756;670474;52798.73600631972;53401.46598534042;53486.465135348924;53518.73240633772;53540.73229633827;1220.9633710988685;1225.4301749686438;1239.1202246404973;1243.2167734327315;1244.004796163066;28381.574276386284;29196.416071678872;29672.477839383893;30252.54621180728;30295.848520757256;44017.339739903284;44484.33273500965;44544.33183502315;44551.77724111359;44645.33032004457;368565;370974;371625;373046;375578;25594.104206352687;26185;32439.513407299382;33279.833600831844;37542.624573755005;40751.1849763009;41102.58897410987;43232.85554377826;43468.34797477977;44154;36579.817100914326;36865.156742162246;37181.442278365306;37498.8125059373;37512.43731344087;36138.819305904355;37854.242915142095;38007.42988855114;38055.61944380632;38363.80818095891;36527.634723653486;36633;36740.44889326609;37457;37666.24667506689;32258.516122258654;32354.514682280256;33393.499097514046;33410.83294583609;33546.832265838515;25481.745182547937;25763.613545796452;25961.35096622524;26246.343841403355;26446.338841529116 14:06:39 INFO - PROCESS | 29911 | |2;jquery.html;365.7823594960999;373.1212993400542;375.517460063818;378.10766590845617;388.9805509724515;16553.33786648534;17750.112494375277;18124.637507249863;18154.909225453855;18161.7275740864;11600.3039817611;16093.678126437464;17039.488815335528;17073.146342682878;17539.145007586045;4702.576768090863;4853.102176097415;4897.926531102036;4899.044686286175;4899.853004409855;3495.563054618173;3625.148090198801;4754.263089221176;5313.123334649778;5589.413111623262;5648.632838865481;5665.348484924225;5685;5687.573431992597;5692.943070569283;5529.419410961851;5542.91685624716;5647.068233741469;5648.74580643872;5661.716914154296;3377.7804442711144;5056.544910958031;5383.407825139231;5393.5954803389905;5504.834854954358;12824;12877.67805804853;12957.935210323982;15425.845741542553;21526;1833.1567478959694;1875.2499000399812;1885.9245630174776;2141.0793358855685;2509.924702258935;8798;9047.276217902618;9398.765030874214;9904.108630223242;10571.524281407355;1632.9183540822912;1648.4889684197938;1729.7578339032546;1817.7273408988626;1828.076821205296;70250.29749702489;70858.64570677113;70877.64561177212;71209.28790712079;71905.6404717973;10221.642242521477;10232.437215953194;10364.740881478023;10368.170546356274;10553.153198190286;14182.574522764333;14198.148111113367;14240.14559126435;14260.144391336553;14329.426822926966;7215.422766178693;7337.926620733831;7400.777976660601;7419.703211871465;7455.7017719290625;6771.627560484122;7023.770840102961;7135.607541585159;7155.92844071563;7211.819704507429;4394.252976993918;4496.752678602708;4543.886402839889;4576.427946506687;4580.129775342674;1606.4056299169383;1765.5762616971833;1842.3828017614248;1869.9626007479774;1954.6774782160785;809.9230573095547;839.4207996482407;840.970566030186;905.5924833824805;908.1281969309537;16986.915065424593;17088.724537950333;17268;17755.378561750276;17978.460646180636;865.1305438034735;866.8873046503915;878.1493152526218;888.5912480259153;904.8371293167293;9542.713718588453;9906.306558540833;9919.305648604673;9919.851202231972;10077.647282345082;384016;387476;393163.2051038473;393466;393966;76657.23342766613;79311;79882.20117798864;79906;80673;886.9157430044136;894.8120894612074;899.7930475990559;901.9549022548978;916.9083091690911;15260.160691162093;15447.768283475982;15483.148426836633;15507.689846203239;15871.698603702629;38589.6141038586;38622;39483.802580986914;39522.80238598789;39831.601683982786;52283.477165229386;52772.472275276756;53082.20376694275;54793;55532.72233638806;7772.533647981139;7846.725364612211;7878.645460954385;7912.920870791449;7997.720079797179;10762.46187690628;11258.66224013281;11818.271996825644;12049.638510844688;12074.45664945062;10201.795964080826;10429.53067111997;10435.530401132119;10442.425666588108;10517.422386642065;10101.292909496558;10148.137408320375;10181.389116653025;10195.082442580204;10212.540435680263;9521.619135234512;9944.254180936314;10003.29976901639;10567.841482377924;10611;7506.662200200894;7723.343515800995;7788.104367997526;7805.960970195113;7933.087694914928;7622.970898928574;8682.78293042679;9501.904980950378;9566.234701224024;9580.233581313618 14:06:39 INFO - PROCESS | 29911 | |3;mootools.html;1277.169839604257;1363.761341765191;1370.9862901370984;1674.6399524102314;1702.736075908233;7189.532680375778;7570.432217583676;7667.3866090712745;7674.6546405411755;7675.539467631939;6304.054391841226;7132.108486439195;7377.631118444083;7386.593737344444;7532.284432978872;2149.9892500537476;2175.2930297653324;2179.6730490426403;2181.8363622728357;2184.322859913432;1884.510027392874;2178.967315490269;2180.1824315881545;2205.184081889703;2215.711957445538;1991.312997016027;2084.5205602711385;2086.2698055680544;2097.2345094040643;2098.2865825619288;2193.078906859123;2197.52753158071;2204.691343211952;2222.866628002325;2226.755056943735;2177.433867194525;2177.9782202177935;2183.170395249811;2184.584928863511;2191.747948985855;7551.848963020764;7672.578008209546;7679.6160191990175;7685.308322250969;7693.5383876967;4496.033352829125;4621.029583787408;4621.69958952667;4628.560286772751;4629.1898917689605;2774.209350335165;2862.9856850715614;2900.8694608742658;2918.5622156676454;2927.151126173407;830.9335253179731;831.6340810043562;851.5997481183833;852.3436953545797;852.8166444214462;10191.031851974125;10218.846717299246;10244.64143754965;10250.436226007567;10251.231157663206;4034.9798251008556;4206.8527601534415;4236.2586547354085;4303.311470164758;4308.9353659695125;8716.346274029473;8769.649214031495;8780.560971951505;8782.956085219661;8794.38439309255;4525.728456292633;4529.162105010583;4530.728156310566;4536.523665015192;4539.818407263672;4048.0487085534874;4136.627703506699;4140.565240649748;4142.2958097123565;4145.316022856195;3568.1614820517157;3588.138846676779;3620.565532136108;3656.5794933582447;3723.5345581802276;1019.4087429290994;1087.3367245979946;1141.0814294493014;1181.911356648255;1184.236167671864;687.2611942162196;717.0928775099503;735.8197241675824;799.5992083372681;818.6357071103421;4912.557869791736;5020.513660063646;5023.79904803811;5070.771815268322;5136.614753893473;811.2658044469764;819.6516480495885;823.2549542663899;824.7360844529812;830.9335253179731;3329.1510664780326;3429.1427143214196;3440.6043305019743;3443.707284880763;3479.808610526445;9043.276537876955;9289.442633442015;9421.199198068103;9437.339386243035;9449.66926157595;7900.683972641145;8189;9310.441373517611;9321.580528876217;9341.486218258062;6754.155730533684;6943.097397338414;7018.192907815666;7048.154221493351;7079.079719636415;5315.3090098286975;5379.381371142213;5395.514403703529;5490.0941344677685;5547.750351234285;8502.957485212783;8527.53098579584;8657.653693852428;8765.474071555727;8772.078931712078;8621.267192288475;8682.088380720186;8932;8951;8956.820863582821;7087.503874728925;7143;7184.317489838457;7200.243974382614;7226;6994.125734283215;7160.498765086394;7170.641467926687;7238.420926325986;7245.855082898418;5108.79393601254;6478.546501744832;6643.56816806906;6653.800385988235;6776.186857577122;6629;6649.069130321662;6714.3957043866285;6719.798406047827;6799.558028728117;6109.908351374822;6177.722002509808;6218.098375735402;6247.0629405589525;6258.342873998165;4548;4607.6313894889;4658.510856360169;4702.811887524597;4733.6213102951;4306.63393611534;4310.159518893911;4330.718503297276;4416.867493975057;4421.248387774151 14:06:39 INFO - PROCESS | 29911 | |4;prototype.html;290.2222044919615;297.00799330237004;299.8530719947226;303.95440683897425;307.3223542089691;4864.4162700475945;4882.877928051796;4899.853004409864;4903.16646170151;4917.4836642152595;4816.3016362627395;4818.469968303492;4830.44449888263;4838.371011768474;4844.66087373884;3624.8550057997713;3740.28934502445;3756.605556416578;3757.6993840492696;3769.681645787848;3697.5378077740284;3766.905827354324;3777.225668737916;3841.558220804601;3903.4535165076913;3796.2597293527774;3815;3823.139793546444;3823.4073718573663;3827.54069511659;3608.657177568153;3803.7637767725323;3823;3827.311084004878;3827.4641550183137;3324.3683700096904;3326.3181047885128;3334.0997930558615;3341.916452088693;3344.515045318415;4693.474620748237;4721.315409265637;4734.55021772931;4745.762711864393;4748;4153.341861208829;4274.102438487921;4276.379924910871;4313.935290970638;4321.157374312011;5034.748262586856;5038.7984480620735;5041.269015992697;5045.167547354682;5060.165072762989;3590.35373632746;3596.604373518911;3611.512445819807;3613.2231570212266;3624.821932871801;5145.485451454862;5298.231756395301;5317.388500322474;5320.813771518017;5323.813666521692;3721.2557488502407;3737.2712321097124;3741.3826718591126;3746.550413950343;3746.925061498755;3784.6783023443318;3784.981075094662;3794.582595914447;3794.6205379462385;3810.2379524094736;4172.228137794457;4302.741835489881;4314.352847072964;4316.589923957219;4339.696221264481;5048.873778155502;5055.418626857959;5079.009593129378;5080;5080.796768129308;1296.235221219485;1304.2044352944886;1306.8627794081485;1308.1104848702782;1309.86246444122;793.4485532554819;818.8034871630766;824.6187635710162;834.4200780457523;846.3863698818308;4403.559644035571;4478.484974228006;4509.729416235036;4537.455505339314;4543.68194226401;5195.740212989335;5230.607704422184;5235;5268.841934741964;5286;4542.818287268538;4549.339491085796;4561.68068235227;4562.1788078146255;4568.423893756649;2639.3797457597448;2804.6634403871667;2808.199663096008;2809.2555472799722;2814.5637426198973;4928.743170491502;4940.135476291634;4952.851414457572;4956.612148598399;4971.279164521196;5203.843884683465;5373.328333958255;5382.892342153135;5383.7846486140115;5405.621606487508;4897.289892965428;4914.705117692878;4933.260010998379;4945.109880221523;4955.231939049453;5210.296609957607;5238;5273.209018647233;5287;5290.497402746733;4998.425181104074;5050.797968081236;5127.897442051213;5171.92242116361;5176.4305926348825;4917.434495033117;4927.384076990376;4950.727709975986;4952.8761780955765;4959.876003099951;3427.5544179256535;3439.914002149966;3451.378751824696;3466.5320181775137;3473.5484387030533;4711.952880471152;4717.811287548459;4726.361941137902;4744.572988431058;4905.4358748742925;5081.593472522263;5112.642115051911;5114.360704911886;5122.487751224848;5142.305788718475;5112.769925353294;5116.641835071509;5124.487551244845;5133.101707201299;5151.613628977917;4863.911416250636;5052.8484145475695;5062.265971434195;5075.898482030265;5096.210087436453;4910.7544622768;4989.226669866177;5044.54599086084;5047.167217409086;5159.432462429055;4832.081904438145;4917.336159618549;4997.700137991732;5045.9243111352625;5053.2420136979745 14:06:39 INFO - PROCESS | 29911 | |5;yui.html;660.5640277416904;671.3353779758038;703.6938931564766;740.4261697184681;756.3419824752465;12666.176698514602;13070.215787052783;13354.66613334667;13529.526466573672;13550.593482195538;12750.10749247553;12865.228086314804;12888.355582220875;12907.419166137523;12955.09314347996;622.3993845938668;765.2309429023851;768.6656304507529;792.1603100713262;797.5055465611329;794.1581923161439;794.5907857453416;796.4942261663828;798.3333916179997;799.1648727080216;830.7715378270964;833.3957880536593;833.6665333866472;833.7123692326138;835.8620827563475;646.453746584138;785.2069409895989;814.975550733473;817.3542901108117;829.8879651247095;603.7192705392014;604.039577072457;604.4046614085123;605.0047671580226;605.0530919111576;11674.416279186007;11688.240264382874;11700.2979821211;11712.297262164297;11724.237924534878;11584.884151158465;12216.144869859114;12614.68463288416;12681.365931703378;13061.346932653425;11716.355600441972;12138.271703697807;12168.878311216864;12368.257904525757;12949.741005179938;4140.108357899761;4200.390943313202;4205.3481710334945;4238.830446782125;4336.349547567858;59008.70495647537;59530;60248.698756506376;60857;61149.694251528905;10101.393916364894;10171.7457063574;10188.949055254676;10260.589576417009;10407.53166107527;16869.578260543338;17121.486355409357;17127.14364281781;17129.14354282281;17134.571635709206;6709.228438729609;6715.160604924385;6762.526623136333;6922.619255940972;6960.477964152708;3564.697000754913;3687.041369244016;3698.6301369863336;3713.721470889694;3742.214135031619;2711.8372897626205;2838.5600231964077;2841.5879697443756;2842.0905310300504;2844.1467559731996;430.65547561950314;486.1274013146411;494.16732805222597;504.16308927180705;506.4656787089582;487.1134535146071;511;554.1410813239463;586.9148973398833;603.1254680712984;8446.662133514714;8454.746357609281;8535.231829135284;8735.781605459915;8888.64445422176;525.3354506549218;563.9238702775073;601.5127746525328;604.3623976704619;616.605372561561;4001.9599804001587;4166.520850102277;4170.873864056748;4262.680298977589;4286.764227967429;78808.21191788123;105199.4740026295;107466.46266768617;108096;114446.42776786063;69141;79507;81592;82739.5863020681;82979.58510207411;64691.99999999906;68247;72009;73076.63461682657;74251.62874185595;8141.43009989295;9181.862272066059;9290;9335.766605834908;9418.152366287068;34365.484517731755;36179;39871.60128398679;43426.34860477032;44039.33940990952;58545.70727146507;65479.345206547325;66120.66939665271;66320.66839665771;68165;11737.706557336134;11819.40902954866;11848.38372266766;12089.093318001009;12508.687282818002;12056.75886482248;12097;12211.084168687206;12582.496700131893;12584.244945303311;11723.062155027748;12267.447964841425;12741;12951.5466958656;13049.282289473791;12126.514939402325;12283;12507;12892.871071289543;12927;12225.57210497664;12544.24734515932;13238.602841914759;13388.129771564818;13417.127886687334;9748.463834488888;10164.949175254076;10195.949020254851;10354.223433242387;10495.527701253615;9673.661421850484;9826.213902887608;10344.157300570509;10461;10477.266591338534 14:06:39 INFO - PROCESS | 29911 | __end_tp_report 14:06:39 INFO - PROCESS | 29911 | __start_cc_report 14:06:39 INFO - PROCESS | 29911 | _x_x_mozilla_cycle_collect,1046 14:06:39 INFO - PROCESS | 29911 | __end_cc_report 14:06:39 INFO - PROCESS | 29911 | __startTimestamp1468357599958__endTimestamp 14:06:39 INFO - PROCESS | 29911 | 14:06:39 INFO - PROCESS | 29911 | ------- Summary: start ------- 14:06:39 INFO - PROCESS | 29911 | Number of tests: 6 14:06:39 INFO - PROCESS | 29911 | 14:06:39 INFO - PROCESS | 29911 | [#0] dojo.html Cycles:165 Average:4731.79 Median:4831.11 stddev:498.39 (10.3%) stddev-sans-first:472.77 14:06:39 INFO - PROCESS | 29911 | Values: 2663.5 2679.3 2703.0 2705.9 2715.3 4676.0 4770.0 4795.9 4875.7 4917.5 4704.1 4724.0 4748.6 4767.5 4781.1 4300.7 4345.3 4377.4 4422.8 4520.2 4460.2 4489.2 4495.8 4526.6 4540.2 4308.5 4331.2 4333.8 4355.2 4397.5 4309.1 4312.0 4317.2 4386.9 4456.0 4322.2 4328.7 4342.3 4349.0 4392.6 4705.2 4729.3 4742.4 4787.0 4788.2 5102.3 5150.7 5157.3 5158.7 5162.8 5138.0 5172.9 5183.0 5190.5 5191.7 4694.0 4773.8 4778.1 4811.7 4830.1 5289.2 5311.3 5313.0 5354.0 5372.9 5094.0 5137.1 5147.6 5151.5 5153.3 4994.7 5104.6 5162.6 5164.9 5166.4 5125.5 5134.2 5148.8 5149.2 5150.5 5063.8 5064.7 5077.5 5110.0 5165.3 4216.3 4244.4 4248.2 4276.6 4312.4 3785.2 3786.6 3826.4 3827.2 3854.4 4425.9 4434.8 4436.3 4481.1 4483.2 4954.6 4993.1 5121.7 5146.6 5209.8 4433.1 4463.0 4465.9 4491.3 4509.3 4636.7 4638.0 4642.1 4676.1 4689.9 4655.1 4723.5 4831.1 4867.1 4883.4 5053.3 5075.9 5078.1 5080.3 5132.0 4775.3 4776.1 4781.9 4782.3 4840.6 4912.1 5013.8 5033.4 5064.6 5077.8 5118.3 5155.5 5158.3 5158.8 5194.2 5021.3 5027.0 5029.9 5031.2 5080.9 4784.1 4795.8 4861.3 4940.1 5014.9 4863.4 4874.0 4885.9 4895.2 4927.3 4963.2 4984.0 4985.6 4985.9 5036.2 4798.8 4892.5 4934.6 4943.1 4954.8 14:06:39 INFO - PROCESS | 29911 | 14:06:39 INFO - PROCESS | 29911 | [#1] ext.html Cycles:180 Average:53685.80 Median:36606.41 stddev:105573.34 (288.4%) stddev-sans-first:105794.12 14:06:39 INFO - PROCESS | 29911 | Values: 548.6 573.6 575.3 582.5 594.1 27494.3 29972.9 29977.1 30038.2 30063.7 30055.5 40797.8 41299.6 41480.8 45699.3 7717.2 7829.5 7830.0 7840.8 7843.0 7552.7 7708.2 7768.3 7783.6 7795.6 7797.6 7852.9 9989.5 10314.4 10327.4 10271.0 10324.7 10332.9 10345.4 10348.6 7509.7 10133.8 10183.7 10199.9 10205.5 39097.4 39991.6 39994.6 43705.3 43714.0 2894.3 2908.2 3063.1 3089.5 3416.8 29174.6 30813.8 30893.5 31129.1 31187.4 3525.5 3596.2 3615.8 3622.9 3678.3 277790.0 278007.0 278914.0 279661.0 281815.0 56638.2 57065.4 57196.4 57274.4 57325.7 59535.0 59547.0 59639.0 59690.4 59708.0 15200.6 15783.5 15798.0 15807.7 15820.2 11153.4 11252.7 11268.9 11327.2 11377.4 15853.4 17658.2 18120.5 18610.8 18938.1 6779.3 6847.7 6905.1 7042.9 7109.6 845.8 916.0 922.7 928.1 1014.6 28501.9 29145.4 29414.9 29560.4 29650.7 919.4 973.8 977.5 1017.7 1036.5 15159.5 15345.8 15420.9 15672.5 15838.8 418452.0 464260.0 473661.0 473756.0 670474.0 52798.7 53401.5 53486.5 53518.7 53540.7 1221.0 1225.4 1239.1 1243.2 1244.0 28381.6 29196.4 29672.5 30252.5 30295.8 44017.3 44484.3 44544.3 44551.8 44645.3 368565.0 370974.0 371625.0 373046.0 375578.0 25594.1 26185.0 32439.5 33279.8 37542.6 40751.2 41102.6 43232.9 43468.3 44154.0 36579.8 36865.2 37181.4 37498.8 37512.4 36138.8 37854.2 38007.4 38055.6 38363.8 36527.6 36633.0 36740.4 37457.0 37666.2 32258.5 32354.5 33393.5 33410.8 33546.8 25481.7 25763.6 25961.4 26246.3 26446.3 14:06:39 INFO - PROCESS | 29911 | 14:06:39 INFO - PROCESS | 29911 | [#2] jquery.html Cycles:180 Average:24427.89 Median:4560.16 stddev:64620.33 (1417.1%) stddev-sans-first:64776.35 14:06:39 INFO - PROCESS | 29911 | Values: 365.8 373.1 375.5 378.1 389.0 16553.3 17750.1 18124.6 18154.9 18161.7 11600.3 16093.7 17039.5 17073.1 17539.1 4702.6 4853.1 4897.9 4899.0 4899.9 3495.6 3625.1 4754.3 5313.1 5589.4 5648.6 5665.3 5685.0 5687.6 5692.9 5529.4 5542.9 5647.1 5648.7 5661.7 3377.8 5056.5 5383.4 5393.6 5504.8 12824.0 12877.7 12957.9 15425.8 21526.0 1833.2 1875.2 1885.9 2141.1 2509.9 8798.0 9047.3 9398.8 9904.1 10571.5 1632.9 1648.5 1729.8 1817.7 1828.1 70250.3 70858.6 70877.6 71209.3 71905.6 10221.6 10232.4 10364.7 10368.2 10553.2 14182.6 14198.1 14240.1 14260.1 14329.4 7215.4 7337.9 7400.8 7419.7 7455.7 6771.6 7023.8 7135.6 7155.9 7211.8 4394.3 4496.8 4543.9 4576.4 4580.1 1606.4 1765.6 1842.4 1870.0 1954.7 809.9 839.4 841.0 905.6 908.1 16986.9 17088.7 17268.0 17755.4 17978.5 865.1 866.9 878.1 888.6 904.8 9542.7 9906.3 9919.3 9919.9 10077.6 384016.0 387476.0 393163.2 393466.0 393966.0 76657.2 79311.0 79882.2 79906.0 80673.0 886.9 894.8 899.8 902.0 916.9 15260.2 15447.8 15483.1 15507.7 15871.7 38589.6 38622.0 39483.8 39522.8 39831.6 52283.5 52772.5 53082.2 54793.0 55532.7 7772.5 7846.7 7878.6 7912.9 7997.7 10762.5 11258.7 11818.3 12049.6 12074.5 10201.8 10429.5 10435.5 10442.4 10517.4 10101.3 10148.1 10181.4 10195.1 10212.5 9521.6 9944.3 10003.3 10567.8 10611.0 7506.7 7723.3 7788.1 7806.0 7933.1 7623.0 8682.8 9501.9 9566.2 9580.2 14:06:39 INFO - PROCESS | 29911 | 14:06:39 INFO - PROCESS | 29911 | [#3] mootools.html Cycles:180 Average:5004.67 Median:5225.96 stddev:2764.57 (52.9%) stddev-sans-first:2758.14 14:06:39 INFO - PROCESS | 29911 | Values: 1277.2 1363.8 1371.0 1674.6 1702.7 7189.5 7570.4 7667.4 7674.7 7675.5 6304.1 7132.1 7377.6 7386.6 7532.3 2150.0 2175.3 2179.7 2181.8 2184.3 1884.5 2179.0 2180.2 2205.2 2215.7 1991.3 2084.5 2086.3 2097.2 2098.3 2193.1 2197.5 2204.7 2222.9 2226.8 2177.4 2178.0 2183.2 2184.6 2191.7 7551.8 7672.6 7679.6 7685.3 7693.5 4496.0 4621.0 4621.7 4628.6 4629.2 2774.2 2863.0 2900.9 2918.6 2927.2 830.9 831.6 851.6 852.3 852.8 10191.0 10218.8 10244.6 10250.4 10251.2 4035.0 4206.9 4236.3 4303.3 4308.9 8716.3 8769.6 8780.6 8783.0 8794.4 4525.7 4529.2 4530.7 4536.5 4539.8 4048.0 4136.6 4140.6 4142.3 4145.3 3568.2 3588.1 3620.6 3656.6 3723.5 1019.4 1087.3 1141.1 1181.9 1184.2 687.3 717.1 735.8 799.6 818.6 4912.6 5020.5 5023.8 5070.8 5136.6 811.3 819.7 823.3 824.7 830.9 3329.2 3429.1 3440.6 3443.7 3479.8 9043.3 9289.4 9421.2 9437.3 9449.7 7900.7 8189.0 9310.4 9321.6 9341.5 6754.2 6943.1 7018.2 7048.2 7079.1 5315.3 5379.4 5395.5 5490.1 5547.8 8503.0 8527.5 8657.7 8765.5 8772.1 8621.3 8682.1 8932.0 8951.0 8956.8 7087.5 7143.0 7184.3 7200.2 7226.0 6994.1 7160.5 7170.6 7238.4 7245.9 5108.8 6478.5 6643.6 6653.8 6776.2 6629.0 6649.1 6714.4 6719.8 6799.6 6109.9 6177.7 6218.1 6247.1 6258.3 4548.0 4607.6 4658.5 4702.8 4733.6 4306.6 4310.2 4330.7 4416.9 4421.2 14:06:39 INFO - PROCESS | 29911 | 14:06:39 INFO - PROCESS | 29911 | [#4] prototype.html Cycles:180 Average:4208.83 Median:4824.46 stddev:1226.37 (25.4%) stddev-sans-first:1194.03 14:06:39 INFO - PROCESS | 29911 | Values: 290.2 297.0 299.9 304.0 307.3 4864.4 4882.9 4899.9 4903.2 4917.5 4816.3 4818.5 4830.4 4838.4 4844.7 3624.9 3740.3 3756.6 3757.7 3769.7 3697.5 3766.9 3777.2 3841.6 3903.5 3796.3 3815.0 3823.1 3823.4 3827.5 3608.7 3803.8 3823.0 3827.3 3827.5 3324.4 3326.3 3334.1 3341.9 3344.5 4693.5 4721.3 4734.6 4745.8 4748.0 4153.3 4274.1 4276.4 4313.9 4321.2 5034.7 5038.8 5041.3 5045.2 5060.2 3590.4 3596.6 3611.5 3613.2 3624.8 5145.5 5298.2 5317.4 5320.8 5323.8 3721.3 3737.3 3741.4 3746.6 3746.9 3784.7 3785.0 3794.6 3794.6 3810.2 4172.2 4302.7 4314.4 4316.6 4339.7 5048.9 5055.4 5079.0 5080.0 5080.8 1296.2 1304.2 1306.9 1308.1 1309.9 793.4 818.8 824.6 834.4 846.4 4403.6 4478.5 4509.7 4537.5 4543.7 5195.7 5230.6 5235.0 5268.8 5286.0 4542.8 4549.3 4561.7 4562.2 4568.4 2639.4 2804.7 2808.2 2809.3 2814.6 4928.7 4940.1 4952.9 4956.6 4971.3 5203.8 5373.3 5382.9 5383.8 5405.6 4897.3 4914.7 4933.3 4945.1 4955.2 5210.3 5238.0 5273.2 5287.0 5290.5 4998.4 5050.8 5127.9 5171.9 5176.4 4917.4 4927.4 4950.7 4952.9 4959.9 3427.6 3439.9 3451.4 3466.5 3473.5 4712.0 4717.8 4726.4 4744.6 4905.4 5081.6 5112.6 5114.4 5122.5 5142.3 5112.8 5116.6 5124.5 5133.1 5151.6 4863.9 5052.8 5062.3 5075.9 5096.2 4910.8 4989.2 5044.5 5047.2 5159.4 4832.1 4917.3 4997.7 5045.9 5053.2 14:06:39 INFO - PROCESS | 29911 | 14:06:39 INFO - PROCESS | 29911 | [#5] yui.html Cycles:180 Average:17642.11 Median:4250.76 stddev:25152.42 (591.7%) stddev-sans-first:25190.66 14:06:39 INFO - PROCESS | 29911 | Values: 660.6 671.3 703.7 740.4 756.3 12666.2 13070.2 13354.7 13529.5 13550.6 12750.1 12865.2 12888.4 12907.4 12955.1 622.4 765.2 768.7 792.2 797.5 794.2 794.6 796.5 798.3 799.2 830.8 833.4 833.7 833.7 835.9 646.5 785.2 815.0 817.4 829.9 603.7 604.0 604.4 605.0 605.1 11674.4 11688.2 11700.3 11712.3 11724.2 11584.9 12216.1 12614.7 12681.4 13061.3 11716.4 12138.3 12168.9 12368.3 12949.7 4140.1 4200.4 4205.3 4238.8 4336.3 59008.7 59530.0 60248.7 60857.0 61149.7 10101.4 10171.7 10188.9 10260.6 10407.5 16869.6 17121.5 17127.1 17129.1 17134.6 6709.2 6715.2 6762.5 6922.6 6960.5 3564.7 3687.0 3698.6 3713.7 3742.2 2711.8 2838.6 2841.6 2842.1 2844.1 430.7 486.1 494.2 504.2 506.5 487.1 511.0 554.1 586.9 603.1 8446.7 8454.7 8535.2 8735.8 8888.6 525.3 563.9 601.5 604.4 616.6 4002.0 4166.5 4170.9 4262.7 4286.8 78808.2 105199.5 107466.5 108096.0 114446.4 69141.0 79507.0 81592.0 82739.6 82979.6 64692.0 68247.0 72009.0 73076.6 74251.6 8141.4 9181.9 9290.0 9335.8 9418.2 34365.5 36179.0 39871.6 43426.3 44039.3 58545.7 65479.3 66120.7 66320.7 68165.0 11737.7 11819.4 11848.4 12089.1 12508.7 12056.8 12097.0 12211.1 12582.5 12584.2 11723.1 12267.4 12741.0 12951.5 13049.3 12126.5 12283.0 12507.0 12892.9 12927.0 12225.6 12544.2 13238.6 13388.1 13417.1 9748.5 10164.9 10195.9 10354.2 10495.5 9673.7 9826.2 10344.2 10461.0 10477.3 14:06:39 INFO - PROCESS | 29911 | -------- Summary: end -------- 14:06:39 INFO - PROCESS | 29911 | 14:06:40 INFO - TEST-INFO | 29911: exit 0 14:06:40 INFO - TEST-OK | dromaeo_css | took 1120293ms 14:06:40 INFO - TEST-START | kraken 14:06:40 INFO - operating with platform_type : linux_ 14:06:40 INFO - Initialising browser for kraken test... 14:06:40 INFO - TEST-INFO | started process 30101 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnM5Kl9/profile http://localhost:33925/getInfo.html) 14:06:45 INFO - PROCESS | 30101 | __metrics Screen width/height:1600/1200 14:06:45 INFO - PROCESS | 30101 | colorDepth:24 14:06:45 INFO - PROCESS | 30101 | Browser inner width/height: 1024/697 14:06:45 INFO - PROCESS | 30101 | __metrics 14:06:45 INFO - PROCESS | 30101 | 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" 14:06:45 INFO - PROCESS | 30101 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:06:46 INFO - TEST-INFO | 30101: exit 0 14:06:46 INFO - Browser initialized. 14:06:46 INFO - Running cycle 1/1 for kraken test... 14:06:46 INFO - TEST-INFO | started process 30181 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnM5Kl9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:06:58 INFO - PROCESS | 30181 | RSS: Main: 158982144 14:06:58 INFO - PROCESS | 30181 | 14:07:01 INFO - PROCESS | 30181 | Cycle 1(1): loaded http://localhost:33925/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33925/tests/kraken/driver.html?testName=audio-beat-detection) 14:07:02 INFO - PROCESS | 30181 | RSS: Main: 217034752 14:07:02 INFO - PROCESS | 30181 | 14:07:05 INFO - PROCESS | 30181 | Cycle 1(1): loaded http://localhost:33925/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33925/tests/kraken/driver.html?testName=audio-dft) 14:07:05 INFO - PROCESS | 30181 | RSS: Main: 203612160 14:07:05 INFO - PROCESS | 30181 | 14:07:09 INFO - PROCESS | 30181 | Cycle 1(1): loaded http://localhost:33925/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33925/tests/kraken/driver.html?testName=audio-fft) 14:07:09 INFO - PROCESS | 30181 | RSS: Main: 270757888 14:07:09 INFO - PROCESS | 30181 | 14:07:11 INFO - PROCESS | 30181 | Cycle 1(1): loaded http://localhost:33925/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33925/tests/kraken/driver.html?testName=audio-oscillator) 14:07:12 INFO - PROCESS | 30181 | RSS: Main: 181256192 14:07:12 INFO - PROCESS | 30181 | 14:07:14 INFO - PROCESS | 30181 | Cycle 1(1): loaded http://localhost:33925/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33925/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:07:15 INFO - PROCESS | 30181 | RSS: Main: 186044416 14:07:15 INFO - PROCESS | 30181 | 14:07:18 INFO - PROCESS | 30181 | Cycle 1(1): loaded http://localhost:33925/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33925/tests/kraken/driver.html?testName=imaging-darkroom) 14:07:19 INFO - PROCESS | 30181 | RSS: Main: 221790208 14:07:19 INFO - PROCESS | 30181 | 14:07:22 INFO - PROCESS | 30181 | Cycle 1(1): loaded http://localhost:33925/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33925/tests/kraken/driver.html?testName=imaging-desaturate) 14:07:23 INFO - PROCESS | 30181 | RSS: Main: 222334976 14:07:23 INFO - PROCESS | 30181 | 14:07:26 INFO - PROCESS | 30181 | Cycle 1(1): loaded http://localhost:33925/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33925/tests/kraken/driver.html?testName=json-parse-financial) 14:07:26 INFO - PROCESS | 30181 | RSS: Main: 223059968 14:07:26 INFO - PROCESS | 30181 | 14:07:28 INFO - PROCESS | 30181 | Cycle 1(1): loaded http://localhost:33925/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33925/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:07:28 INFO - PROCESS | 30181 | RSS: Main: 208162816 14:07:28 INFO - PROCESS | 30181 | 14:07:30 INFO - PROCESS | 30181 | Cycle 1(1): loaded http://localhost:33925/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33925/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:07:31 INFO - PROCESS | 30181 | RSS: Main: 211800064 14:07:31 INFO - PROCESS | 30181 | 14:07:33 INFO - PROCESS | 30181 | Cycle 1(1): loaded http://localhost:33925/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33925/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:07:34 INFO - PROCESS | 30181 | RSS: Main: 213020672 14:07:34 INFO - PROCESS | 30181 | 14:07:37 INFO - PROCESS | 30181 | Cycle 1(1): loaded http://localhost:33925/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33925/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:07:37 INFO - PROCESS | 30181 | RSS: Main: 225222656 14:07:37 INFO - PROCESS | 30181 | 14:07:40 INFO - PROCESS | 30181 | Cycle 1(1): loaded http://localhost:33925/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33925/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:07:41 INFO - PROCESS | 30181 | RSS: Main: 225714176 14:07:41 INFO - PROCESS | 30181 | 14:07:43 INFO - PROCESS | 30181 | Cycle 1(1): loaded http://localhost:33925/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33925/tests/kraken/driver.html?testName=ai-astar) 14:07:43 INFO - PROCESS | 30181 | RSS: Main: 267796480 14:07:43 INFO - PROCESS | 30181 | 14:07:43 INFO - PROCESS | 30181 | __start_tp_report 14:07:43 INFO - PROCESS | 30181 | _x_x_mozilla_page_load 14:07:43 INFO - PROCESS | 30181 | _x_x_mozilla_page_load_details 14:07:43 INFO - PROCESS | 30181 | |i|pagename|runs| 14:07:43 INFO - PROCESS | 30181 | |0;ai-astar;105;117;114;113;115;115;113;115;113;116 14:07:43 INFO - PROCESS | 30181 | |1;audio-beat-detection;154;128;129;189;125;147;148;132;185;124 14:07:43 INFO - PROCESS | 30181 | |2;audio-dft;162;161;160;160;161;163;161;164;161;162 14:07:43 INFO - PROCESS | 30181 | |3;audio-fft;75;75;76;117;77;76;74;75;106;75 14:07:43 INFO - PROCESS | 30181 | |4;audio-oscillator;85;86;120;85;86;86;121;84;84;128 14:07:43 INFO - PROCESS | 30181 | |5;imaging-gaussian-blur;116;116;117;116;116;116;117;116;117;116 14:07:43 INFO - PROCESS | 30181 | |6;imaging-darkroom;146;146;146;147;147;146;147;146;147;146 14:07:43 INFO - PROCESS | 30181 | |7;imaging-desaturate;94;95;95;95;95;95;95;95;95;94 14:07:43 INFO - PROCESS | 30181 | |8;json-parse-financial;64;64;63;63;63;63;62;64;63;62 14:07:43 INFO - PROCESS | 30181 | |9;json-stringify-tinderbox;64;65;64;65;64;64;64;66;65;64 14:07:43 INFO - PROCESS | 30181 | |10;stanford-crypto-aes;80;79;79;88;79;79;78;78;89;83 14:07:43 INFO - PROCESS | 30181 | |11;stanford-crypto-ccm;130;131;137;127;129;135;129;128;171;136 14:07:43 INFO - PROCESS | 30181 | |12;stanford-crypto-pbkdf2;166;174;171;173;170;169;170;173;170;170 14:07:43 INFO - PROCESS | 30181 | |13;stanford-crypto-sha256-iterative;69;69;70;67;67;66;67;66;66;65 14:07:43 INFO - PROCESS | 30181 | __end_tp_report 14:07:43 INFO - PROCESS | 30181 | __start_cc_report 14:07:43 INFO - PROCESS | 30181 | _x_x_mozilla_cycle_collect,1956 14:07:43 INFO - PROCESS | 30181 | __end_cc_report 14:07:43 INFO - PROCESS | 30181 | __startTimestamp1468357663252__endTimestamp 14:07:43 INFO - PROCESS | 30181 | 14:07:43 INFO - PROCESS | 30181 | ------- Summary: start ------- 14:07:43 INFO - PROCESS | 30181 | Number of tests: 14 14:07:43 INFO - PROCESS | 30181 | 14:07:43 INFO - PROCESS | 30181 | [#0] ai-astar Cycles:10 Average:113.60 Median:115.00 stddev:3.31 (2.9%) stddev-sans-first:1.42 14:07:43 INFO - PROCESS | 30181 | Values: 105.0 117.0 114.0 113.0 115.0 115.0 113.0 115.0 113.0 116.0 14:07:43 INFO - PROCESS | 30181 | 14:07:43 INFO - PROCESS | 30181 | [#1] audio-beat-detection Cycles:10 Average:146.10 Median:147.50 stddev:23.97 (16.3%) stddev-sans-first:25.26 14:07:43 INFO - PROCESS | 30181 | Values: 154.0 128.0 129.0 189.0 125.0 147.0 148.0 132.0 185.0 124.0 14:07:43 INFO - PROCESS | 30181 | 14:07:43 INFO - PROCESS | 30181 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:1.27 (0.8%) stddev-sans-first:1.33 14:07:43 INFO - PROCESS | 30181 | Values: 162.0 161.0 160.0 160.0 161.0 163.0 161.0 164.0 161.0 162.0 14:07:43 INFO - PROCESS | 30181 | 14:07:43 INFO - PROCESS | 30181 | [#3] audio-fft Cycles:10 Average:82.60 Median:75.00 stddev:15.47 (20.6%) stddev-sans-first:16.16 14:07:43 INFO - PROCESS | 30181 | Values: 75.0 75.0 76.0 117.0 77.0 76.0 74.0 75.0 106.0 75.0 14:07:43 INFO - PROCESS | 30181 | 14:07:43 INFO - PROCESS | 30181 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:85.00 stddev:18.42 (21.7%) stddev-sans-first:19.06 14:07:43 INFO - PROCESS | 30181 | Values: 85.0 86.0 120.0 85.0 86.0 86.0 121.0 84.0 84.0 128.0 14:07:43 INFO - PROCESS | 30181 | 14:07:43 INFO - PROCESS | 30181 | [#5] imaging-gaussian-blur Cycles:10 Average:116.30 Median:116.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 14:07:43 INFO - PROCESS | 30181 | Values: 116.0 116.0 117.0 116.0 116.0 116.0 117.0 116.0 117.0 116.0 14:07:43 INFO - PROCESS | 30181 | 14:07:43 INFO - PROCESS | 30181 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 14:07:43 INFO - PROCESS | 30181 | Values: 146.0 146.0 146.0 147.0 147.0 146.0 147.0 146.0 147.0 146.0 14:07:43 INFO - PROCESS | 30181 | 14:07:43 INFO - PROCESS | 30181 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 14:07:43 INFO - PROCESS | 30181 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 14:07:43 INFO - PROCESS | 30181 | 14:07:43 INFO - PROCESS | 30181 | [#8] json-parse-financial Cycles:10 Average:63.10 Median:63.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 14:07:43 INFO - PROCESS | 30181 | Values: 64.0 64.0 63.0 63.0 63.0 63.0 62.0 64.0 63.0 62.0 14:07:43 INFO - PROCESS | 30181 | 14:07:43 INFO - PROCESS | 30181 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:64.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 14:07:43 INFO - PROCESS | 30181 | Values: 64.0 65.0 64.0 65.0 64.0 64.0 64.0 66.0 65.0 64.0 14:07:43 INFO - PROCESS | 30181 | 14:07:43 INFO - PROCESS | 30181 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:79.50 stddev:4.10 (5.2%) stddev-sans-first:4.33 14:07:43 INFO - PROCESS | 30181 | Values: 80.0 79.0 79.0 88.0 79.0 79.0 78.0 78.0 89.0 83.0 14:07:43 INFO - PROCESS | 30181 | 14:07:43 INFO - PROCESS | 30181 | [#11] stanford-crypto-ccm Cycles:10 Average:135.30 Median:133.00 stddev:13.02 (9.8%) stddev-sans-first:13.67 14:07:43 INFO - PROCESS | 30181 | Values: 130.0 131.0 137.0 127.0 129.0 135.0 129.0 128.0 171.0 136.0 14:07:43 INFO - PROCESS | 30181 | 14:07:43 INFO - PROCESS | 30181 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.60 Median:170.50 stddev:2.32 (1.4%) stddev-sans-first:1.76 14:07:43 INFO - PROCESS | 30181 | Values: 166.0 174.0 171.0 173.0 170.0 169.0 170.0 173.0 170.0 170.0 14:07:43 INFO - PROCESS | 30181 | 14:07:43 INFO - PROCESS | 30181 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:1.62 (2.4%) stddev-sans-first:1.58 14:07:43 INFO - PROCESS | 30181 | Values: 69.0 69.0 70.0 67.0 67.0 66.0 67.0 66.0 66.0 65.0 14:07:43 INFO - PROCESS | 30181 | -------- Summary: end -------- 14:07:43 INFO - PROCESS | 30181 | 14:07:44 INFO - TEST-INFO | 30181: exit 0 14:07:44 INFO - TEST-OK | kraken | took 63597ms 14:07:44 INFO - SUITE-END | took 1183s 14:07:44 INFO - Completed test suite (00:19:44) 14:07:44 INFO - javascript benchmark 14:07:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2663.533881570725, 2679.3301674581353, 2703.0, 2705.864706764661, 2715.253305341032, 4676.0, 4770.045990801845, 4795.856124316268, 4875.707457552545, 4917.532834380732, 4704.082703872747, 4724.0, 4748.596369308613, 4767.47557768646, 4781.0676918001, 4300.6989510734265, 4345.3047512398025, 4377.430933978579, 4422.823087076513, 4520.186366454037, 4460.1525710114975, 4489.1695036418205, 4495.797689103982, 4526.569975852289, 4540.160070386973, 4308.504521979981, 4331.242032644274, 4333.761643109628, 4355.237833379178, 4397.494288156871, 4309.116631090619, 4312.029793296515, 4317.201317756225, 4386.868393948154, 4455.977720111378, 4322.178786030676, 4328.740275583444, 4342.261815491374, 4349.0, 4392.648588112976, 4705.200115980258, 4729.290606409032, 4742.359781429497, 4787.042591481682, 4788.162071637485, 5102.260172275037, 5150.742462876879, 5157.329547158883, 5158.690478571298, 5162.819301324435, 5138.0, 5172.896542069175, 5183.041137389558, 5190.4550022247495, 5191.662541934762, 4694.0, 4773.832915847928, 4778.116048531033, 4811.663183577186, 4830.082284365959, 5289.2330612061805, 5311.336082989626, 5312.990531799023, 5354.0, 5372.946270537323, 5093.9745301274, 5137.12668846297, 5147.639665223398, 5151.459096794858, 5153.252778347193, 4994.650374473825, 5104.566111880457, 5162.586993040548, 5164.948350516522, 5166.43169251382, 5125.538701516882, 5134.2298655201275, 5148.845534633892, 5149.150390185652, 5150.459201783834, 5063.772130254148, 5064.670796398296, 5077.543021128116, 5110.029094472038, 5165.276861239429, 4216.262154123016, 4244.427002354642, 4248.235317642854, 4276.615104640598, 4312.439382880269, 3785.167263202091, 3786.5645450772963, 3826.426036094608, 3827.1962887793875, 3854.383298672199, 4425.933610995838, 4434.800433980478, 4436.290193569013, 4481.081378317437, 4483.21543729846, 4954.628402869799, 4993.1262029144755, 5121.667091639031, 5146.588272938231, 5209.817656382009, 4433.069055498317, 4463.0, 4465.910681786346, 4491.326301054803, 4509.323601459741, 4636.652251081115, 4638.0, 4642.141203877293, 4676.111538807683, 4689.929651055237, 4655.06898620284, 4723.480417154042, 4831.106245344622, 4867.099586576494, 4883.438404583376, 5053.292539044463, 5075.898482030265, 5078.085944529872, 5080.288759573737, 5131.974340128425, 4775.283707443911, 4776.09254241693, 4781.928271075867, 4782.282657601388, 4840.564349208588, 4912.091263116335, 5013.799448022184, 5033.446320904624, 5064.645474816874, 5077.822276220315, 5118.283440318432, 5155.458676838878, 5158.329417175743, 5158.793648254028, 5194.194899790538, 5021.347224860745, 5026.994601079872, 5029.924551131663, 5031.245313203049, 5080.898382032265, 4784.067106914118, 4795.808167673254, 4861.270809378621, 4940.061388336205, 5014.874628134326, 4863.416390033219, 4874.0, 4885.877853053702, 4895.241237608177, 4927.28554359623, 4963.181075122564, 4984.0, 4985.6011519077665, 4985.875353116201, 5036.169032109661, 4798.808047678054, 4892.461829198714, 4934.5805606523845, 4943.134951383421, 4954.752262386794], "value": 4700.10174735308, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.6403062860074, 573.6443405088845, 575.2550447170911, 582.4524946550246, 594.111802854732, 27494.31264218393, 29972.85013574929, 29977.1006869794, 30038.249043773918, 30063.69936300639, 30055.549166762463, 40797.79601101998, 41299.58700412995, 41480.792596037056, 45699.31451028229, 7717.151113377524, 7829.451938364316, 7830.0, 7840.803979900491, 7842.960785196066, 7552.735654252102, 7708.229177082275, 7768.262015108584, 7783.571903545303, 7795.6491957861745, 7797.57113358765, 7852.882206766903, 9989.500524973759, 10314.432706201156, 10327.380357178556, 10271.0, 10324.690259292232, 10332.896671033268, 10345.379277243313, 10348.637797677084, 7509.737159199456, 10133.847992280049, 10183.7454063649, 10199.949000255025, 10205.489725513695, 39097.41353879694, 39991.60008399937, 39994.60005399938, 43705.34441983341, 43714.0, 2894.2619631993707, 2908.1857080017417, 3063.127008802503, 3089.474789285827, 3416.8120753358558, 29174.562381564294, 30813.845930770425, 30893.53659695084, 31129.066128016195, 31187.376252474824, 3525.5240542526685, 3596.2088340565033, 3615.8011309377976, 3622.9275414491826, 3678.282734866702, 277790.0, 278007.0, 278914.0, 279661.0, 281815.0, 56638.15042774362, 57065.42934570684, 57196.428035719946, 57274.42725572774, 57325.713371432874, 59535.0, 59547.0, 59639.0, 59690.403095969355, 59708.0, 15200.619984500256, 15783.526494205193, 15798.0, 15807.68384632324, 15820.208989550476, 11153.386563739072, 11252.718682032852, 11268.887311126784, 11327.150463715254, 11377.431128443544, 15853.365865365256, 17658.205380757896, 18120.456386308433, 18610.81389186118, 18938.14778334978, 6779.322067793181, 6847.657617119125, 6905.136857892763, 7042.873140297528, 7109.649166658319, 845.8477474054606, 916.0381599320687, 922.7370199493113, 928.0811996123924, 1014.6398028699853, 28501.857490712828, 29145.417091658474, 29414.852925735235, 29560.408791824473, 29650.703492965225, 919.4115765909823, 973.7906350134614, 977.5014742481386, 1017.7201269650757, 1036.5180191211123, 15159.545213643609, 15345.846541534665, 15420.922895385676, 15672.529824105295, 15838.841611583737, 418452.0, 464260.0, 473661.0, 473756.0, 670474.0, 52798.73600631972, 53401.46598534042, 53486.465135348924, 53518.73240633772, 53540.73229633827, 1220.9633710988685, 1225.4301749686438, 1239.1202246404973, 1243.2167734327315, 1244.004796163066, 28381.574276386284, 29196.416071678872, 29672.477839383893, 30252.54621180728, 30295.848520757256, 44017.339739903284, 44484.33273500965, 44544.33183502315, 44551.77724111359, 44645.33032004457, 368565.0, 370974.0, 371625.0, 373046.0, 375578.0, 25594.104206352687, 26185.0, 32439.513407299382, 33279.833600831844, 37542.624573755005, 40751.1849763009, 41102.58897410987, 43232.85554377826, 43468.34797477977, 44154.0, 36579.817100914326, 36865.156742162246, 37181.442278365306, 37498.8125059373, 37512.43731344087, 36138.819305904355, 37854.242915142095, 38007.42988855114, 38055.61944380632, 38363.80818095891, 36527.634723653486, 36633.0, 36740.44889326609, 37457.0, 37666.24667506689, 32258.516122258654, 32354.514682280256, 33393.499097514046, 33410.83294583609, 33546.832265838515, 25481.745182547937, 25763.613545796452, 25961.35096622524, 26246.343841403355, 26446.338841529116], "value": 18517.31345121355, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.7823594960999, 373.1212993400542, 375.517460063818, 378.10766590845617, 388.9805509724515, 16553.33786648534, 17750.112494375277, 18124.637507249863, 18154.909225453855, 18161.7275740864, 11600.3039817611, 16093.678126437464, 17039.488815335528, 17073.146342682878, 17539.145007586045, 4702.576768090863, 4853.102176097415, 4897.926531102036, 4899.044686286175, 4899.853004409855, 3495.563054618173, 3625.148090198801, 4754.263089221176, 5313.123334649778, 5589.413111623262, 5648.632838865481, 5665.348484924225, 5685.0, 5687.573431992597, 5692.943070569283, 5529.419410961851, 5542.91685624716, 5647.068233741469, 5648.74580643872, 5661.716914154296, 3377.7804442711144, 5056.544910958031, 5383.407825139231, 5393.5954803389905, 5504.834854954358, 12824.0, 12877.67805804853, 12957.935210323982, 15425.845741542553, 21526.0, 1833.1567478959694, 1875.2499000399812, 1885.9245630174776, 2141.0793358855685, 2509.924702258935, 8798.0, 9047.276217902618, 9398.765030874214, 9904.108630223242, 10571.524281407355, 1632.9183540822912, 1648.4889684197938, 1729.7578339032546, 1817.7273408988626, 1828.076821205296, 70250.29749702489, 70858.64570677113, 70877.64561177212, 71209.28790712079, 71905.6404717973, 10221.642242521477, 10232.437215953194, 10364.740881478023, 10368.170546356274, 10553.153198190286, 14182.574522764333, 14198.148111113367, 14240.14559126435, 14260.144391336553, 14329.426822926966, 7215.422766178693, 7337.926620733831, 7400.777976660601, 7419.703211871465, 7455.7017719290625, 6771.627560484122, 7023.770840102961, 7135.607541585159, 7155.92844071563, 7211.819704507429, 4394.252976993918, 4496.752678602708, 4543.886402839889, 4576.427946506687, 4580.129775342674, 1606.4056299169383, 1765.5762616971833, 1842.3828017614248, 1869.9626007479774, 1954.6774782160785, 809.9230573095547, 839.4207996482407, 840.970566030186, 905.5924833824805, 908.1281969309537, 16986.915065424593, 17088.724537950333, 17268.0, 17755.378561750276, 17978.460646180636, 865.1305438034735, 866.8873046503915, 878.1493152526218, 888.5912480259153, 904.8371293167293, 9542.713718588453, 9906.306558540833, 9919.305648604673, 9919.851202231972, 10077.647282345082, 384016.0, 387476.0, 393163.2051038473, 393466.0, 393966.0, 76657.23342766613, 79311.0, 79882.20117798864, 79906.0, 80673.0, 886.9157430044136, 894.8120894612074, 899.7930475990559, 901.9549022548978, 916.9083091690911, 15260.160691162093, 15447.768283475982, 15483.148426836633, 15507.689846203239, 15871.698603702629, 38589.6141038586, 38622.0, 39483.802580986914, 39522.80238598789, 39831.601683982786, 52283.477165229386, 52772.472275276756, 53082.20376694275, 54793.0, 55532.72233638806, 7772.533647981139, 7846.725364612211, 7878.645460954385, 7912.920870791449, 7997.720079797179, 10762.46187690628, 11258.66224013281, 11818.271996825644, 12049.638510844688, 12074.45664945062, 10201.795964080826, 10429.53067111997, 10435.530401132119, 10442.425666588108, 10517.422386642065, 10101.292909496558, 10148.137408320375, 10181.389116653025, 10195.082442580204, 10212.540435680263, 9521.619135234512, 9944.254180936314, 10003.29976901639, 10567.841482377924, 10611.0, 7506.662200200894, 7723.343515800995, 7788.104367997526, 7805.960970195113, 7933.087694914928, 7622.970898928574, 8682.78293042679, 9501.904980950378, 9566.234701224024, 9580.233581313618], "value": 8167.121676786004, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1277.169839604257, 1363.761341765191, 1370.9862901370984, 1674.6399524102314, 1702.736075908233, 7189.532680375778, 7570.432217583676, 7667.3866090712745, 7674.6546405411755, 7675.539467631939, 6304.054391841226, 7132.108486439195, 7377.631118444083, 7386.593737344444, 7532.284432978872, 2149.9892500537476, 2175.2930297653324, 2179.6730490426403, 2181.8363622728357, 2184.322859913432, 1884.510027392874, 2178.967315490269, 2180.1824315881545, 2205.184081889703, 2215.711957445538, 1991.312997016027, 2084.5205602711385, 2086.2698055680544, 2097.2345094040643, 2098.2865825619288, 2193.078906859123, 2197.52753158071, 2204.691343211952, 2222.866628002325, 2226.755056943735, 2177.433867194525, 2177.9782202177935, 2183.170395249811, 2184.584928863511, 2191.747948985855, 7551.848963020764, 7672.578008209546, 7679.6160191990175, 7685.308322250969, 7693.5383876967, 4496.033352829125, 4621.029583787408, 4621.69958952667, 4628.560286772751, 4629.1898917689605, 2774.209350335165, 2862.9856850715614, 2900.8694608742658, 2918.5622156676454, 2927.151126173407, 830.9335253179731, 831.6340810043562, 851.5997481183833, 852.3436953545797, 852.8166444214462, 10191.031851974125, 10218.846717299246, 10244.64143754965, 10250.436226007567, 10251.231157663206, 4034.9798251008556, 4206.8527601534415, 4236.2586547354085, 4303.311470164758, 4308.9353659695125, 8716.346274029473, 8769.649214031495, 8780.560971951505, 8782.956085219661, 8794.38439309255, 4525.728456292633, 4529.162105010583, 4530.728156310566, 4536.523665015192, 4539.818407263672, 4048.0487085534874, 4136.627703506699, 4140.565240649748, 4142.2958097123565, 4145.316022856195, 3568.1614820517157, 3588.138846676779, 3620.565532136108, 3656.5794933582447, 3723.5345581802276, 1019.4087429290994, 1087.3367245979946, 1141.0814294493014, 1181.911356648255, 1184.236167671864, 687.2611942162196, 717.0928775099503, 735.8197241675824, 799.5992083372681, 818.6357071103421, 4912.557869791736, 5020.513660063646, 5023.79904803811, 5070.771815268322, 5136.614753893473, 811.2658044469764, 819.6516480495885, 823.2549542663899, 824.7360844529812, 830.9335253179731, 3329.1510664780326, 3429.1427143214196, 3440.6043305019743, 3443.707284880763, 3479.808610526445, 9043.276537876955, 9289.442633442015, 9421.199198068103, 9437.339386243035, 9449.66926157595, 7900.683972641145, 8189.0, 9310.441373517611, 9321.580528876217, 9341.486218258062, 6754.155730533684, 6943.097397338414, 7018.192907815666, 7048.154221493351, 7079.079719636415, 5315.3090098286975, 5379.381371142213, 5395.514403703529, 5490.0941344677685, 5547.750351234285, 8502.957485212783, 8527.53098579584, 8657.653693852428, 8765.474071555727, 8772.078931712078, 8621.267192288475, 8682.088380720186, 8932.0, 8951.0, 8956.820863582821, 7087.503874728925, 7143.0, 7184.317489838457, 7200.243974382614, 7226.0, 6994.125734283215, 7160.498765086394, 7170.641467926687, 7238.420926325986, 7245.855082898418, 5108.79393601254, 6478.546501744832, 6643.56816806906, 6653.800385988235, 6776.186857577122, 6629.0, 6649.069130321662, 6714.3957043866285, 6719.798406047827, 6799.558028728117, 6109.908351374822, 6177.722002509808, 6218.098375735402, 6247.0629405589525, 6258.342873998165, 4548.0, 4607.6313894889, 4658.510856360169, 4702.811887524597, 4733.6213102951, 4306.63393611534, 4310.159518893911, 4330.718503297276, 4416.867493975057, 4421.248387774151], "value": 4032.5524564782245, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.2222044919615, 297.00799330237004, 299.8530719947226, 303.95440683897425, 307.3223542089691, 4864.4162700475945, 4882.877928051796, 4899.853004409864, 4903.16646170151, 4917.4836642152595, 4816.3016362627395, 4818.469968303492, 4830.44449888263, 4838.371011768474, 4844.66087373884, 3624.8550057997713, 3740.28934502445, 3756.605556416578, 3757.6993840492696, 3769.681645787848, 3697.5378077740284, 3766.905827354324, 3777.225668737916, 3841.558220804601, 3903.4535165076913, 3796.2597293527774, 3815.0, 3823.139793546444, 3823.4073718573663, 3827.54069511659, 3608.657177568153, 3803.7637767725323, 3823.0, 3827.311084004878, 3827.4641550183137, 3324.3683700096904, 3326.3181047885128, 3334.0997930558615, 3341.916452088693, 3344.515045318415, 4693.474620748237, 4721.315409265637, 4734.55021772931, 4745.762711864393, 4748.0, 4153.341861208829, 4274.102438487921, 4276.379924910871, 4313.935290970638, 4321.157374312011, 5034.748262586856, 5038.7984480620735, 5041.269015992697, 5045.167547354682, 5060.165072762989, 3590.35373632746, 3596.604373518911, 3611.512445819807, 3613.2231570212266, 3624.821932871801, 5145.485451454862, 5298.231756395301, 5317.388500322474, 5320.813771518017, 5323.813666521692, 3721.2557488502407, 3737.2712321097124, 3741.3826718591126, 3746.550413950343, 3746.925061498755, 3784.6783023443318, 3784.981075094662, 3794.582595914447, 3794.6205379462385, 3810.2379524094736, 4172.228137794457, 4302.741835489881, 4314.352847072964, 4316.589923957219, 4339.696221264481, 5048.873778155502, 5055.418626857959, 5079.009593129378, 5080.0, 5080.796768129308, 1296.235221219485, 1304.2044352944886, 1306.8627794081485, 1308.1104848702782, 1309.86246444122, 793.4485532554819, 818.8034871630766, 824.6187635710162, 834.4200780457523, 846.3863698818308, 4403.559644035571, 4478.484974228006, 4509.729416235036, 4537.455505339314, 4543.68194226401, 5195.740212989335, 5230.607704422184, 5235.0, 5268.841934741964, 5286.0, 4542.818287268538, 4549.339491085796, 4561.68068235227, 4562.1788078146255, 4568.423893756649, 2639.3797457597448, 2804.6634403871667, 2808.199663096008, 2809.2555472799722, 2814.5637426198973, 4928.743170491502, 4940.135476291634, 4952.851414457572, 4956.612148598399, 4971.279164521196, 5203.843884683465, 5373.328333958255, 5382.892342153135, 5383.7846486140115, 5405.621606487508, 4897.289892965428, 4914.705117692878, 4933.260010998379, 4945.109880221523, 4955.231939049453, 5210.296609957607, 5238.0, 5273.209018647233, 5287.0, 5290.497402746733, 4998.425181104074, 5050.797968081236, 5127.897442051213, 5171.92242116361, 5176.4305926348825, 4917.434495033117, 4927.384076990376, 4950.727709975986, 4952.8761780955765, 4959.876003099951, 3427.5544179256535, 3439.914002149966, 3451.378751824696, 3466.5320181775137, 3473.5484387030533, 4711.952880471152, 4717.811287548459, 4726.361941137902, 4744.572988431058, 4905.4358748742925, 5081.593472522263, 5112.642115051911, 5114.360704911886, 5122.487751224848, 5142.305788718475, 5112.769925353294, 5116.641835071509, 5124.487551244845, 5133.101707201299, 5151.613628977917, 4863.911416250636, 5052.8484145475695, 5062.265971434195, 5075.898482030265, 5096.210087436453, 4910.7544622768, 4989.226669866177, 5044.54599086084, 5047.167217409086, 5159.432462429055, 4832.081904438145, 4917.336159618549, 4997.700137991732, 5045.9243111352625, 5053.2420136979745], "value": 3816.4165954095924, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [660.5640277416904, 671.3353779758038, 703.6938931564766, 740.4261697184681, 756.3419824752465, 12666.176698514602, 13070.215787052783, 13354.66613334667, 13529.526466573672, 13550.593482195538, 12750.10749247553, 12865.228086314804, 12888.355582220875, 12907.419166137523, 12955.09314347996, 622.3993845938668, 765.2309429023851, 768.6656304507529, 792.1603100713262, 797.5055465611329, 794.1581923161439, 794.5907857453416, 796.4942261663828, 798.3333916179997, 799.1648727080216, 830.7715378270964, 833.3957880536593, 833.6665333866472, 833.7123692326138, 835.8620827563475, 646.453746584138, 785.2069409895989, 814.975550733473, 817.3542901108117, 829.8879651247095, 603.7192705392014, 604.039577072457, 604.4046614085123, 605.0047671580226, 605.0530919111576, 11674.416279186007, 11688.240264382874, 11700.2979821211, 11712.297262164297, 11724.237924534878, 11584.884151158465, 12216.144869859114, 12614.68463288416, 12681.365931703378, 13061.346932653425, 11716.355600441972, 12138.271703697807, 12168.878311216864, 12368.257904525757, 12949.741005179938, 4140.108357899761, 4200.390943313202, 4205.3481710334945, 4238.830446782125, 4336.349547567858, 59008.70495647537, 59530.0, 60248.698756506376, 60857.0, 61149.694251528905, 10101.393916364894, 10171.7457063574, 10188.949055254676, 10260.589576417009, 10407.53166107527, 16869.578260543338, 17121.486355409357, 17127.14364281781, 17129.14354282281, 17134.571635709206, 6709.228438729609, 6715.160604924385, 6762.526623136333, 6922.619255940972, 6960.477964152708, 3564.697000754913, 3687.041369244016, 3698.6301369863336, 3713.721470889694, 3742.214135031619, 2711.8372897626205, 2838.5600231964077, 2841.5879697443756, 2842.0905310300504, 2844.1467559731996, 430.65547561950314, 486.1274013146411, 494.16732805222597, 504.16308927180705, 506.4656787089582, 487.1134535146071, 511.0, 554.1410813239463, 586.9148973398833, 603.1254680712984, 8446.662133514714, 8454.746357609281, 8535.231829135284, 8735.781605459915, 8888.64445422176, 525.3354506549218, 563.9238702775073, 601.5127746525328, 604.3623976704619, 616.605372561561, 4001.9599804001587, 4166.520850102277, 4170.873864056748, 4262.680298977589, 4286.764227967429, 78808.21191788123, 105199.4740026295, 107466.46266768617, 108096.0, 114446.42776786063, 69141.0, 79507.0, 81592.0, 82739.5863020681, 82979.58510207411, 64691.99999999906, 68247.0, 72009.0, 73076.63461682657, 74251.62874185595, 8141.43009989295, 9181.862272066059, 9290.0, 9335.766605834908, 9418.152366287068, 34365.484517731755, 36179.0, 39871.60128398679, 43426.34860477032, 44039.33940990952, 58545.70727146507, 65479.345206547325, 66120.66939665271, 66320.66839665771, 68165.0, 11737.706557336134, 11819.40902954866, 11848.38372266766, 12089.093318001009, 12508.687282818002, 12056.75886482248, 12097.0, 12211.084168687206, 12582.496700131893, 12584.244945303311, 11723.062155027748, 12267.447964841425, 12741.0, 12951.5466958656, 13049.282289473791, 12126.514939402325, 12283.0, 12507.0, 12892.871071289543, 12927.0, 12225.57210497664, 12544.24734515932, 13238.602841914759, 13388.129771564818, 13417.127886687334, 9748.463834488888, 10164.949175254076, 10195.949020254851, 10354.223433242387, 10495.527701253615, 9673.661421850484, 9826.213902887608, 10344.157300570509, 10461.0, 10477.266591338534], "value": 6627.335153145441, "unit": "score"}], "name": "dromaeo_css", "value": 6457.487664965941, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 117.0, 114.0, 113.0, 115.0, 115.0, 113.0, 115.0, 113.0, 116.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 128.0, 129.0, 189.0, 125.0, 147.0, 148.0, 132.0, 185.0, 124.0], "value": 146.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 160.0, 161.0, 163.0, 161.0, 164.0, 161.0, 162.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 117.0, 77.0, 76.0, 74.0, 75.0, 106.0, 75.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 120.0, 85.0, 86.0, 86.0, 121.0, 84.0, 84.0, 128.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 116.0, 116.0, 116.0, 117.0, 116.0, 117.0, 116.0], "value": 116.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 63.0, 63.0, 63.0, 62.0, 64.0, 63.0, 62.0], "value": 63.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 65.0, 64.0, 64.0, 64.0, 66.0, 65.0, 64.0], "value": 64.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 88.0, 79.0, 79.0, 78.0, 78.0, 89.0, 83.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 131.0, 137.0, 127.0, 129.0, 135.0, 129.0, 128.0, 171.0, 136.0], "value": 135.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 174.0, 171.0, 173.0, 170.0, 169.0, 170.0, 173.0, 170.0, 170.0], "value": 170.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 70.0, 67.0, 67.0, 66.0, 67.0, 66.0, 66.0, 65.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1539.6999999999998, "alertThreshold": 2.0}]} 14:07:45 INFO - Return code: 0 14:07:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:07:45 INFO - # TBPL SUCCESS # 14:07:45 INFO - Running post-action listener: _resource_record_post_action 14:07:45 INFO - ##### 14:07:45 INFO - ##### Finished run-tests step (success) 14:07:45 INFO - ##### 14:07:45 INFO - Running post-run listener: _resource_record_post_run 14:07:45 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 12288; Write bytes: 534523904; Read time: 356; Write time: 519592 14:07:45 INFO - TinderboxPrint: CPU usage
13.0% 14:07:45 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 356 14:07:45 INFO - TinderboxPrint: I/O write bytes / time
534,523,904 / 519,592 14:07:45 INFO - TinderboxPrint: CPU idle
8,340.3 (87.0%) 14:07:45 INFO - TinderboxPrint: CPU user
1,202.2 (12.5%) 14:07:45 INFO - TinderboxPrint: Swap in / out
0 / 0 14:07:45 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 246476800; Read time: 172; Write time: 319368 14:07:45 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 8192; Write bytes: 288047104; Read time: 184; Write time: 200224 14:07:45 INFO - Running post-run listener: _upload_blobber_files 14:07:45 INFO - Blob upload gear active. 14:07:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:07:45 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 14:07:45 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'] 14:07:45 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 14:07:46 INFO - (blobuploader) - INFO - Open directory for files ... 14:07:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:07:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:07:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:07:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:07:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:07:49 INFO - (blobuploader) - INFO - Done attempting. 14:07:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:07:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:07:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:07:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:07:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:07:50 INFO - (blobuploader) - INFO - Done attempting. 14:07:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:07:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:07:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:07:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:07:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:07:51 INFO - (blobuploader) - INFO - Done attempting. 14:07:51 INFO - (blobuploader) - INFO - Iteration through files over. 14:07:51 INFO - Return code: 0 14:07:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:07:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:07:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/79a218073d8972fe8571188a7f5427ca35935b6eaadf14b9c7afabaae7c40203c4b09dc985e036cf08905a15a90099e30a3691ba6cc47dd28c303887fa02d619", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a087e34f13d0ae74a809f522cc9d52d4316f2de4fe91cb91b4b1dcb8dae1d2d4063bf446a6776af20add7407255cf78c8eda4982a3c41b1b679f97b8b54a9ce9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5320c0350df343807f96f3804f1ed2a130735cb72bd7e47bf7846c68ac6bec2cf5ecac07ecb4cf9fe40c5dae006cae25d0a21453377defd4e6ede497831e7352"} 14:07:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:07:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:07:51 INFO - Contents: 14:07:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/79a218073d8972fe8571188a7f5427ca35935b6eaadf14b9c7afabaae7c40203c4b09dc985e036cf08905a15a90099e30a3691ba6cc47dd28c303887fa02d619", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a087e34f13d0ae74a809f522cc9d52d4316f2de4fe91cb91b4b1dcb8dae1d2d4063bf446a6776af20add7407255cf78c8eda4982a3c41b1b679f97b8b54a9ce9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5320c0350df343807f96f3804f1ed2a130735cb72bd7e47bf7846c68ac6bec2cf5ecac07ecb4cf9fe40c5dae006cae25d0a21453377defd4e6ede497831e7352"} 14:07:51 INFO - Running post-run listener: copy_logs_to_upload_dir 14:07:51 INFO - Copying logs to upload dir... 14:07:51 INFO - mkdir: /builds/slave/test/build/upload/logs 14:07:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.625704 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-07-12 14:07:50.653127) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 14:07:50.656927) ========= 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=5bd038846534b2fdfa68eeae000001e2-1468355688.496615-1670034750 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/79a218073d8972fe8571188a7f5427ca35935b6eaadf14b9c7afabaae7c40203c4b09dc985e036cf08905a15a90099e30a3691ba6cc47dd28c303887fa02d619", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a087e34f13d0ae74a809f522cc9d52d4316f2de4fe91cb91b4b1dcb8dae1d2d4063bf446a6776af20add7407255cf78c8eda4982a3c41b1b679f97b8b54a9ce9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5320c0350df343807f96f3804f1ed2a130735cb72bd7e47bf7846c68ac6bec2cf5ecac07ecb4cf9fe40c5dae006cae25d0a21453377defd4e6ede497831e7352"} build_url:https://queue.taskcluster.net/v1/task/Nr8C3QtUSp2F5tPP9hbLDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011203 build_url: 'https://queue.taskcluster.net/v1/task/Nr8C3QtUSp2F5tPP9hbLDw/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/79a218073d8972fe8571188a7f5427ca35935b6eaadf14b9c7afabaae7c40203c4b09dc985e036cf08905a15a90099e30a3691ba6cc47dd28c303887fa02d619", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a087e34f13d0ae74a809f522cc9d52d4316f2de4fe91cb91b4b1dcb8dae1d2d4063bf446a6776af20add7407255cf78c8eda4982a3c41b1b679f97b8b54a9ce9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5320c0350df343807f96f3804f1ed2a130735cb72bd7e47bf7846c68ac6bec2cf5ecac07ecb4cf9fe40c5dae006cae25d0a21453377defd4e6ede497831e7352"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 14:07:50.681675) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 14:07:50.681983) ========= 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=5bd038846534b2fdfa68eeae000001e2-1468355688.496615-1670034750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004465 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 14:07:50.767662) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 14:07:50.768011) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 14:07:50.768317) ========= ========= Total master_lag: 0.17 =========