builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-039 starttime: 1468499941.77 results: success (0) buildid: 20160714051941 builduid: 2f4e1f354a1743e48f446b5d6cc518fb revision: 1d5210d6f9614812ebdfad13a0d6e25d4513c03e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 05:39:01.772674) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 05:39:01.773498) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 05:39:01.774017) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 05:39:01.822184) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 05:39:01.822811) ========= 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-1468499776.15777-104712317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-14 05:39:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.7M=0s 2016-07-14 05:39:02 (70.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100094 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 05:39:01.938820) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 05:39:01.939154) ========= 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-1468499776.15777-104712317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016241 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 05:39:01.988485) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 05:39:01.988880) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1d5210d6f9614812ebdfad13a0d6e25d4513c03e --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 1d5210d6f9614812ebdfad13a0d6e25d4513c03e --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-1468499776.15777-104712317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-14 05:39:02,150 truncating revision to first 12 chars 2016-07-14 05:39:02,151 Setting DEBUG logging. 2016-07-14 05:39:02,151 attempt 1/10 2016-07-14 05:39:02,151 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1d5210d6f961?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-14 05:39:02,469 unpacking tar archive at: fx-team-1d5210d6f961/testing/mozharness/ program finished with exit code 0 elapsedTime=0.675542 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 05:39:02.678941) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 05:39:02.679348) ========= script_repo_revision: 1d5210d6f9614812ebdfad13a0d6e25d4513c03e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 05:39:02.679844) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 05:39:02.680140) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 05:39:02.699669) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-07-14 05:39:02.700100) ========= /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-1468499776.15777-104712317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:39:02 INFO - MultiFileLogger online at 20160714 05:39:02 in /builds/slave/test 05:39:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:39:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:39:02 INFO - {'append_to_log': False, 05:39:02 INFO - 'base_work_dir': '/builds/slave/test', 05:39:02 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:39:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:39:02 INFO - 'branch': 'Fx-Team-Non-PGO', 05:39:02 INFO - 'buildbot_json_path': 'buildprops.json', 05:39:02 INFO - 'config_files': ('talos/linux_config.py',), 05:39:02 INFO - 'default_actions': ('clobber', 05:39:02 INFO - 'read-buildbot-config', 05:39:02 INFO - 'download-and-extract', 05:39:02 INFO - 'populate-webroot', 05:39:02 INFO - 'create-virtualenv', 05:39:02 INFO - 'install', 05:39:02 INFO - 'run-tests'), 05:39:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:39:02 INFO - 'download_minidump_stackwalk': True, 05:39:02 INFO - 'download_symbols': 'ondemand', 05:39:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:39:02 INFO - 'tooltool.py': '/tools/tooltool.py', 05:39:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:39:02 INFO - '/tools/misc-python/virtualenv.py')}, 05:39:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:39:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:39:02 INFO - 'installer_path': 'installer.exe', 05:39:02 INFO - 'log_level': 'info', 05:39:02 INFO - 'log_name': 'talos', 05:39:02 INFO - 'log_to_console': True, 05:39:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:39:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:39:02 INFO - 'opt_config_files': (), 05:39:02 INFO - 'pip_index': False, 05:39:02 INFO - 'sps_profile': False, 05:39:02 INFO - 'sps_profile_interval': 0, 05:39:02 INFO - 'suite': 'dromaeojs', 05:39:02 INFO - 'system_bits': '32', 05:39:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:39:02 INFO - 'title': 'talos-linux64-ix-039', 05:39:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:39:02 INFO - 'use_talos_json': True, 05:39:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:39:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:39:02 INFO - 'work_dir': 'build'} 05:39:02 INFO - ##### 05:39:02 INFO - ##### Running clobber step. 05:39:02 INFO - ##### 05:39:02 INFO - Running pre-action listener: _resource_record_pre_action 05:39:02 INFO - Running main action method: clobber 05:39:02 INFO - rmtree: /builds/slave/test/build 05:39:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:39:03 INFO - Running post-action listener: _resource_record_post_action 05:39:03 INFO - ##### 05:39:03 INFO - ##### Finished clobber step (success) 05:39:03 INFO - ##### 05:39:03 INFO - ##### 05:39:03 INFO - ##### Running read-buildbot-config step. 05:39:03 INFO - ##### 05:39:03 INFO - Running pre-action listener: _resource_record_pre_action 05:39:03 INFO - Running main action method: read_buildbot_config 05:39:03 INFO - Using buildbot properties: 05:39:03 INFO - { 05:39:03 INFO - "project": "", 05:39:03 INFO - "product": "firefox", 05:39:03 INFO - "script_repo_revision": "production", 05:39:03 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:39:03 INFO - "repository": "", 05:39:03 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:39:03 INFO - "buildid": "20160714051941", 05:39:03 INFO - "pgo_build": "False", 05:39:03 INFO - "basedir": "/builds/slave/test", 05:39:03 INFO - "buildnumber": 1991, 05:39:03 INFO - "slavename": "talos-linux64-ix-039", 05:39:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:39:03 INFO - "platform": "ubuntu64_hw", 05:39:03 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:39:03 INFO - "branch": "fx-team", 05:39:03 INFO - "repo_path": "integration/fx-team", 05:39:03 INFO - "revision": "1d5210d6f9614812ebdfad13a0d6e25d4513c03e", 05:39:03 INFO - "stage_platform": "linux64", 05:39:03 INFO - "builduid": "2f4e1f354a1743e48f446b5d6cc518fb", 05:39:03 INFO - "slavebuilddir": "test" 05:39:03 INFO - } 05:39:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/XqURWo3kR-OpIRp74Ia9vA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:39:03 INFO - Running post-action listener: _resource_record_post_action 05:39:03 INFO - ##### 05:39:03 INFO - ##### Finished read-buildbot-config step (success) 05:39:03 INFO - ##### 05:39:03 INFO - ##### 05:39:03 INFO - ##### Running download-and-extract step. 05:39:03 INFO - ##### 05:39:03 INFO - Running pre-action listener: _resource_record_pre_action 05:39:03 INFO - Running main action method: download_and_extract 05:39:03 INFO - mkdir: /builds/slave/test/build/tests 05:39:03 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')]} 05:39:03 INFO - https://queue.taskcluster.net/v1/task/XqURWo3kR-OpIRp74Ia9vA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:39:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XqURWo3kR-OpIRp74Ia9vA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:39:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XqURWo3kR-OpIRp74Ia9vA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:39:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XqURWo3kR-OpIRp74Ia9vA/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 05:39:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XqURWo3kR-OpIRp74Ia9vA/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 05:39:11 INFO - Downloaded 1361 bytes. 05:39:11 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:39:11 INFO - Using the following test package requirements: 05:39:11 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:39:11 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:39:11 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:39:11 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:11 INFO - u'jsshell-linux-x86_64.zip'], 05:39:11 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:39:11 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:39:11 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:39:11 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:39:11 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:39:11 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:39:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:39:11 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:39:11 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')]} 05:39:11 INFO - https://queue.taskcluster.net/v1/task/XqURWo3kR-OpIRp74Ia9vA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:39:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XqURWo3kR-OpIRp74Ia9vA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:39:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XqURWo3kR-OpIRp74Ia9vA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:39:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XqURWo3kR-OpIRp74Ia9vA/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 05:39:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XqURWo3kR-OpIRp74Ia9vA/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 05:39:17 INFO - Downloaded 22756551 bytes. 05:39: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'] 05:39: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 05:39:18 INFO - Return code: 0 05:39:18 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 05:39: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')]} 05:39:18 INFO - https://queue.taskcluster.net/v1/task/XqURWo3kR-OpIRp74Ia9vA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:39:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XqURWo3kR-OpIRp74Ia9vA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:39:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XqURWo3kR-OpIRp74Ia9vA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:39:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XqURWo3kR-OpIRp74Ia9vA/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 05:39:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XqURWo3kR-OpIRp74Ia9vA/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 05:39:23 INFO - Downloaded 22756551 bytes. 05:39:23 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'] 05:39:23 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 05:39:24 INFO - Return code: 0 05:39: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')]} 05:39:24 INFO - https://queue.taskcluster.net/v1/task/XqURWo3kR-OpIRp74Ia9vA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:39:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XqURWo3kR-OpIRp74Ia9vA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:39:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XqURWo3kR-OpIRp74Ia9vA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:39:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XqURWo3kR-OpIRp74Ia9vA/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 05:39:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XqURWo3kR-OpIRp74Ia9vA/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 05:39:25 INFO - Downloaded 14403317 bytes. 05:39:25 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'] 05:39:25 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 05:39:26 INFO - Return code: 0 05:39:26 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')]} 05:39:26 INFO - https://queue.taskcluster.net/v1/task/XqURWo3kR-OpIRp74Ia9vA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:39:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XqURWo3kR-OpIRp74Ia9vA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:39:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XqURWo3kR-OpIRp74Ia9vA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:39:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XqURWo3kR-OpIRp74Ia9vA/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 05:39:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XqURWo3kR-OpIRp74Ia9vA/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 05:39:27 INFO - Downloaded 57054790 bytes. 05:39:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XqURWo3kR-OpIRp74Ia9vA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:39:27 INFO - mkdir: /builds/slave/test/properties 05:39:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:39:27 INFO - Writing to file /builds/slave/test/properties/build_url 05:39:27 INFO - Contents: 05:39:27 INFO - build_url:https://queue.taskcluster.net/v1/task/XqURWo3kR-OpIRp74Ia9vA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:39:28 INFO - Running post-action listener: _resource_record_post_action 05:39:28 INFO - Running post-action listener: set_extra_try_arguments 05:39:28 INFO - ##### 05:39:28 INFO - ##### Finished download-and-extract step (success) 05:39:28 INFO - ##### 05:39:28 INFO - ##### 05:39:28 INFO - ##### Running populate-webroot step. 05:39:28 INFO - ##### 05:39:28 INFO - Running pre-action listener: _resource_record_pre_action 05:39:28 INFO - Running main action method: populate_webroot 05:39:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:39:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:39:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:39:28 INFO - '--tppagecycles', 05:39:28 INFO - '7'], 05:39:28 INFO - 'tests': ['tsvgm']}}, 05:39:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:39:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:39:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:39:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:39:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:39:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:39:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:28 INFO - 'talos_options': ['--disable-e10s'], 05:39:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:39:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:39:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:28 INFO - 'talos_options': ['--disable-e10s'], 05:39:28 INFO - 'tests': ['damp', 'tps']}, 05:39:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:28 INFO - 'tests': ['damp', 'tps']}, 05:39:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:39:28 INFO - 'tests': ['dromaeo_dom']}, 05:39:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:39:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:39:28 INFO - 'tests': ['basic_compositor_video']}, 05:39:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:39:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:39:28 INFO - 'tests': ['a11yr', 05:39:28 INFO - 'ts_paint', 05:39:28 INFO - 'tpaint', 05:39:28 INFO - 'sessionrestore', 05:39:28 INFO - 'sessionrestore_no_auto_restore', 05:39:28 INFO - 'tabpaint']}, 05:39:28 INFO - 'other-e10s': {'tests': ['a11yr', 05:39:28 INFO - 'ts_paint', 05:39:28 INFO - 'tpaint', 05:39:28 INFO - 'sessionrestore', 05:39:28 INFO - 'sessionrestore_no_auto_restore', 05:39:28 INFO - 'tabpaint']}, 05:39:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:39:28 INFO - 'ts_paint', 05:39:28 INFO - 'tpaint', 05:39:28 INFO - 'sessionrestore', 05:39:28 INFO - 'sessionrestore_no_auto_restore', 05:39:28 INFO - 'tabpaint']}, 05:39:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:39:28 INFO - 'ts_paint', 05:39:28 INFO - 'tpaint', 05:39:28 INFO - 'sessionrestore', 05:39:28 INFO - 'sessionrestore_no_auto_restore', 05:39:28 INFO - 'tabpaint']}, 05:39:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:39:28 INFO - 'tests': ['a11yr', 05:39:28 INFO - 'ts_paint', 05:39:28 INFO - 'tpaint', 05:39:28 INFO - 'sessionrestore', 05:39:28 INFO - 'sessionrestore_no_auto_restore', 05:39:28 INFO - 'tabpaint']}, 05:39:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:39:28 INFO - 'tests': ['a11yr', 05:39:28 INFO - 'ts_paint', 05:39:28 INFO - 'tpaint', 05:39:28 INFO - 'sessionrestore', 05:39:28 INFO - 'sessionrestore_no_auto_restore', 05:39:28 INFO - 'tabpaint']}, 05:39:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:39:28 INFO - 'tests': ['tsvgx', 05:39:28 INFO - 'tsvgr_opacity', 05:39:28 INFO - 'tart', 05:39:28 INFO - 'tscrollx', 05:39:28 INFO - 'cart']}, 05:39:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:39:28 INFO - 'tsvgr_opacity', 05:39:28 INFO - 'tart', 05:39:28 INFO - 'tscrollx', 05:39:28 INFO - 'cart']}, 05:39:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:28 INFO - 'talos_options': ['--disable-e10s'], 05:39:28 INFO - 'tests': ['tp5o']}, 05:39:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:28 INFO - 'tests': ['tp5o']}, 05:39:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:28 INFO - 'talos_options': ['--disable-e10s', 05:39:28 INFO - '--xperf_path', 05:39:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:39:28 INFO - 'tests': ['tp5n']}, 05:39:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:28 INFO - 'talos_options': ['--xperf_path', 05:39:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:39:28 INFO - 'tests': ['tp5n']}}, 05:39:28 INFO - 'talos.zip': {'path': '', 05:39:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:39:28 INFO - Running post-action listener: _resource_record_post_action 05:39:28 INFO - ##### 05:39:28 INFO - ##### Finished populate-webroot step (success) 05:39:28 INFO - ##### 05:39:28 INFO - ##### 05:39:28 INFO - ##### Running create-virtualenv step. 05:39:28 INFO - ##### 05:39:28 INFO - Running pre-action listener: _resource_record_pre_action 05:39:28 INFO - Running main action method: create_virtualenv 05:39:28 INFO - Creating virtualenv /builds/slave/test/build/venv 05:39:28 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 05:39:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:39:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:39:28 INFO - Using real prefix '/usr' 05:39:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:39:28 INFO - Installing distribute.............................................................................................................................................................................................done. 05:39:30 INFO - Installing pip.................done. 05:39:30 INFO - Return code: 0 05:39:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2457030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2718180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27163b0>, '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 0x27172b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2717740>, '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-1468499776.15777-104712317', '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 05:39:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:39:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:39:30 INFO - Using env: {'DISPLAY': ':0', 05:39:30 INFO - 'HOME': '/home/cltbld', 05:39:30 INFO - 'LANG': 'en_US.UTF-8', 05:39:30 INFO - 'LANGUAGE': 'en_US:en', 05:39:30 INFO - 'LOGNAME': 'cltbld', 05:39:30 INFO - 'MAIL': '/var/mail/cltbld', 05:39:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:30 INFO - 'MOZ_NO_REMOTE': '1', 05:39:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:30 INFO - 'NO_EM_RESTART': '1', 05:39:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:30 INFO - 'PWD': '/builds/slave/test', 05:39:30 INFO - 'SHELL': '/bin/bash', 05:39:30 INFO - 'SHLVL': '1', 05:39:30 INFO - 'TERM': 'linux', 05:39:30 INFO - 'TMOUT': '86400', 05:39:30 INFO - 'USER': 'cltbld', 05:39:30 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468499776.15777-104712317', 05:39:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:30 INFO - '_': '/tools/buildbot/bin/python'} 05:39:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:31 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 05:39:31 INFO - Cleaning up... 05:39:31 INFO - Return code: 0 05:39:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:39:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2457030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2718180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27163b0>, '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 0x27172b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2717740>, '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-1468499776.15777-104712317', '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 05:39:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:39:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:39:31 INFO - Using env: {'DISPLAY': ':0', 05:39:31 INFO - 'HOME': '/home/cltbld', 05:39:31 INFO - 'LANG': 'en_US.UTF-8', 05:39:31 INFO - 'LANGUAGE': 'en_US:en', 05:39:31 INFO - 'LOGNAME': 'cltbld', 05:39:31 INFO - 'MAIL': '/var/mail/cltbld', 05:39:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:31 INFO - 'MOZ_NO_REMOTE': '1', 05:39:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:31 INFO - 'NO_EM_RESTART': '1', 05:39:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:31 INFO - 'PWD': '/builds/slave/test', 05:39:31 INFO - 'SHELL': '/bin/bash', 05:39:31 INFO - 'SHLVL': '1', 05:39:31 INFO - 'TERM': 'linux', 05:39:31 INFO - 'TMOUT': '86400', 05:39:31 INFO - 'USER': 'cltbld', 05:39:31 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468499776.15777-104712317', 05:39:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:31 INFO - '_': '/tools/buildbot/bin/python'} 05:39:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:31 INFO - Downloading/unpacking psutil>=3.1.1 05:39:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:39:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:39:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:39:33 INFO - Installing collected packages: psutil 05:39:33 INFO - Running setup.py install for psutil 05:39:33 INFO - building 'psutil._psutil_linux' extension 05:39:33 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 05:39:33 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 05:39:33 INFO - building 'psutil._psutil_posix' extension 05:39:33 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 05:39:33 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 05:39:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:39:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:39:33 INFO - Successfully installed psutil 05:39:33 INFO - Cleaning up... 05:39:33 INFO - Return code: 0 05:39:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:39:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2457030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2718180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27163b0>, '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 0x27172b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2717740>, '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-1468499776.15777-104712317', '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 05:39:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:39:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:39:33 INFO - Using env: {'DISPLAY': ':0', 05:39:33 INFO - 'HOME': '/home/cltbld', 05:39:33 INFO - 'LANG': 'en_US.UTF-8', 05:39:33 INFO - 'LANGUAGE': 'en_US:en', 05:39:33 INFO - 'LOGNAME': 'cltbld', 05:39:33 INFO - 'MAIL': '/var/mail/cltbld', 05:39:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:33 INFO - 'MOZ_NO_REMOTE': '1', 05:39:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:33 INFO - 'NO_EM_RESTART': '1', 05:39:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:33 INFO - 'PWD': '/builds/slave/test', 05:39:33 INFO - 'SHELL': '/bin/bash', 05:39:33 INFO - 'SHLVL': '1', 05:39:33 INFO - 'TERM': 'linux', 05:39:33 INFO - 'TMOUT': '86400', 05:39:33 INFO - 'USER': 'cltbld', 05:39:33 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468499776.15777-104712317', 05:39:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:33 INFO - '_': '/tools/buildbot/bin/python'} 05:39:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:39: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 05:39: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 05:39: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 05:39: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 05:39: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 05:39: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 05:39:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:39:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:39:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:39:37 INFO - Installing collected packages: mozsystemmonitor 05:39:37 INFO - Running setup.py install for mozsystemmonitor 05:39:37 INFO - Successfully installed mozsystemmonitor 05:39:37 INFO - Cleaning up... 05:39:37 INFO - Return code: 0 05:39:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:39:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:37 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 0x2457030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2718180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27163b0>, '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 0x27172b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2717740>, '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-1468499776.15777-104712317', '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 05:39:37 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 05:39:37 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 05:39:37 INFO - Using env: {'DISPLAY': ':0', 05:39:37 INFO - 'HOME': '/home/cltbld', 05:39:37 INFO - 'LANG': 'en_US.UTF-8', 05:39:37 INFO - 'LANGUAGE': 'en_US:en', 05:39:37 INFO - 'LOGNAME': 'cltbld', 05:39:37 INFO - 'MAIL': '/var/mail/cltbld', 05:39:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:37 INFO - 'MOZ_NO_REMOTE': '1', 05:39:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:37 INFO - 'NO_EM_RESTART': '1', 05:39:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:37 INFO - 'PWD': '/builds/slave/test', 05:39:37 INFO - 'SHELL': '/bin/bash', 05:39:37 INFO - 'SHLVL': '1', 05:39:37 INFO - 'TERM': 'linux', 05:39:37 INFO - 'TMOUT': '86400', 05:39:37 INFO - 'USER': 'cltbld', 05:39:37 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468499776.15777-104712317', 05:39:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:37 INFO - '_': '/tools/buildbot/bin/python'} 05:39:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:37 INFO - Downloading/unpacking jsonschema==2.5.1 05:39:37 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 05:39:37 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 05:39:37 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 05:39:37 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 05:39:37 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 05:39:37 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 05:39:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:39:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:39:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:39 INFO - Downloading functools32-3.2.3-2.tar.gz 05:39:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:39:39 INFO - warning: no files found matching '*.txt' 05:39:39 INFO - no previously-included directories found matching 'build' 05:39:39 INFO - no previously-included directories found matching 'dist' 05:39:39 INFO - no previously-included directories found matching '.git*' 05:39:39 INFO - Installing collected packages: jsonschema, functools32 05:39:39 INFO - Running setup.py install for functools32 05:39:39 INFO - warning: no files found matching '*.txt' 05:39:39 INFO - no previously-included directories found matching 'build' 05:39:39 INFO - no previously-included directories found matching 'dist' 05:39:39 INFO - no previously-included directories found matching '.git*' 05:39:39 INFO - Successfully installed jsonschema functools32 05:39:39 INFO - Cleaning up... 05:39:39 INFO - Return code: 0 05:39:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:39: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')]} 05:39:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39: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')]} 05:39:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:39 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 0x2457030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2718180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27163b0>, '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 0x27172b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2717740>, '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-1468499776.15777-104712317', '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 05:39:39 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 05:39:39 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 05:39:39 INFO - Using env: {'DISPLAY': ':0', 05:39:39 INFO - 'HOME': '/home/cltbld', 05:39:39 INFO - 'LANG': 'en_US.UTF-8', 05:39:39 INFO - 'LANGUAGE': 'en_US:en', 05:39:39 INFO - 'LOGNAME': 'cltbld', 05:39:39 INFO - 'MAIL': '/var/mail/cltbld', 05:39:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:39 INFO - 'MOZ_NO_REMOTE': '1', 05:39:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:39 INFO - 'NO_EM_RESTART': '1', 05:39:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:39 INFO - 'PWD': '/builds/slave/test', 05:39:39 INFO - 'SHELL': '/bin/bash', 05:39:39 INFO - 'SHLVL': '1', 05:39:39 INFO - 'TERM': 'linux', 05:39:39 INFO - 'TMOUT': '86400', 05:39:39 INFO - 'USER': 'cltbld', 05:39:39 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468499776.15777-104712317', 05:39:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:39 INFO - '_': '/tools/buildbot/bin/python'} 05:39:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:40 INFO - Downloading/unpacking blobuploader==1.2.4 05:39: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 05:39: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 05:39: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 05:39: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 05:39: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 05:39: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 05:39:41 INFO - Downloading blobuploader-1.2.4.tar.gz 05:39:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:39:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:39:42 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 05:39:42 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 05:39:42 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 05:39:42 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 05:39:42 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 05:39:42 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 05:39:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:39:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:39:42 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 05:39:42 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 05:39:42 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 05:39:42 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 05:39:42 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 05:39:42 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 05:39:42 INFO - Downloading docopt-0.6.1.tar.gz 05:39:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:39:42 INFO - Installing collected packages: blobuploader, requests, docopt 05:39:42 INFO - Running setup.py install for blobuploader 05:39:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:39:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:39:42 INFO - Running setup.py install for requests 05:39:43 INFO - Running setup.py install for docopt 05:39:43 INFO - Successfully installed blobuploader requests docopt 05:39:43 INFO - Cleaning up... 05:39:43 INFO - Return code: 0 05:39:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:39: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')]} 05:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39: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')]} 05:39:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:43 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 0x2457030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2718180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27163b0>, '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 0x27172b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2717740>, '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-1468499776.15777-104712317', '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 05:39:43 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 05:39:43 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 05:39:43 INFO - Using env: {'DISPLAY': ':0', 05:39:43 INFO - 'HOME': '/home/cltbld', 05:39:43 INFO - 'LANG': 'en_US.UTF-8', 05:39:43 INFO - 'LANGUAGE': 'en_US:en', 05:39:43 INFO - 'LOGNAME': 'cltbld', 05:39:43 INFO - 'MAIL': '/var/mail/cltbld', 05:39:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:43 INFO - 'MOZ_NO_REMOTE': '1', 05:39:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:43 INFO - 'NO_EM_RESTART': '1', 05:39:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:43 INFO - 'PWD': '/builds/slave/test', 05:39:43 INFO - 'SHELL': '/bin/bash', 05:39:43 INFO - 'SHLVL': '1', 05:39:43 INFO - 'TERM': 'linux', 05:39:43 INFO - 'TMOUT': '86400', 05:39:43 INFO - 'USER': 'cltbld', 05:39:43 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468499776.15777-104712317', 05:39:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:43 INFO - '_': '/tools/buildbot/bin/python'} 05:39:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:39:43 INFO - Running setup.py (path:/tmp/pip-Bopn9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:39:43 INFO - Running setup.py (path:/tmp/pip-qW3DSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:39:43 INFO - Running setup.py (path:/tmp/pip-qrxN2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:39:43 INFO - Running setup.py (path:/tmp/pip-uhxEGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:39:43 INFO - Running setup.py (path:/tmp/pip-3XDFtl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:39:43 INFO - Running setup.py (path:/tmp/pip-e80Scc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:39:44 INFO - Running setup.py (path:/tmp/pip-ReuRVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:39:44 INFO - Running setup.py (path:/tmp/pip-sVjp2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:39:44 INFO - Running setup.py (path:/tmp/pip-yYsFTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:39:44 INFO - Running setup.py (path:/tmp/pip-7VxDB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:39:44 INFO - Running setup.py (path:/tmp/pip-V7UO_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:39:44 INFO - Running setup.py (path:/tmp/pip-Lq_NvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:39:44 INFO - Running setup.py (path:/tmp/pip-xue4DY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:39:44 INFO - Running setup.py (path:/tmp/pip-hpGSP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:44 INFO - Running setup.py (path:/tmp/pip-90EAoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:39:44 INFO - Running setup.py (path:/tmp/pip-LS2x8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:39:44 INFO - Running setup.py (path:/tmp/pip-SZtudc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:39:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:39:44 INFO - Running setup.py install for manifestparser 05:39:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:39:44 INFO - Running setup.py install for mozcrash 05:39:45 INFO - Running setup.py install for mozdebug 05:39:45 INFO - Running setup.py install for mozdevice 05:39:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:39:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:39:45 INFO - Running setup.py install for mozfile 05:39:45 INFO - Running setup.py install for mozhttpd 05:39:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:39:45 INFO - Running setup.py install for mozinfo 05:39:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:39:45 INFO - Running setup.py install for mozInstall 05:39:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:39:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:39:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:39:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:39:45 INFO - Running setup.py install for mozleak 05:39:45 INFO - Running setup.py install for mozlog 05:39:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:39:45 INFO - Running setup.py install for moznetwork 05:39:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:39:45 INFO - Running setup.py install for mozprocess 05:39:46 INFO - Running setup.py install for mozprofile 05:39:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:39:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:39:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:39:46 INFO - Running setup.py install for mozrunner 05:39:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:39:46 INFO - Running setup.py install for mozscreenshot 05:39:46 INFO - Running setup.py install for moztest 05:39:46 INFO - Running setup.py install for mozversion 05:39:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:39:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:39:46 INFO - Cleaning up... 05:39:46 INFO - Return code: 0 05:39:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:39:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:46 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 0x2457030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2718180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27163b0>, '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 0x27172b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2717740>, '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-1468499776.15777-104712317', '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 05:39:46 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 05:39:46 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 05:39:46 INFO - Using env: {'DISPLAY': ':0', 05:39:46 INFO - 'HOME': '/home/cltbld', 05:39:46 INFO - 'LANG': 'en_US.UTF-8', 05:39:46 INFO - 'LANGUAGE': 'en_US:en', 05:39:46 INFO - 'LOGNAME': 'cltbld', 05:39:46 INFO - 'MAIL': '/var/mail/cltbld', 05:39:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:46 INFO - 'MOZ_NO_REMOTE': '1', 05:39:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:46 INFO - 'NO_EM_RESTART': '1', 05:39:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:46 INFO - 'PWD': '/builds/slave/test', 05:39:46 INFO - 'SHELL': '/bin/bash', 05:39:46 INFO - 'SHLVL': '1', 05:39:46 INFO - 'TERM': 'linux', 05:39:46 INFO - 'TMOUT': '86400', 05:39:46 INFO - 'USER': 'cltbld', 05:39:46 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468499776.15777-104712317', 05:39:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:46 INFO - '_': '/tools/buildbot/bin/python'} 05:39:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:39:46 INFO - Running setup.py (path:/tmp/pip-3PK7od-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:39:46 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)) 05:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:39:46 INFO - Running setup.py (path:/tmp/pip-Mw3tNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:39:46 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)) 05:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:39:46 INFO - Running setup.py (path:/tmp/pip-opWRrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:39:47 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)) 05:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:39:47 INFO - Running setup.py (path:/tmp/pip-QBakk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:39:47 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)) 05:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:39:47 INFO - Running setup.py (path:/tmp/pip-haqtnY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:39:47 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)) 05:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:39:47 INFO - Running setup.py (path:/tmp/pip-lcH3T5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:39:47 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)) 05:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:39:47 INFO - Running setup.py (path:/tmp/pip-gii6js-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:39:47 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)) 05:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:39:47 INFO - Running setup.py (path:/tmp/pip-1KL8iD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:39:47 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)) 05:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:39:47 INFO - Running setup.py (path:/tmp/pip-68qqw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:39:47 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)) 05:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:39:47 INFO - Running setup.py (path:/tmp/pip-HG1NB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:39:47 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)) 05:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:39:47 INFO - Running setup.py (path:/tmp/pip-fWGYZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:39:47 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)) 05:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:39:47 INFO - Running setup.py (path:/tmp/pip-ZB4c5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:39:47 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)) 05:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:39:47 INFO - Running setup.py (path:/tmp/pip-avEJmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:39:47 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)) 05:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:39:47 INFO - Running setup.py (path:/tmp/pip-Icn_3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:39:47 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)) 05:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:47 INFO - Running setup.py (path:/tmp/pip-9kbDW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:47 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)) 05:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:39:47 INFO - Running setup.py (path:/tmp/pip-vAQKqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:39:47 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)) 05:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:39:47 INFO - Running setup.py (path:/tmp/pip-y5qQvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:39:48 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)) 05:39:48 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)) 05:39:48 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)) 05:39:48 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)) 05:39:48 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)) 05:39:48 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)) 05:39:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:39:48 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 05:39:48 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 05:39:48 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 05:39:48 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 05:39:48 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 05:39:48 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 05:39:49 INFO - Downloading blessings-1.6.tar.gz 05:39:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:39:50 INFO - Installing collected packages: blessings 05:39:50 INFO - Running setup.py install for blessings 05:39:50 INFO - Successfully installed blessings 05:39:50 INFO - Cleaning up... 05:39:50 INFO - Return code: 0 05:39:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:39:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:39:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:39:50 INFO - Reading from file tmpfile_stdout 05:39:50 INFO - Current package versions: 05:39:50 INFO - argparse == 1.2.1 05:39:50 INFO - blessings == 1.6 05:39:50 INFO - blobuploader == 1.2.4 05:39:50 INFO - docopt == 0.6.1 05:39:50 INFO - functools32 == 3.2.3-2 05:39:50 INFO - jsonschema == 2.5.1 05:39:50 INFO - manifestparser == 1.1 05:39:50 INFO - mozInstall == 1.12 05:39:50 INFO - mozcrash == 0.17 05:39:50 INFO - mozdebug == 0.1 05:39:50 INFO - mozdevice == 0.48 05:39:50 INFO - mozfile == 1.2 05:39:50 INFO - mozhttpd == 0.7 05:39:50 INFO - mozinfo == 0.9 05:39:50 INFO - mozleak == 0.1 05:39:50 INFO - mozlog == 3.2 05:39:50 INFO - moznetwork == 0.27 05:39:50 INFO - mozprocess == 0.23 05:39:50 INFO - mozprofile == 0.28 05:39:50 INFO - mozrunner == 6.12 05:39:50 INFO - mozscreenshot == 0.1 05:39:50 INFO - mozsystemmonitor == 0.3 05:39:50 INFO - moztest == 0.7 05:39:50 INFO - mozversion == 1.4 05:39:50 INFO - psutil == 3.1.1 05:39:50 INFO - requests == 1.2.3 05:39:50 INFO - wsgiref == 0.1.2 05:39:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:39:50 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')]} 05:39:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:50 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')]} 05:39:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:50 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 0x2457030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2718180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27163b0>, '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 0x27172b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2717740>, '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-1468499776.15777-104712317', '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 05:39:50 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 05:39:50 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 05:39:50 INFO - Using env: {'DISPLAY': ':0', 05:39:50 INFO - 'HOME': '/home/cltbld', 05:39:50 INFO - 'LANG': 'en_US.UTF-8', 05:39:50 INFO - 'LANGUAGE': 'en_US:en', 05:39:50 INFO - 'LOGNAME': 'cltbld', 05:39:50 INFO - 'MAIL': '/var/mail/cltbld', 05:39:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:50 INFO - 'MOZ_NO_REMOTE': '1', 05:39:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:50 INFO - 'NO_EM_RESTART': '1', 05:39:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:50 INFO - 'PWD': '/builds/slave/test', 05:39:50 INFO - 'SHELL': '/bin/bash', 05:39:50 INFO - 'SHLVL': '1', 05:39:50 INFO - 'TERM': 'linux', 05:39:50 INFO - 'TMOUT': '86400', 05:39:50 INFO - 'USER': 'cltbld', 05:39:50 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468499776.15777-104712317', 05:39:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:50 INFO - '_': '/tools/buildbot/bin/python'} 05:39:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:50 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)) 05:39:50 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)) 05:39:50 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)) 05:39:50 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)) 05:39:50 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)) 05:39:50 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)) 05:39:50 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)) 05:39:50 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)) 05:39:50 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)) 05:39:50 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)) 05:39:50 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)) 05:39:50 INFO - Cleaning up... 05:39:50 INFO - Return code: 0 05:39:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:39:50 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')]} 05:39:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:50 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')]} 05:39:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:50 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 0x2457030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2718180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27163b0>, '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 0x27172b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2717740>, '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-1468499776.15777-104712317', '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 05:39:50 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 05:39:50 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 05:39:50 INFO - Using env: {'DISPLAY': ':0', 05:39:50 INFO - 'HOME': '/home/cltbld', 05:39:50 INFO - 'LANG': 'en_US.UTF-8', 05:39:50 INFO - 'LANGUAGE': 'en_US:en', 05:39:50 INFO - 'LOGNAME': 'cltbld', 05:39:50 INFO - 'MAIL': '/var/mail/cltbld', 05:39:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:50 INFO - 'MOZ_NO_REMOTE': '1', 05:39:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:50 INFO - 'NO_EM_RESTART': '1', 05:39:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:50 INFO - 'PWD': '/builds/slave/test', 05:39:50 INFO - 'SHELL': '/bin/bash', 05:39:50 INFO - 'SHLVL': '1', 05:39:50 INFO - 'TERM': 'linux', 05:39:50 INFO - 'TMOUT': '86400', 05:39:50 INFO - 'USER': 'cltbld', 05:39:50 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468499776.15777-104712317', 05:39:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:50 INFO - '_': '/tools/buildbot/bin/python'} 05:39:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:39:50 INFO - Cleaning up... 05:39:50 INFO - Return code: 0 05:39:50 INFO - Running post-action listener: _resource_record_post_action 05:39:50 INFO - Running post-action listener: _start_resource_monitoring 05:39:50 INFO - Starting resource monitoring. 05:39:50 INFO - ##### 05:39:50 INFO - ##### Finished create-virtualenv step (success) 05:39:50 INFO - ##### 05:39:50 INFO - ##### 05:39:50 INFO - ##### Running install step. 05:39:50 INFO - ##### 05:39:50 INFO - Running pre-action listener: _resource_record_pre_action 05:39:50 INFO - Running main action method: install 05:39:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:39:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:39:51 INFO - Reading from file tmpfile_stdout 05:39:51 INFO - Detecting whether we're running mozinstall >=1.0... 05:39:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:39:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:39:51 INFO - Reading from file tmpfile_stdout 05:39:51 INFO - Output received: 05:39:51 INFO - Usage: mozinstall [options] installer 05:39:51 INFO - Options: 05:39:51 INFO - -h, --help show this help message and exit 05:39:51 INFO - -d DEST, --destination=DEST 05:39:51 INFO - Directory to install application into. [default: 05:39:51 INFO - "/builds/slave/test"] 05:39:51 INFO - --app=APP Application being installed. [default: firefox] 05:39:51 INFO - mkdir: /builds/slave/test/build/application 05:39:51 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'] 05:39:51 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 05:40:07 INFO - Reading from file tmpfile_stdout 05:40:07 INFO - Output received: 05:40:07 INFO - /builds/slave/test/build/application/firefox/firefox 05:40:07 INFO - Running post-action listener: _resource_record_post_action 05:40:07 INFO - ##### 05:40:07 INFO - ##### Finished install step (success) 05:40:07 INFO - ##### 05:40:07 INFO - ##### 05:40:07 INFO - ##### Running run-tests step. 05:40:07 INFO - ##### 05:40:07 INFO - Running pre-action listener: _resource_record_pre_action 05:40:07 INFO - Running main action method: run_tests 05:40:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:40:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:40:07 INFO - Python 2.7.3 05:40:07 INFO - Return code: 0 05:40:07 INFO - grabbing minidump binary from tooltool 05:40:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:07 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 0x27163b0>, '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 0x27172b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2717740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:40:07 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 05:40:07 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 05:40:07 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 05:40:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:40:07 INFO - Return code: 0 05:40:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:40:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:40:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:40:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:40:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:40:07 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/XqURWo3kR-OpIRp74Ia9vA/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 05:40:07 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/XqURWo3kR-OpIRp74Ia9vA/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 05:40:07 INFO - Using env: {'DISPLAY': ':0', 05:40:07 INFO - 'HOME': '/home/cltbld', 05:40:07 INFO - 'LANG': 'en_US.UTF-8', 05:40:07 INFO - 'LANGUAGE': 'en_US:en', 05:40:07 INFO - 'LOGNAME': 'cltbld', 05:40:07 INFO - 'MAIL': '/var/mail/cltbld', 05:40:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:40:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:40:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:07 INFO - 'MOZ_NO_REMOTE': '1', 05:40:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:40:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:07 INFO - 'NO_EM_RESTART': '1', 05:40:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:07 INFO - 'PWD': '/builds/slave/test', 05:40:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:40:07 INFO - 'SHELL': '/bin/bash', 05:40:07 INFO - 'SHLVL': '1', 05:40:07 INFO - 'TERM': 'linux', 05:40:07 INFO - 'TMOUT': '86400', 05:40:07 INFO - 'USER': 'cltbld', 05:40:07 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468499776.15777-104712317', 05:40:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:07 INFO - '_': '/tools/buildbot/bin/python'} 05:40:07 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/XqURWo3kR-OpIRp74Ia9vA/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 05:40:08 INFO - mozversion application_buildid: 20160714051941 05:40:08 INFO - mozversion application_changeset: 1d5210d6f9614812ebdfad13a0d6e25d4513c03e 05:40:08 INFO - mozversion application_display_name: Nightly 05:40:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:40:08 INFO - mozversion application_name: Firefox 05:40:08 INFO - mozversion application_remotingname: firefox 05:40:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:40:08 INFO - mozversion application_vendor: Mozilla 05:40:08 INFO - mozversion application_version: 50.0a1 05:40:08 INFO - mozversion platform_buildid: 20160714051941 05:40:08 INFO - mozversion platform_changeset: 1d5210d6f9614812ebdfad13a0d6e25d4513c03e 05:40:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:40:08 INFO - mozversion platform_version: 50.0a1 05:40:08 INFO - using testdate: 1468500008 05:40:08 INFO - actual date: 1468500008 05:40:08 INFO - starting webserver on 'localhost:38699' 05:40:08 INFO - SUITE-START | Running 2 tests 05:40:08 INFO - TEST-START | dromaeo_css 05:40:08 INFO - operating with platform_type : linux_ 05:40:08 INFO - Initialising browser for dromaeo_css test... 05:40:08 INFO - TEST-INFO | started process 17673 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPXnuen/profile http://localhost:38699/getInfo.html) 05:40:12 INFO - PROCESS | 17673 | __metrics Screen width/height:1600/1200 05:40:12 INFO - PROCESS | 17673 | colorDepth:24 05:40:12 INFO - PROCESS | 17673 | Browser inner width/height: 1024/697 05:40:12 INFO - PROCESS | 17673 | __metrics 05:40:13 INFO - PROCESS | 17673 | 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" 05:40:13 INFO - PROCESS | 17673 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:40:14 INFO - TEST-INFO | 17673: exit 0 05:40:14 INFO - Browser initialized. 05:40:14 INFO - Running cycle 1/1 for dromaeo_css test... 05:40:14 INFO - TEST-INFO | started process 17753 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPXnuen/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:40:26 INFO - PROCESS | 17753 | RSS: Main: 159358976 05:40:26 INFO - PROCESS | 17753 | 05:41:17 INFO - PROCESS | 17753 | 1468500077086 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] 05:43:29 INFO - PROCESS | 17753 | Cycle 1(1): loaded http://localhost:38699/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38699/tests/dromaeo/cssquery-ext.html) 05:43:30 INFO - PROCESS | 17753 | RSS: Main: 241766400 05:43:30 INFO - PROCESS | 17753 | 05:46:33 INFO - PROCESS | 17753 | Cycle 1(1): loaded http://localhost:38699/tests/dromaeo/cssquery-ext.html (next: http://localhost:38699/tests/dromaeo/cssquery-jquery.html) 05:46:34 INFO - PROCESS | 17753 | RSS: Main: 241885184 05:46:34 INFO - PROCESS | 17753 | 05:49:36 INFO - PROCESS | 17753 | Cycle 1(1): loaded http://localhost:38699/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38699/tests/dromaeo/cssquery-mootools.html) 05:49:37 INFO - PROCESS | 17753 | RSS: Main: 243945472 05:49:37 INFO - PROCESS | 17753 | 05:52:39 INFO - PROCESS | 17753 | Cycle 1(1): loaded http://localhost:38699/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38699/tests/dromaeo/cssquery-prototype.html) 05:52:40 INFO - PROCESS | 17753 | RSS: Main: 232865792 05:52:40 INFO - PROCESS | 17753 | 05:55:43 INFO - PROCESS | 17753 | Cycle 1(1): loaded http://localhost:38699/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38699/tests/dromaeo/cssquery-yui.html) 05:55:43 INFO - PROCESS | 17753 | RSS: Main: 213983232 05:55:43 INFO - PROCESS | 17753 | 05:58:46 INFO - PROCESS | 17753 | Cycle 1(1): loaded http://localhost:38699/tests/dromaeo/cssquery-yui.html (next: http://localhost:38699/tests/dromaeo/cssquery-dojo.html) 05:58:46 INFO - PROCESS | 17753 | RSS: Main: 272809984 05:58:46 INFO - PROCESS | 17753 | 05:58:46 INFO - PROCESS | 17753 | __start_tp_report 05:58:46 INFO - PROCESS | 17753 | _x_x_mozilla_page_load 05:58:46 INFO - PROCESS | 17753 | _x_x_mozilla_page_load_details 05:58:46 INFO - PROCESS | 17753 | |i|pagename|runs| 05:58:46 INFO - PROCESS | 17753 | |0;dojo.html;2670.7462791034845;2679.169457468185;2725.7274272572745;2725.9999999999995;2728.0451841855365;4465.419495465585;4529.388532548105;4767.0465906818645;4778.68938518996;4852.781624826883;4730.597899178574;4749.0264495778365;4752.477227504972;4787.281907713845;4800.879978000552;4292.656587472995;4327.4157988671595;4415.646748260147;4434.97782511087;4487.842925497608;4397.824087036514;4428.535003824601;4442.111577684476;4444.444444444444;4469.240229161034;4225.429567008446;4249.320108782611;4260.275753121977;4280.486341638992;4288.378185163165;4280.443542339476;4333.306670932667;4341.240282950503;4351.43431353922;4396.8021439035;4327.653787697008;4335.046289816235;4340.956590434118;4356.281213599752;4362.302031674917;4583.449986001668;4658.627309815207;4754.524547545252;4757.595604373632;4772.308015337791;5027.773750181251;5044.924326135111;5084.491550844923;5089.211172268304;5089.541941225308;4817.253325734517;5077.466865979056;5077.974610126926;5089.389273287229;5125.154349532323;4612.76936153191;4652.581267685924;4653.767311634405;4669.136209801198;4672.766361681903;5089.491050894881;5170.97414512925;5171.3535808024;5176.120059589879;5176.275321454999;4845.854624361275;4904.215325547895;5004.074246264453;5022.949770502321;5027.296178535008;5042.294078828967;5086.109930762102;5113.821016264413;5135.075686376414;5137;5028;5029.8491045267965;5042.218456139304;5042.268871013683;5089.236614507853;4768.499307572655;4897.2898929655;4945.950540494549;5007.148784706608;5020.196768517019;4258.318669012943;4272.700910936204;4304.655627549789;4314.245007123741;4318.395424640553;3730.477733117366;3745.8127093645207;3752.9437058444146;3785.5078839750654;3798.4492248623797;4260.552641972548;4312.741235525878;4318.805653745526;4383.1452866691325;4391.824327026947;4964.851054468371;5004.999000199975;5022.89954200914;5038.899222015539;5040.974795126001;4377.846775362847;4386;4393.428854248991;4395.252807022814;4435.556444355539;4456;4491.034427598082;4505.774711264424;4533.5013148553635;4534.229181039165;4771.475137734777;4775.140474714446;4786.401699787527;4793.23308270675;4796.8081276748535;5007.974960125176;5033.672811267256;5039.546440820343;5042.571381432619;5093.337866077386;4588.220002599633;4760.523947605212;4838.612910967185;4847.442544107473;4847.491013443538;5025.346704928336;5036.773345199402;5039.823606173766;5049.596032317332;5087.465816089258;4957.380327459067;5064.848054558369;5112.105381558138;5114.079465696211;5126.487351264993;4853.49038350968;4869.926951095807;4944.134776414185;4956.504349565159;4962.652614316963;4939.431965324034;4949.529794669501;4952.059108769322;4955.207166853286;5004.874878128076;4643.349931009594;4747.169245381975;4875.43932447773;4889.877753056202;4937.679050861682;4867.342908707279;4885.90228195427;4886.486918873467;4891.364122664031;4932.7533623319405;4802.687825291345;4809.519048095302;4810.086083644096;4812.085703716282;4841.878953026203 05:58:46 INFO - PROCESS | 17753 | |1;ext.html;535.7615860941883;571.2345457087501;581.2182614383657;584.4622946888862;587.289379850381;28146.71853281469;39936.40095398568;40631.39052914209;40634.390484142765;40685.186296274056;41201.381979270336;41352;41643.16713665725;41654.79172604133;41691.37462938058;7492.887606685904;7838.372930165573;7982.121966583672;7986.121526632066;10030;10012.098911097999;10374.896251037506;10375.84436233457;10387.532561034734;10402.167826573856;10379.636712715057;10427.739306517322;10436.112930400886;10448.26862119652;10449.791004179911;10341.482925853677;10348.482575871214;10373.222008349405;10401.427921464316;10404.739881502985;10187.694369168938;10300.12448941841;10309.948450257702;10318.845217321747;10323;38615.80692096549;38802.805985970175;38967;39015.41476877849;39024.80487597572;2911.9272018199504;2995.4757917364373;3068.819420588555;3163.920901977469;3187.7131058204873;29515.654799745676;29588.70411295881;30118.247043824078;30451.695483045107;30527;3067.754579633624;3082.660907300195;3083.383323335342;3155.4004739099496;3209.759268054882;249498;249690;249809;249862;250072.74963625247;32375.190620234684;52081.73959130256;52430;52445.47554524482;52484.21273680898;32586.674133258362;34294.82852585771;34384.484232736526;34405.82797086049;34407.139821504665;13929.442822287197;13979.510717125055;14065.71868562623;14074.577762667137;14080.577582672537;9048.321375896703;11209.775804483865;11429.314241145557;11454.48454819535;11522.251053681484;7974;7996.480228785111;7998.960005200053;8052.838943221102;8068.233517815798;3131.7964332318325;3152.9684703153134;3160.8419579020956;3162.4307624627786;3182.3794360100023;777.296546625305;864.8745931839848;868.9608967596473;880.3441436129996;945.229637845154;26613;27493;27878.442431151263;28025.859870700922;28101.71898281032;914.4239129348468;954.7279025477706;1006.758377989292;1020.3877673395903;1065.1159537583787;14273.92863035699;14451.638709032359;14590.708185836436;14764.48324308644;14819.77770333446;388337;392395;392477;392696;394289;49795.50204497909;50113.24830127551;50337.74831125821;50343;50351.24473132906;1055.37205362809;1100.2298391126244;1166.3701601135463;1179.3808250668467;1207.3963018490754;25980.35049123787;28875.278118047216;29223.70776292295;29537.26156846096;29593.112206633836;40832.591674082876;46669;48175.277370840166;48315.5168448311;52590.211146832065;353600;353871;356905;358855;358947;32115.839420802746;37324.25351493009;38085;38416.23167536689;38689.6131038686;40607.1878562433;41013.38479922863;41384;41430.792846035576;41469.79265103655;35809.1047723809;36894.8155259222;37096;37156.62843371532;37385.81307093447;35876;36279.455808163424;36556.45165322469;36822;37311.81344093262;35157.82421087878;35779.642203577634;35979.1005224861;36083.278334433686;36113.45829812502;31532.842335788173;33006.66993330132;33008.1747956303;33103.172420688716;33662.663373365955;25683.229503114937;25961.221163365128;25968.350791230372;26013.479730405663;26278.4744305109 05:58:46 INFO - PROCESS | 17753 | |2;jquery.html;339.6840937927726;357.66736934650766;365.6855104610035;371.6673577148452;372.54735496371904;12946.35268236588;16419.671606567877;16981.490555283344;18095.45713628593;18111.637767244647;17455.563610909732;17751.46745597634;18263.726044109317;18283.725744113817;18297.35959241427;4977.502249775021;5037.874053148664;5158.819441319536;5276.8153114641;5278.6568873023325;3719.79541125238;4986.5013498650205;5694.6867922264255;6016.939830601704;6046.576739628228;6072.08918662202;6101.2983506896835;6101.664408457533;6105.175801266839;6119.051547010221;5076.898462030757;5371.57027437804;5380.811671591476;5444.891102177974;5447.53695935842;3443.328550932569;5010.624203184776;5248.790048398059;5262.05283049051;5268.736563171826;11536.884631153665;11564.653060408202;12601.495940162382;21226.257081002244;21685.566288674298;1773.140027086862;1815.891046537212;1818.5180927054341;1840.0063965458637;1852.0739630184908;8601.61292741828;8755.212030917248;9310.394824336396;9740.415575065519;10851.457427128613;1756.8331008554167;1771.9911400443045;1807.629435965624;1827.9451616451527;1860.1722233606051;60698.39301606971;71115.64442177808;73955;74133.25866741317;75470;8680.739577812676;9514.714558563253;9664.565094570762;9776.853347199798;9834.608299710182;12870.613881583567;13591.388387522586;13639.931800340935;14145.292735363191;14160.150390976574;6096.329403765582;7398.741044063432;7545.50954187976;7561.7731468056045;7684;7155.821104472429;7221.638918054076;7312.634368281565;7323.304286092813;7333.74331898381;4166.125113726091;4395.340698895191;4502.414686090853;4541.227991241497;4546.227141385973;1826.954326141857;1863.1802007116826;1871.4385684294657;1893.6212757448566;1910.064068606373;746.1531162131021;828.1221904780831;834.3950635789005;875.1991927386497;881.748701620048;17081.145942703064;17259;17326.826731732774;17508.387206447715;18068;833.8040560468285;853.2576658307312;857.4683696108452;867.4708427859001;915.7573243090586;9558.713238602853;9804.558794854249;9861.112499875046;9883.703488895344;9917.603295868228;380882;383536;383738;407848;409810;81368;83281.58359208165;85013;85456;85486.572567138;924.8381533231658;936.194872409727;955.2883102088988;960.3037797596686;965.3435663748578;16139.838601613834;16366.918165409097;16499.58751031234;16642.084685342423;16809.831901680827;26369.472610548066;27184.864075680285;38819.805900970314;39050.804745976086;39367.40948885826;47776.52223477721;52523;53214.20178697245;53592.73203633957;54908.72545637406;7690.384769218337;7844.843103137791;7952.522848629101;8133.349332053303;8207.876881846658;10448.843267351147;10808.621698240839;12311.630651080482;12458.190217635825;12465.376731163587;10423.739406514898;10718.410487423267;10749.785004299714;10900.127989760958;10962.506687199255;9865;10417.895821041995;10606.46967651599;10935.726606834574;11030.28303160292;10036.498175091363;10197.796044078928;10982.670519884416;11061.557537698724;11138.27601205919;7731.690732370642;7767.417443691858;8059.274665280153;8160.632771525415;8267.586620669063;9941.850872236777;10160.695179144637;10249.641262555775;10323.535440905327;10438 05:58:46 INFO - PROCESS | 17753 | |3;mootools.html;1238.4179435665246;1390;1418.6595217147885;1500.7823865539497;1692.1370101248351;6798.89801652975;7548.584827834474;7743.767686969386;7780.533168009909;8042.91957080429;7779.260970207835;7792.649330780115;7856;7875.054993400786;7890.56601886896;1825.3063835742466;2116.1429621003517;2165.956680866386;2191.9561608767817;2193.5503221839563;2226.588081204974;2263.185253308816;2264.1735766445213;2267.0025188916907;2268.739095004079;2209.2046863129262;2214.6345852934246;2240.7535171131162;2258.7063681721434;2263.54729054189;1821.1076572479521;2063.9896800516053;2151.505153814616;2166.3176099528678;2173.5978843913927;2158.061243359128;2176.4014895903597;2178.2267295110323;2181.029441898356;2181.3564998325533;8107.432479726422;8134.389920755908;8167.305779008732;8172.223638754309;8179.100298967109;4480.059187570614;4566.474855391639;4576.290674945389;4585.770711464414;4591.058832939239;2799.8740056697497;2848.9857550712113;2870.296777289577;2880.395117025427;2881.5101432756483;830.6054624053587;864.5806783709895;883.1212943121571;886.4282537763171;891.8974317953454;10828.620998265102;10830.72923176919;10878.836817447745;10892.564297428093;10902.5093870776;4024.939625905614;4182.1844740275965;4204.663626909901;4349.086691794759;4353.172897149531;9299.767505812273;9382.95308523453;9385.62457501706;9394.671186508576;9404.576794044147;4697.647676424282;4703.788329525111;4710.505396933273;4712.481627021025;4714.316424118552;3734.533183352081;4169.854055108117;4281.293586558245;4301.741895486281;4319.43847299849;3678.576963649161;3750.662440380379;3814.732968692165;3815.626374505176;3841.2701586698995;1200.6758175292796;1229.4283158331418;1232.7103130764262;1254.4104270992618;1257.9685507862193;656.6355672601657;724.3589423360364;831.7172161465131;841.7769291137853;866.7443104284251;5172.353455818023;5260.079486089919;5268.130758424893;5387.0841956867425;5454.045542030208;883.3198437203317;894.4275663575316;898.9325800564853;904.9954750226207;921.3964853021282;3582.1223800169128;3715.8327875245677;3725.3294407006997;3748.081719978623;3760.3231418344412;9552.522373881278;10005.399676019462;10057.245706572035;10075;10087.747806304755;9909.65316213929;9930.751731206778;9946.502674866228;9955.900440995498;9965.501724913725;7446.962765186139;7670.539767613961;7672.462927595015;7681.231876812274;7684.231576842383;5253.684778913277;5274.868128296824;5348.679079255102;5367.141257398797;5397.568194544348;9252.676156334495;9258.861117083385;9267.304952128483;9278.9536052322;9359.391639543408;8997.64009439615;9389.154976052188;9448.291378146529;9470.431774093577;9478.620855165716;6971.825704357431;7144.535605185646;7145.356917877416;7147.213806481387;7153.678084486315;7323.304286092813;7691.692332306645;7727.034120734908;7781.299683028328;7791.415643826849;6878.3465570770695;6888.41448476885;6889.655517224019;7009.544379615309;7022.4382049436945;6909.619970901648;7047.6828542714675;7062.682179301841;7135.215126336203;7182.281771822776;6603.174603174603;6634.237062737847;6693.5943451875655;6702.430293425114;6704.161979752531;4415.6909016368545;4442.577955094261;4478.619317358061;4540.614047805841;4542.477615074309;4641.651876109373;4656.627469802475;4703.905921881612;4746.525347465225;4791.425028996403 05:58:46 INFO - PROCESS | 17753 | |4;prototype.html;300.1610498656256;303.0454069680506;307.6216254007572;308.19714643354064;310.44430469459667;4926.187179115442;4972.4033116026085;4979.45226025137;5002.899942001158;5020.447750747419;4888.902221955559;4898.436679781827;4905.484924082964;4920.852374428764;4969.353983982086;3693.8575626136844;3798.22136462026;3830.291396091718;3905.668018218455;3934.291827471054;3827.617238276178;3889.202713443737;3897.123147291865;3906.726529142961;3933.331333673282;3845.1540661054523;3846.1538461538416;3872.7289089763726;3882.941755873664;3890.9027274318228;3704.555453345589;3742.2889650966367;3859.337057430364;3866.4007078902814;3876.341022026262;3417.3848707232687;3417.6411476795074;3418.3505134024704;3421.623621401644;3428.5885693716664;4830;4837.685550439211;4855.708657480563;4859.764508326174;4863.003084367731;4106.958930410688;4370.235208838472;4390.846320378803;4400;4402.273624851896;5066.442691303953;5070.31550740649;5132.255822905658;5171.922421163686;5173.715445650488;3609.4946707460713;3616.945745813815;3620;3663.303972245265;3673.2653469306247;5068.062408454411;5341.7297648499625;5382.327209098863;5387.919181212285;5403.729813509309;3666.156783939709;3692.2800053989213;3692.9076773080888;3697.9630203698157;3700.833462494194;3741.513603231617;3770.0763312988493;3788.6969042476535;3811.6188381162215;3812.390017597171;4364.4980827204645;4372.825086996548;4375.5405682403525;4378.978105109454;4379.4525684289465;5015.548600625962;5074.594032477393;5077.695338279641;5084.6440749147205;5141.305923700253;1260.5273022616518;1268.3277862732766;1273.1342686972948;1282.7113899372566;1282.9422675979604;835.2649668291986;840.3991146330403;850.5158498420296;876.6318146378536;887.8845750052581;4499.257622492318;4507.729536227836;4509.864704058883;4543.136804007228;4548.408706868086;5178.042062218502;5187.144121220032;5189.6886186828915;5191.377034755778;5203.8178663746585;4365.1229971112725;4500.89728016638;4507.639388848885;4508.977455112769;4515.909681806345;2749.748864266754;2765.7372549607753;2775.195193393893;2783.7216278372002;2786.5680819473014;4939.481354457802;4949.628777841676;4962.950370496321;4963.181075122637;4969.583668654416;5133.589312854962;5266.710330931759;5273;5312.814051508179;5330.522361216596;4851.563359297751;4874.95125048745;4877.853664390074;4900.779464924087;4923.433805112386;5171.379434467888;5173.870653233699;5176;5214.357477394608;5221.712805795718;4931.5315045070665;5055.393352797688;5058.974705126598;5061.063703214917;5096.847094587169;4866.296796121329;4886.486918873467;4889.315495830516;4912.140375434356;4942.75286235694;3707.128824726241;3707.4253490708984;3710.4063349864973;3713.9814300928324;3715.5912849587066;4958.7024778513405;5179.482051794941;5232.529072383504;5244.816431424882;5259.815906443256;4988.800447982186;4995.225740010304;5034.270030845581;5034.59723222134;5039.84880453587;5022.623303252344;5036.345275114211;5048.192289233705;5057.342545469065;5084.618653601069;4799.496052914394;4908.852734417973;4959.156943319572;5135.663273210605;5150.6137039721425;4966.255061740623;5005.798608334047;5197.376314842243;5206.271122042841;5217.191335343028;5081;5093.974530127474;5094.847154585368;5104.540591346797;5140.151874940593 05:58:46 INFO - PROCESS | 17753 | |5;yui.html;607.7632018841657;634.3307810260173;643.3212960326854;716.3409663109942;721.3507842941353;12913.354332283383;13855;13879.236641984688;13885.305734713262;13895;12887.291198984052;13633.659158521043;13645.590632281048;13670.111442756239;13702.383392747326;627.4227710506345;786.3787607789839;801.7434420985287;808.6522795198063;812.0580127052621;763.8243204063069;797.4378063465272;800.4756884240832;804.452971979054;806.6007326373453;835.0980940584185;835.2357592802608;842.7219017724136;844.2486187293314;845.1337379186322;626.6302881300055;664.4949838123061;830.0661755525034;832.2301870769575;832.6003518311184;491.07432489757065;492.49273248553686;565.5334349161917;606.3875485759371;608.8660494691161;13127.0811043227;13160.341982900913;13177.275249861254;13202.603921882263;13217.867821321759;12641.620751377473;13139.46210171779;13206;13328.533501327407;13507.25710085945;11792.528298868036;11807.527698892034;11931.40342982856;12157.574484893075;12224.388780560936;4131.566185550504;4163.292240319122;4215.831366745327;4225.535191128974;4240.512341080785;58133.418665813646;58233.41766582365;58328.708356457944;58917;59035.40964590385;10187.134093602126;10214.08073273409;10318.896811031793;10330.638427654996;10401.479926003822;18642.161102750408;18726.625467490572;18737.81262187388;18744.812551874307;19311.806881931;6695.230048544382;6834.794956151323;6871.690773915186;6888.758893438706;6893.4829887758615;3532.876349327761;3583.1511209176865;3583.4624806278744;3589.6410358963894;3640.2355505344176;2741.8080734348805;2844.9189308062805;2845.9573106403423;2855.7858160638034;2876.6548014238424;453.5396572478937;457.0310940805514;463.60130287952336;470.57883194540693;473.09638590293065;474.60133487870354;477.98805029873836;481.60575134984026;494.38942905511664;502.7938545196525;7120.216776154619;7241.8551628967125;7519.172890981988;7521.0974683038385;7723.9613801931755;421.6184353160395;462.8310666606664;469.0993292877683;483.9346688197119;484.38483126429236;3430.1767575781632;3459.5329630500064;3468.4797280408143;3470.8264586771065;3576.5171701819922;75108;77335.61332193416;78490;89170.55414722885;92367;77777.61111194408;77835;78463;82424.17575824165;82975.585122074;44285.557144428145;51299;71534;74013.62993185107;74385.0758874231;8312.83374332522;8330.583470826556;8490.448120872123;8553;8671.869921951049;36300.63699362973;43488.78255608702;44848;44885.10229795451;45045.32432013588;63172;65094;66671.33328666652;67041.32958670545;67311.66344168248;10993.890061099286;11128.777424451628;11149.832752508557;11275.210735248455;11678.416079196177;11967.461464233957;12124.27254364741;12403.13178077562;12459.12786104964;12667.30329831868;11571.363575003455;12263.570775022832;12369;12514.624561263177;12926.676833078873;11178.832317515082;11305.943470282597;11323.15076369259;11493.597724079616;11741.76516469683;11183;11339.71650708706;11434.309924457306;11445.771084578095;11479.139064570023;9379.155875971195;9597.9040209597;9614.95192524033;9800.215982721507;10009.349392289478;9623.171597396473;9989.400635961865;10085.495725213857;10115.269334579321;10137.64518241858 05:58:46 INFO - PROCESS | 17753 | __end_tp_report 05:58:46 INFO - PROCESS | 17753 | __start_cc_report 05:58:46 INFO - PROCESS | 17753 | _x_x_mozilla_cycle_collect,870 05:58:46 INFO - PROCESS | 17753 | __end_cc_report 05:58:46 INFO - PROCESS | 17753 | __startTimestamp1468501126756__endTimestamp 05:58:46 INFO - PROCESS | 17753 | 05:58:46 INFO - PROCESS | 17753 | ------- Summary: start ------- 05:58:46 INFO - PROCESS | 17753 | Number of tests: 6 05:58:46 INFO - PROCESS | 17753 | 05:58:46 INFO - PROCESS | 17753 | [#0] dojo.html Cycles:165 Average:4667.18 Median:4796.81 stddev:478.26 (10.0%) stddev-sans-first:453.36 05:58:46 INFO - PROCESS | 17753 | Values: 2670.7 2679.2 2725.7 2726.0 2728.0 4465.4 4529.4 4767.0 4778.7 4852.8 4730.6 4749.0 4752.5 4787.3 4800.9 4292.7 4327.4 4415.6 4435.0 4487.8 4397.8 4428.5 4442.1 4444.4 4469.2 4225.4 4249.3 4260.3 4280.5 4288.4 4280.4 4333.3 4341.2 4351.4 4396.8 4327.7 4335.0 4341.0 4356.3 4362.3 4583.4 4658.6 4754.5 4757.6 4772.3 5027.8 5044.9 5084.5 5089.2 5089.5 4817.3 5077.5 5078.0 5089.4 5125.2 4612.8 4652.6 4653.8 4669.1 4672.8 5089.5 5171.0 5171.4 5176.1 5176.3 4845.9 4904.2 5004.1 5022.9 5027.3 5042.3 5086.1 5113.8 5135.1 5137.0 5028.0 5029.8 5042.2 5042.3 5089.2 4768.5 4897.3 4946.0 5007.1 5020.2 4258.3 4272.7 4304.7 4314.2 4318.4 3730.5 3745.8 3752.9 3785.5 3798.4 4260.6 4312.7 4318.8 4383.1 4391.8 4964.9 5005.0 5022.9 5038.9 5041.0 4377.8 4386.0 4393.4 4395.3 4435.6 4456.0 4491.0 4505.8 4533.5 4534.2 4771.5 4775.1 4786.4 4793.2 4796.8 5008.0 5033.7 5039.5 5042.6 5093.3 4588.2 4760.5 4838.6 4847.4 4847.5 5025.3 5036.8 5039.8 5049.6 5087.5 4957.4 5064.8 5112.1 5114.1 5126.5 4853.5 4869.9 4944.1 4956.5 4962.7 4939.4 4949.5 4952.1 4955.2 5004.9 4643.3 4747.2 4875.4 4889.9 4937.7 4867.3 4885.9 4886.5 4891.4 4932.8 4802.7 4809.5 4810.1 4812.1 4841.9 05:58:46 INFO - PROCESS | 17753 | 05:58:46 INFO - PROCESS | 17753 | [#1] ext.html Cycles:180 Average:48311.14 Median:33382.92 stddev:89156.67 (267.1%) stddev-sans-first:89334.62 05:58:46 INFO - PROCESS | 17753 | Values: 535.8 571.2 581.2 584.5 587.3 28146.7 39936.4 40631.4 40634.4 40685.2 41201.4 41352.0 41643.2 41654.8 41691.4 7492.9 7838.4 7982.1 7986.1 10030.0 10012.1 10374.9 10375.8 10387.5 10402.2 10379.6 10427.7 10436.1 10448.3 10449.8 10341.5 10348.5 10373.2 10401.4 10404.7 10187.7 10300.1 10309.9 10318.8 10323.0 38615.8 38802.8 38967.0 39015.4 39024.8 2911.9 2995.5 3068.8 3163.9 3187.7 29515.7 29588.7 30118.2 30451.7 30527.0 3067.8 3082.7 3083.4 3155.4 3209.8 249498.0 249690.0 249809.0 249862.0 250072.7 32375.2 52081.7 52430.0 52445.5 52484.2 32586.7 34294.8 34384.5 34405.8 34407.1 13929.4 13979.5 14065.7 14074.6 14080.6 9048.3 11209.8 11429.3 11454.5 11522.3 7974.0 7996.5 7999.0 8052.8 8068.2 3131.8 3153.0 3160.8 3162.4 3182.4 777.3 864.9 869.0 880.3 945.2 26613.0 27493.0 27878.4 28025.9 28101.7 914.4 954.7 1006.8 1020.4 1065.1 14273.9 14451.6 14590.7 14764.5 14819.8 388337.0 392395.0 392477.0 392696.0 394289.0 49795.5 50113.2 50337.7 50343.0 50351.2 1055.4 1100.2 1166.4 1179.4 1207.4 25980.4 28875.3 29223.7 29537.3 29593.1 40832.6 46669.0 48175.3 48315.5 52590.2 353600.0 353871.0 356905.0 358855.0 358947.0 32115.8 37324.3 38085.0 38416.2 38689.6 40607.2 41013.4 41384.0 41430.8 41469.8 35809.1 36894.8 37096.0 37156.6 37385.8 35876.0 36279.5 36556.5 36822.0 37311.8 35157.8 35779.6 35979.1 36083.3 36113.5 31532.8 33006.7 33008.2 33103.2 33662.7 25683.2 25961.2 25968.4 26013.5 26278.5 05:58:46 INFO - PROCESS | 17753 | 05:58:46 INFO - PROCESS | 17753 | [#2] jquery.html Cycles:180 Average:24600.55 Median:26161.37 stddev:65154.53 (249.0%) stddev-sans-first:65311.85 05:58:46 INFO - PROCESS | 17753 | Values: 339.7 357.7 365.7 371.7 372.5 12946.4 16419.7 16981.5 18095.5 18111.6 17455.6 17751.5 18263.7 18283.7 18297.4 4977.5 5037.9 5158.8 5276.8 5278.7 3719.8 4986.5 5694.7 6016.9 6046.6 6072.1 6101.3 6101.7 6105.2 6119.1 5076.9 5371.6 5380.8 5444.9 5447.5 3443.3 5010.6 5248.8 5262.1 5268.7 11536.9 11564.7 12601.5 21226.3 21685.6 1773.1 1815.9 1818.5 1840.0 1852.1 8601.6 8755.2 9310.4 9740.4 10851.5 1756.8 1772.0 1807.6 1827.9 1860.2 60698.4 71115.6 73955.0 74133.3 75470.0 8680.7 9514.7 9664.6 9776.9 9834.6 12870.6 13591.4 13639.9 14145.3 14160.2 6096.3 7398.7 7545.5 7561.8 7684.0 7155.8 7221.6 7312.6 7323.3 7333.7 4166.1 4395.3 4502.4 4541.2 4546.2 1827.0 1863.2 1871.4 1893.6 1910.1 746.2 828.1 834.4 875.2 881.7 17081.1 17259.0 17326.8 17508.4 18068.0 833.8 853.3 857.5 867.5 915.8 9558.7 9804.6 9861.1 9883.7 9917.6 380882.0 383536.0 383738.0 407848.0 409810.0 81368.0 83281.6 85013.0 85456.0 85486.6 924.8 936.2 955.3 960.3 965.3 16139.8 16366.9 16499.6 16642.1 16809.8 26369.5 27184.9 38819.8 39050.8 39367.4 47776.5 52523.0 53214.2 53592.7 54908.7 7690.4 7844.8 7952.5 8133.3 8207.9 10448.8 10808.6 12311.6 12458.2 12465.4 10423.7 10718.4 10749.8 10900.1 10962.5 9865.0 10417.9 10606.5 10935.7 11030.3 10036.5 10197.8 10982.7 11061.6 11138.3 7731.7 7767.4 8059.3 8160.6 8267.6 9941.9 10160.7 10249.6 10323.5 10438.0 05:58:46 INFO - PROCESS | 17753 | 05:58:46 INFO - PROCESS | 17753 | [#3] mootools.html Cycles:180 Average:5259.37 Median:5256.88 stddev:2991.04 (56.9%) stddev-sans-first:2984.16 05:58:46 INFO - PROCESS | 17753 | Values: 1238.4 1390.0 1418.7 1500.8 1692.1 6798.9 7548.6 7743.8 7780.5 8042.9 7779.3 7792.6 7856.0 7875.1 7890.6 1825.3 2116.1 2166.0 2192.0 2193.6 2226.6 2263.2 2264.2 2267.0 2268.7 2209.2 2214.6 2240.8 2258.7 2263.5 1821.1 2064.0 2151.5 2166.3 2173.6 2158.1 2176.4 2178.2 2181.0 2181.4 8107.4 8134.4 8167.3 8172.2 8179.1 4480.1 4566.5 4576.3 4585.8 4591.1 2799.9 2849.0 2870.3 2880.4 2881.5 830.6 864.6 883.1 886.4 891.9 10828.6 10830.7 10878.8 10892.6 10902.5 4024.9 4182.2 4204.7 4349.1 4353.2 9299.8 9383.0 9385.6 9394.7 9404.6 4697.6 4703.8 4710.5 4712.5 4714.3 3734.5 4169.9 4281.3 4301.7 4319.4 3678.6 3750.7 3814.7 3815.6 3841.3 1200.7 1229.4 1232.7 1254.4 1258.0 656.6 724.4 831.7 841.8 866.7 5172.4 5260.1 5268.1 5387.1 5454.0 883.3 894.4 898.9 905.0 921.4 3582.1 3715.8 3725.3 3748.1 3760.3 9552.5 10005.4 10057.2 10075.0 10087.7 9909.7 9930.8 9946.5 9955.9 9965.5 7447.0 7670.5 7672.5 7681.2 7684.2 5253.7 5274.9 5348.7 5367.1 5397.6 9252.7 9258.9 9267.3 9279.0 9359.4 8997.6 9389.2 9448.3 9470.4 9478.6 6971.8 7144.5 7145.4 7147.2 7153.7 7323.3 7691.7 7727.0 7781.3 7791.4 6878.3 6888.4 6889.7 7009.5 7022.4 6909.6 7047.7 7062.7 7135.2 7182.3 6603.2 6634.2 6693.6 6702.4 6704.2 4415.7 4442.6 4478.6 4540.6 4542.5 4641.7 4656.6 4703.9 4746.5 4791.4 05:58:46 INFO - PROCESS | 17753 | 05:58:46 INFO - PROCESS | 17753 | [#4] prototype.html Cycles:180 Average:4241.97 Median:4887.69 stddev:1224.46 (25.1%) stddev-sans-first:1191.62 05:58:46 INFO - PROCESS | 17753 | Values: 300.2 303.0 307.6 308.2 310.4 4926.2 4972.4 4979.5 5002.9 5020.4 4888.9 4898.4 4905.5 4920.9 4969.4 3693.9 3798.2 3830.3 3905.7 3934.3 3827.6 3889.2 3897.1 3906.7 3933.3 3845.2 3846.2 3872.7 3882.9 3890.9 3704.6 3742.3 3859.3 3866.4 3876.3 3417.4 3417.6 3418.4 3421.6 3428.6 4830.0 4837.7 4855.7 4859.8 4863.0 4107.0 4370.2 4390.8 4400.0 4402.3 5066.4 5070.3 5132.3 5171.9 5173.7 3609.5 3616.9 3620.0 3663.3 3673.3 5068.1 5341.7 5382.3 5387.9 5403.7 3666.2 3692.3 3692.9 3698.0 3700.8 3741.5 3770.1 3788.7 3811.6 3812.4 4364.5 4372.8 4375.5 4379.0 4379.5 5015.5 5074.6 5077.7 5084.6 5141.3 1260.5 1268.3 1273.1 1282.7 1282.9 835.3 840.4 850.5 876.6 887.9 4499.3 4507.7 4509.9 4543.1 4548.4 5178.0 5187.1 5189.7 5191.4 5203.8 4365.1 4500.9 4507.6 4509.0 4515.9 2749.7 2765.7 2775.2 2783.7 2786.6 4939.5 4949.6 4963.0 4963.2 4969.6 5133.6 5266.7 5273.0 5312.8 5330.5 4851.6 4875.0 4877.9 4900.8 4923.4 5171.4 5173.9 5176.0 5214.4 5221.7 4931.5 5055.4 5059.0 5061.1 5096.8 4866.3 4886.5 4889.3 4912.1 4942.8 3707.1 3707.4 3710.4 3714.0 3715.6 4958.7 5179.5 5232.5 5244.8 5259.8 4988.8 4995.2 5034.3 5034.6 5039.8 5022.6 5036.3 5048.2 5057.3 5084.6 4799.5 4908.9 4959.2 5135.7 5150.6 4966.3 5005.8 5197.4 5206.3 5217.2 5081.0 5094.0 5094.8 5104.5 5140.2 05:58:46 INFO - PROCESS | 17753 | 05:58:46 INFO - PROCESS | 17753 | [#5] yui.html Cycles:180 Average:16900.26 Median:22749.43 stddev:23131.52 (101.7%) stddev-sans-first:23164.06 05:58:46 INFO - PROCESS | 17753 | Values: 607.8 634.3 643.3 716.3 721.4 12913.4 13855.0 13879.2 13885.3 13895.0 12887.3 13633.7 13645.6 13670.1 13702.4 627.4 786.4 801.7 808.7 812.1 763.8 797.4 800.5 804.5 806.6 835.1 835.2 842.7 844.2 845.1 626.6 664.5 830.1 832.2 832.6 491.1 492.5 565.5 606.4 608.9 13127.1 13160.3 13177.3 13202.6 13217.9 12641.6 13139.5 13206.0 13328.5 13507.3 11792.5 11807.5 11931.4 12157.6 12224.4 4131.6 4163.3 4215.8 4225.5 4240.5 58133.4 58233.4 58328.7 58917.0 59035.4 10187.1 10214.1 10318.9 10330.6 10401.5 18642.2 18726.6 18737.8 18744.8 19311.8 6695.2 6834.8 6871.7 6888.8 6893.5 3532.9 3583.2 3583.5 3589.6 3640.2 2741.8 2844.9 2846.0 2855.8 2876.7 453.5 457.0 463.6 470.6 473.1 474.6 478.0 481.6 494.4 502.8 7120.2 7241.9 7519.2 7521.1 7724.0 421.6 462.8 469.1 483.9 484.4 3430.2 3459.5 3468.5 3470.8 3576.5 75108.0 77335.6 78490.0 89170.6 92367.0 77777.6 77835.0 78463.0 82424.2 82975.6 44285.6 51299.0 71534.0 74013.6 74385.1 8312.8 8330.6 8490.4 8553.0 8671.9 36300.6 43488.8 44848.0 44885.1 45045.3 63172.0 65094.0 66671.3 67041.3 67311.7 10993.9 11128.8 11149.8 11275.2 11678.4 11967.5 12124.3 12403.1 12459.1 12667.3 11571.4 12263.6 12369.0 12514.6 12926.7 11178.8 11305.9 11323.2 11493.6 11741.8 11183.0 11339.7 11434.3 11445.8 11479.1 9379.2 9597.9 9615.0 9800.2 10009.3 9623.2 9989.4 10085.5 10115.3 10137.6 05:58:46 INFO - PROCESS | 17753 | -------- Summary: end -------- 05:58:46 INFO - PROCESS | 17753 | 05:58:47 INFO - TEST-INFO | 17753: exit 0 05:58:47 INFO - TEST-OK | dromaeo_css | took 1119522ms 05:58:47 INFO - TEST-START | kraken 05:58:47 INFO - operating with platform_type : linux_ 05:58:47 INFO - Initialising browser for kraken test... 05:58:47 INFO - TEST-INFO | started process 17942 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLt2dFz/profile http://localhost:38699/getInfo.html) 05:58:51 INFO - PROCESS | 17942 | __metrics Screen width/height:1600/1200 05:58:51 INFO - PROCESS | 17942 | colorDepth:24 05:58:51 INFO - PROCESS | 17942 | Browser inner width/height: 1024/697 05:58:51 INFO - PROCESS | 17942 | __metrics 05:58:52 INFO - PROCESS | 17942 | 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" 05:58:52 INFO - PROCESS | 17942 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:58:53 INFO - PROCESS | 17942 | console.error: PushService: 05:58:53 INFO - PROCESS | 17942 | stateChangeProcessEnqueue: Error transitioning state 05:58:53 INFO - PROCESS | 17942 | UnknownError 05:58:53 INFO - TEST-INFO | 17942: exit 0 05:58:53 INFO - Browser initialized. 05:58:53 INFO - Running cycle 1/1 for kraken test... 05:58:53 INFO - TEST-INFO | started process 18025 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLt2dFz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:59:05 INFO - PROCESS | 18025 | RSS: Main: 158781440 05:59:05 INFO - PROCESS | 18025 | 05:59:08 INFO - PROCESS | 18025 | Cycle 1(1): loaded http://localhost:38699/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38699/tests/kraken/driver.html?testName=audio-beat-detection) 05:59:09 INFO - PROCESS | 18025 | RSS: Main: 217653248 05:59:09 INFO - PROCESS | 18025 | 05:59:12 INFO - PROCESS | 18025 | Cycle 1(1): loaded http://localhost:38699/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38699/tests/kraken/driver.html?testName=audio-dft) 05:59:12 INFO - PROCESS | 18025 | RSS: Main: 205303808 05:59:12 INFO - PROCESS | 18025 | 05:59:16 INFO - PROCESS | 18025 | Cycle 1(1): loaded http://localhost:38699/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38699/tests/kraken/driver.html?testName=audio-fft) 05:59:16 INFO - PROCESS | 18025 | RSS: Main: 270823424 05:59:16 INFO - PROCESS | 18025 | 05:59:18 INFO - PROCESS | 18025 | Cycle 1(1): loaded http://localhost:38699/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38699/tests/kraken/driver.html?testName=audio-oscillator) 05:59:19 INFO - PROCESS | 18025 | RSS: Main: 181891072 05:59:19 INFO - PROCESS | 18025 | 05:59:21 INFO - PROCESS | 18025 | Cycle 1(1): loaded http://localhost:38699/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38699/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:59:22 INFO - PROCESS | 18025 | RSS: Main: 186544128 05:59:22 INFO - PROCESS | 18025 | 05:59:25 INFO - PROCESS | 18025 | Cycle 1(1): loaded http://localhost:38699/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38699/tests/kraken/driver.html?testName=imaging-darkroom) 05:59:25 INFO - PROCESS | 18025 | RSS: Main: 221810688 05:59:25 INFO - PROCESS | 18025 | 05:59:29 INFO - PROCESS | 18025 | Cycle 1(1): loaded http://localhost:38699/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38699/tests/kraken/driver.html?testName=imaging-desaturate) 05:59:30 INFO - PROCESS | 18025 | RSS: Main: 217972736 05:59:30 INFO - PROCESS | 18025 | 05:59:32 INFO - PROCESS | 18025 | Cycle 1(1): loaded http://localhost:38699/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38699/tests/kraken/driver.html?testName=json-parse-financial) 05:59:33 INFO - PROCESS | 18025 | RSS: Main: 221040640 05:59:33 INFO - PROCESS | 18025 | 05:59:35 INFO - PROCESS | 18025 | Cycle 1(1): loaded http://localhost:38699/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38699/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:59:35 INFO - PROCESS | 18025 | RSS: Main: 209207296 05:59:35 INFO - PROCESS | 18025 | 05:59:37 INFO - PROCESS | 18025 | Cycle 1(1): loaded http://localhost:38699/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38699/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:59:38 INFO - PROCESS | 18025 | RSS: Main: 214454272 05:59:38 INFO - PROCESS | 18025 | 05:59:40 INFO - PROCESS | 18025 | Cycle 1(1): loaded http://localhost:38699/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38699/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:59:41 INFO - PROCESS | 18025 | RSS: Main: 210145280 05:59:41 INFO - PROCESS | 18025 | 05:59:44 INFO - PROCESS | 18025 | Cycle 1(1): loaded http://localhost:38699/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38699/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:59:44 INFO - PROCESS | 18025 | RSS: Main: 224141312 05:59:44 INFO - PROCESS | 18025 | 05:59:47 INFO - PROCESS | 18025 | Cycle 1(1): loaded http://localhost:38699/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38699/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:59:48 INFO - PROCESS | 18025 | RSS: Main: 225210368 05:59:48 INFO - PROCESS | 18025 | 05:59:49 INFO - PROCESS | 18025 | Cycle 1(1): loaded http://localhost:38699/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38699/tests/kraken/driver.html?testName=ai-astar) 05:59:50 INFO - PROCESS | 18025 | RSS: Main: 267493376 05:59:50 INFO - PROCESS | 18025 | 05:59:50 INFO - PROCESS | 18025 | __start_tp_report 05:59:50 INFO - PROCESS | 18025 | _x_x_mozilla_page_load 05:59:50 INFO - PROCESS | 18025 | _x_x_mozilla_page_load_details 05:59:50 INFO - PROCESS | 18025 | |i|pagename|runs| 05:59:50 INFO - PROCESS | 18025 | |0;ai-astar;103;115;113;114;113;112;112;112;113;113 05:59:50 INFO - PROCESS | 18025 | |1;audio-beat-detection;154;121;125;174;123;124;144;127;160;127 05:59:50 INFO - PROCESS | 18025 | |2;audio-dft;160;162;160;160;162;162;161;162;160;161 05:59:50 INFO - PROCESS | 18025 | |3;audio-fft;75;75;75;110;77;77;74;76;104;78 05:59:50 INFO - PROCESS | 18025 | |4;audio-oscillator;86;86;125;85;85;86;120;83;85;134 05:59:50 INFO - PROCESS | 18025 | |5;imaging-gaussian-blur;118;116;117;117;117;117;116;117;117;117 05:59:50 INFO - PROCESS | 18025 | |6;imaging-darkroom;146;148;146;146;148;148;146;147;146;145 05:59:50 INFO - PROCESS | 18025 | |7;imaging-desaturate;95;95;95;95;95;95;96;95;95;95 05:59:50 INFO - PROCESS | 18025 | |8;json-parse-financial;66;68;67;68;67;68;66;66;66;65 05:59:50 INFO - PROCESS | 18025 | |9;json-stringify-tinderbox;67;66;66;65;65;65;65;65;69;66 05:59:50 INFO - PROCESS | 18025 | |10;stanford-crypto-aes;80;80;78;81;84;83;83;79;81;82 05:59:50 INFO - PROCESS | 18025 | |11;stanford-crypto-ccm;127;126;129;131;128;141;127;132;173;137 05:59:50 INFO - PROCESS | 18025 | |12;stanford-crypto-pbkdf2;163;167;164;166;168;165;165;164;162;170 05:59:50 INFO - PROCESS | 18025 | |13;stanford-crypto-sha256-iterative;66;67;66;66;65;65;68;67;68;65 05:59:50 INFO - PROCESS | 18025 | __end_tp_report 05:59:50 INFO - PROCESS | 18025 | __start_cc_report 05:59:50 INFO - PROCESS | 18025 | _x_x_mozilla_cycle_collect,1912 05:59:50 INFO - PROCESS | 18025 | __end_cc_report 05:59:50 INFO - PROCESS | 18025 | __startTimestamp1468501190057__endTimestamp 05:59:50 INFO - PROCESS | 18025 | 05:59:50 INFO - PROCESS | 18025 | ------- Summary: start ------- 05:59:50 INFO - PROCESS | 18025 | Number of tests: 14 05:59:50 INFO - PROCESS | 18025 | 05:59:50 INFO - PROCESS | 18025 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:3.30 (2.9%) stddev-sans-first:1.00 05:59:50 INFO - PROCESS | 18025 | Values: 103.0 115.0 113.0 114.0 113.0 112.0 112.0 112.0 113.0 113.0 05:59:50 INFO - PROCESS | 18025 | 05:59:50 INFO - PROCESS | 18025 | [#1] audio-beat-detection Cycles:10 Average:137.90 Median:135.50 stddev:18.84 (13.9%) stddev-sans-first:19.06 05:59:50 INFO - PROCESS | 18025 | Values: 154.0 121.0 125.0 174.0 123.0 124.0 144.0 127.0 160.0 127.0 05:59:50 INFO - PROCESS | 18025 | 05:59:50 INFO - PROCESS | 18025 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:0.94 (0.6%) stddev-sans-first:0.93 05:59:50 INFO - PROCESS | 18025 | Values: 160.0 162.0 160.0 160.0 162.0 162.0 161.0 162.0 160.0 161.0 05:59:50 INFO - PROCESS | 18025 | 05:59:50 INFO - PROCESS | 18025 | [#3] audio-fft Cycles:10 Average:82.10 Median:75.50 stddev:13.25 (17.6%) stddev-sans-first:13.81 05:59:50 INFO - PROCESS | 18025 | Values: 75.0 75.0 75.0 110.0 77.0 77.0 74.0 76.0 104.0 78.0 05:59:50 INFO - PROCESS | 18025 | 05:59:50 INFO - PROCESS | 18025 | [#4] audio-oscillator Cycles:10 Average:97.50 Median:85.00 stddev:20.19 (23.8%) stddev-sans-first:20.99 05:59:50 INFO - PROCESS | 18025 | Values: 86.0 86.0 125.0 85.0 85.0 86.0 120.0 83.0 85.0 134.0 05:59:50 INFO - PROCESS | 18025 | 05:59:50 INFO - PROCESS | 18025 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 05:59:50 INFO - PROCESS | 18025 | Values: 118.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 05:59:50 INFO - PROCESS | 18025 | 05:59:50 INFO - PROCESS | 18025 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:146.50 stddev:1.07 (0.7%) stddev-sans-first:1.12 05:59:50 INFO - PROCESS | 18025 | Values: 146.0 148.0 146.0 146.0 148.0 148.0 146.0 147.0 146.0 145.0 05:59:50 INFO - PROCESS | 18025 | 05:59:50 INFO - PROCESS | 18025 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 05:59:50 INFO - PROCESS | 18025 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 05:59:50 INFO - PROCESS | 18025 | 05:59:50 INFO - PROCESS | 18025 | [#8] json-parse-financial Cycles:10 Average:66.70 Median:67.00 stddev:1.06 (1.6%) stddev-sans-first:1.09 05:59:50 INFO - PROCESS | 18025 | Values: 66.0 68.0 67.0 68.0 67.0 68.0 66.0 66.0 66.0 65.0 05:59:50 INFO - PROCESS | 18025 | 05:59:50 INFO - PROCESS | 18025 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:1.29 (1.9%) stddev-sans-first:1.30 05:59:50 INFO - PROCESS | 18025 | Values: 67.0 66.0 66.0 65.0 65.0 65.0 65.0 65.0 69.0 66.0 05:59:50 INFO - PROCESS | 18025 | 05:59:50 INFO - PROCESS | 18025 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:81.50 stddev:1.91 (2.3%) stddev-sans-first:1.99 05:59:50 INFO - PROCESS | 18025 | Values: 80.0 80.0 78.0 81.0 84.0 83.0 83.0 79.0 81.0 82.0 05:59:50 INFO - PROCESS | 18025 | 05:59:50 INFO - PROCESS | 18025 | [#11] stanford-crypto-ccm Cycles:10 Average:135.10 Median:131.50 stddev:14.15 (10.8%) stddev-sans-first:14.71 05:59:50 INFO - PROCESS | 18025 | Values: 127.0 126.0 129.0 131.0 128.0 141.0 127.0 132.0 173.0 137.0 05:59:50 INFO - PROCESS | 18025 | 05:59:50 INFO - PROCESS | 18025 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.40 Median:165.50 stddev:2.41 (1.5%) stddev-sans-first:2.40 05:59:50 INFO - PROCESS | 18025 | Values: 163.0 167.0 164.0 166.0 168.0 165.0 165.0 164.0 162.0 170.0 05:59:50 INFO - PROCESS | 18025 | 05:59:50 INFO - PROCESS | 18025 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:1.16 (1.7%) stddev-sans-first:1.22 05:59:50 INFO - PROCESS | 18025 | Values: 66.0 67.0 66.0 66.0 65.0 65.0 68.0 67.0 68.0 65.0 05:59:50 INFO - PROCESS | 18025 | -------- Summary: end -------- 05:59:50 INFO - PROCESS | 18025 | 05:59:51 INFO - TEST-INFO | 18025: exit 0 05:59:51 INFO - TEST-OK | kraken | took 63609ms 05:59:51 INFO - SUITE-END | took 1183s 05:59:51 INFO - Completed test suite (00:19:43) 05:59:51 INFO - javascript benchmark 05:59:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2670.7462791034845, 2679.169457468185, 2725.7274272572745, 2725.9999999999995, 2728.0451841855365, 4465.419495465585, 4529.388532548105, 4767.0465906818645, 4778.68938518996, 4852.781624826883, 4730.597899178574, 4749.0264495778365, 4752.477227504972, 4787.281907713845, 4800.879978000552, 4292.656587472995, 4327.4157988671595, 4415.646748260147, 4434.97782511087, 4487.842925497608, 4397.824087036514, 4428.535003824601, 4442.111577684476, 4444.444444444444, 4469.240229161034, 4225.429567008446, 4249.320108782611, 4260.275753121977, 4280.486341638992, 4288.378185163165, 4280.443542339476, 4333.306670932667, 4341.240282950503, 4351.43431353922, 4396.8021439035, 4327.653787697008, 4335.046289816235, 4340.956590434118, 4356.281213599752, 4362.302031674917, 4583.449986001668, 4658.627309815207, 4754.524547545252, 4757.595604373632, 4772.308015337791, 5027.773750181251, 5044.924326135111, 5084.491550844923, 5089.211172268304, 5089.541941225308, 4817.253325734517, 5077.466865979056, 5077.974610126926, 5089.389273287229, 5125.154349532323, 4612.76936153191, 4652.581267685924, 4653.767311634405, 4669.136209801198, 4672.766361681903, 5089.491050894881, 5170.97414512925, 5171.3535808024, 5176.120059589879, 5176.275321454999, 4845.854624361275, 4904.215325547895, 5004.074246264453, 5022.949770502321, 5027.296178535008, 5042.294078828967, 5086.109930762102, 5113.821016264413, 5135.075686376414, 5137.0, 5028.0, 5029.8491045267965, 5042.218456139304, 5042.268871013683, 5089.236614507853, 4768.499307572655, 4897.2898929655, 4945.950540494549, 5007.148784706608, 5020.196768517019, 4258.318669012943, 4272.700910936204, 4304.655627549789, 4314.245007123741, 4318.395424640553, 3730.477733117366, 3745.8127093645207, 3752.9437058444146, 3785.5078839750654, 3798.4492248623797, 4260.552641972548, 4312.741235525878, 4318.805653745526, 4383.1452866691325, 4391.824327026947, 4964.851054468371, 5004.999000199975, 5022.89954200914, 5038.899222015539, 5040.974795126001, 4377.846775362847, 4386.0, 4393.428854248991, 4395.252807022814, 4435.556444355539, 4456.0, 4491.034427598082, 4505.774711264424, 4533.5013148553635, 4534.229181039165, 4771.475137734777, 4775.140474714446, 4786.401699787527, 4793.23308270675, 4796.8081276748535, 5007.974960125176, 5033.672811267256, 5039.546440820343, 5042.571381432619, 5093.337866077386, 4588.220002599633, 4760.523947605212, 4838.612910967185, 4847.442544107473, 4847.491013443538, 5025.346704928336, 5036.773345199402, 5039.823606173766, 5049.596032317332, 5087.465816089258, 4957.380327459067, 5064.848054558369, 5112.105381558138, 5114.079465696211, 5126.487351264993, 4853.49038350968, 4869.926951095807, 4944.134776414185, 4956.504349565159, 4962.652614316963, 4939.431965324034, 4949.529794669501, 4952.059108769322, 4955.207166853286, 5004.874878128076, 4643.349931009594, 4747.169245381975, 4875.43932447773, 4889.877753056202, 4937.679050861682, 4867.342908707279, 4885.90228195427, 4886.486918873467, 4891.364122664031, 4932.7533623319405, 4802.687825291345, 4809.519048095302, 4810.086083644096, 4812.085703716282, 4841.878953026203], "value": 4637.8500066687275, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [535.7615860941883, 571.2345457087501, 581.2182614383657, 584.4622946888862, 587.289379850381, 28146.71853281469, 39936.40095398568, 40631.39052914209, 40634.390484142765, 40685.186296274056, 41201.381979270336, 41352.0, 41643.16713665725, 41654.79172604133, 41691.37462938058, 7492.887606685904, 7838.372930165573, 7982.121966583672, 7986.121526632066, 10030.0, 10012.098911097999, 10374.896251037506, 10375.84436233457, 10387.532561034734, 10402.167826573856, 10379.636712715057, 10427.739306517322, 10436.112930400886, 10448.26862119652, 10449.791004179911, 10341.482925853677, 10348.482575871214, 10373.222008349405, 10401.427921464316, 10404.739881502985, 10187.694369168938, 10300.12448941841, 10309.948450257702, 10318.845217321747, 10323.0, 38615.80692096549, 38802.805985970175, 38967.0, 39015.41476877849, 39024.80487597572, 2911.9272018199504, 2995.4757917364373, 3068.819420588555, 3163.920901977469, 3187.7131058204873, 29515.654799745676, 29588.70411295881, 30118.247043824078, 30451.695483045107, 30527.0, 3067.754579633624, 3082.660907300195, 3083.383323335342, 3155.4004739099496, 3209.759268054882, 249498.0, 249690.0, 249809.0, 249862.0, 250072.74963625247, 32375.190620234684, 52081.73959130256, 52430.0, 52445.47554524482, 52484.21273680898, 32586.674133258362, 34294.82852585771, 34384.484232736526, 34405.82797086049, 34407.139821504665, 13929.442822287197, 13979.510717125055, 14065.71868562623, 14074.577762667137, 14080.577582672537, 9048.321375896703, 11209.775804483865, 11429.314241145557, 11454.48454819535, 11522.251053681484, 7974.0, 7996.480228785111, 7998.960005200053, 8052.838943221102, 8068.233517815798, 3131.7964332318325, 3152.9684703153134, 3160.8419579020956, 3162.4307624627786, 3182.3794360100023, 777.296546625305, 864.8745931839848, 868.9608967596473, 880.3441436129996, 945.229637845154, 26613.0, 27493.0, 27878.442431151263, 28025.859870700922, 28101.71898281032, 914.4239129348468, 954.7279025477706, 1006.758377989292, 1020.3877673395903, 1065.1159537583787, 14273.92863035699, 14451.638709032359, 14590.708185836436, 14764.48324308644, 14819.77770333446, 388337.0, 392395.0, 392477.0, 392696.0, 394289.0, 49795.50204497909, 50113.24830127551, 50337.74831125821, 50343.0, 50351.24473132906, 1055.37205362809, 1100.2298391126244, 1166.3701601135463, 1179.3808250668467, 1207.3963018490754, 25980.35049123787, 28875.278118047216, 29223.70776292295, 29537.26156846096, 29593.112206633836, 40832.591674082876, 46669.0, 48175.277370840166, 48315.5168448311, 52590.211146832065, 353600.0, 353871.0, 356905.0, 358855.0, 358947.0, 32115.839420802746, 37324.25351493009, 38085.0, 38416.23167536689, 38689.6131038686, 40607.1878562433, 41013.38479922863, 41384.0, 41430.792846035576, 41469.79265103655, 35809.1047723809, 36894.8155259222, 37096.0, 37156.62843371532, 37385.81307093447, 35876.0, 36279.455808163424, 36556.45165322469, 36822.0, 37311.81344093262, 35157.82421087878, 35779.642203577634, 35979.1005224861, 36083.278334433686, 36113.45829812502, 31532.842335788173, 33006.66993330132, 33008.1747956303, 33103.172420688716, 33662.663373365955, 25683.229503114937, 25961.221163365128, 25968.350791230372, 26013.479730405663, 26278.4744305109], "value": 17287.470052284763, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.6840937927726, 357.66736934650766, 365.6855104610035, 371.6673577148452, 372.54735496371904, 12946.35268236588, 16419.671606567877, 16981.490555283344, 18095.45713628593, 18111.637767244647, 17455.563610909732, 17751.46745597634, 18263.726044109317, 18283.725744113817, 18297.35959241427, 4977.502249775021, 5037.874053148664, 5158.819441319536, 5276.8153114641, 5278.6568873023325, 3719.79541125238, 4986.5013498650205, 5694.6867922264255, 6016.939830601704, 6046.576739628228, 6072.08918662202, 6101.2983506896835, 6101.664408457533, 6105.175801266839, 6119.051547010221, 5076.898462030757, 5371.57027437804, 5380.811671591476, 5444.891102177974, 5447.53695935842, 3443.328550932569, 5010.624203184776, 5248.790048398059, 5262.05283049051, 5268.736563171826, 11536.884631153665, 11564.653060408202, 12601.495940162382, 21226.257081002244, 21685.566288674298, 1773.140027086862, 1815.891046537212, 1818.5180927054341, 1840.0063965458637, 1852.0739630184908, 8601.61292741828, 8755.212030917248, 9310.394824336396, 9740.415575065519, 10851.457427128613, 1756.8331008554167, 1771.9911400443045, 1807.629435965624, 1827.9451616451527, 1860.1722233606051, 60698.39301606971, 71115.64442177808, 73955.0, 74133.25866741317, 75470.0, 8680.739577812676, 9514.714558563253, 9664.565094570762, 9776.853347199798, 9834.608299710182, 12870.613881583567, 13591.388387522586, 13639.931800340935, 14145.292735363191, 14160.150390976574, 6096.329403765582, 7398.741044063432, 7545.50954187976, 7561.7731468056045, 7684.0, 7155.821104472429, 7221.638918054076, 7312.634368281565, 7323.304286092813, 7333.74331898381, 4166.125113726091, 4395.340698895191, 4502.414686090853, 4541.227991241497, 4546.227141385973, 1826.954326141857, 1863.1802007116826, 1871.4385684294657, 1893.6212757448566, 1910.064068606373, 746.1531162131021, 828.1221904780831, 834.3950635789005, 875.1991927386497, 881.748701620048, 17081.145942703064, 17259.0, 17326.826731732774, 17508.387206447715, 18068.0, 833.8040560468285, 853.2576658307312, 857.4683696108452, 867.4708427859001, 915.7573243090586, 9558.713238602853, 9804.558794854249, 9861.112499875046, 9883.703488895344, 9917.603295868228, 380882.0, 383536.0, 383738.0, 407848.0, 409810.0, 81368.0, 83281.58359208165, 85013.0, 85456.0, 85486.572567138, 924.8381533231658, 936.194872409727, 955.2883102088988, 960.3037797596686, 965.3435663748578, 16139.838601613834, 16366.918165409097, 16499.58751031234, 16642.084685342423, 16809.831901680827, 26369.472610548066, 27184.864075680285, 38819.805900970314, 39050.804745976086, 39367.40948885826, 47776.52223477721, 52523.0, 53214.20178697245, 53592.73203633957, 54908.72545637406, 7690.384769218337, 7844.843103137791, 7952.522848629101, 8133.349332053303, 8207.876881846658, 10448.843267351147, 10808.621698240839, 12311.630651080482, 12458.190217635825, 12465.376731163587, 10423.739406514898, 10718.410487423267, 10749.785004299714, 10900.127989760958, 10962.506687199255, 9865.0, 10417.895821041995, 10606.46967651599, 10935.726606834574, 11030.28303160292, 10036.498175091363, 10197.796044078928, 10982.670519884416, 11061.557537698724, 11138.27601205919, 7731.690732370642, 7767.417443691858, 8059.274665280153, 8160.632771525415, 8267.586620669063, 9941.850872236777, 10160.695179144637, 10249.641262555775, 10323.535440905327, 10438.0], "value": 8247.1785007951, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1238.4179435665246, 1390.0, 1418.6595217147885, 1500.7823865539497, 1692.1370101248351, 6798.89801652975, 7548.584827834474, 7743.767686969386, 7780.533168009909, 8042.91957080429, 7779.260970207835, 7792.649330780115, 7856.0, 7875.054993400786, 7890.56601886896, 1825.3063835742466, 2116.1429621003517, 2165.956680866386, 2191.9561608767817, 2193.5503221839563, 2226.588081204974, 2263.185253308816, 2264.1735766445213, 2267.0025188916907, 2268.739095004079, 2209.2046863129262, 2214.6345852934246, 2240.7535171131162, 2258.7063681721434, 2263.54729054189, 1821.1076572479521, 2063.9896800516053, 2151.505153814616, 2166.3176099528678, 2173.5978843913927, 2158.061243359128, 2176.4014895903597, 2178.2267295110323, 2181.029441898356, 2181.3564998325533, 8107.432479726422, 8134.389920755908, 8167.305779008732, 8172.223638754309, 8179.100298967109, 4480.059187570614, 4566.474855391639, 4576.290674945389, 4585.770711464414, 4591.058832939239, 2799.8740056697497, 2848.9857550712113, 2870.296777289577, 2880.395117025427, 2881.5101432756483, 830.6054624053587, 864.5806783709895, 883.1212943121571, 886.4282537763171, 891.8974317953454, 10828.620998265102, 10830.72923176919, 10878.836817447745, 10892.564297428093, 10902.5093870776, 4024.939625905614, 4182.1844740275965, 4204.663626909901, 4349.086691794759, 4353.172897149531, 9299.767505812273, 9382.95308523453, 9385.62457501706, 9394.671186508576, 9404.576794044147, 4697.647676424282, 4703.788329525111, 4710.505396933273, 4712.481627021025, 4714.316424118552, 3734.533183352081, 4169.854055108117, 4281.293586558245, 4301.741895486281, 4319.43847299849, 3678.576963649161, 3750.662440380379, 3814.732968692165, 3815.626374505176, 3841.2701586698995, 1200.6758175292796, 1229.4283158331418, 1232.7103130764262, 1254.4104270992618, 1257.9685507862193, 656.6355672601657, 724.3589423360364, 831.7172161465131, 841.7769291137853, 866.7443104284251, 5172.353455818023, 5260.079486089919, 5268.130758424893, 5387.0841956867425, 5454.045542030208, 883.3198437203317, 894.4275663575316, 898.9325800564853, 904.9954750226207, 921.3964853021282, 3582.1223800169128, 3715.8327875245677, 3725.3294407006997, 3748.081719978623, 3760.3231418344412, 9552.522373881278, 10005.399676019462, 10057.245706572035, 10075.0, 10087.747806304755, 9909.65316213929, 9930.751731206778, 9946.502674866228, 9955.900440995498, 9965.501724913725, 7446.962765186139, 7670.539767613961, 7672.462927595015, 7681.231876812274, 7684.231576842383, 5253.684778913277, 5274.868128296824, 5348.679079255102, 5367.141257398797, 5397.568194544348, 9252.676156334495, 9258.861117083385, 9267.304952128483, 9278.9536052322, 9359.391639543408, 8997.64009439615, 9389.154976052188, 9448.291378146529, 9470.431774093577, 9478.620855165716, 6971.825704357431, 7144.535605185646, 7145.356917877416, 7147.213806481387, 7153.678084486315, 7323.304286092813, 7691.692332306645, 7727.034120734908, 7781.299683028328, 7791.415643826849, 6878.3465570770695, 6888.41448476885, 6889.655517224019, 7009.544379615309, 7022.4382049436945, 6909.619970901648, 7047.6828542714675, 7062.682179301841, 7135.215126336203, 7182.281771822776, 6603.174603174603, 6634.237062737847, 6693.5943451875655, 6702.430293425114, 6704.161979752531, 4415.6909016368545, 4442.577955094261, 4478.619317358061, 4540.614047805841, 4542.477615074309, 4641.651876109373, 4656.627469802475, 4703.905921881612, 4746.525347465225, 4791.425028996403], "value": 4200.547420085508, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.1610498656256, 303.0454069680506, 307.6216254007572, 308.19714643354064, 310.44430469459667, 4926.187179115442, 4972.4033116026085, 4979.45226025137, 5002.899942001158, 5020.447750747419, 4888.902221955559, 4898.436679781827, 4905.484924082964, 4920.852374428764, 4969.353983982086, 3693.8575626136844, 3798.22136462026, 3830.291396091718, 3905.668018218455, 3934.291827471054, 3827.617238276178, 3889.202713443737, 3897.123147291865, 3906.726529142961, 3933.331333673282, 3845.1540661054523, 3846.1538461538416, 3872.7289089763726, 3882.941755873664, 3890.9027274318228, 3704.555453345589, 3742.2889650966367, 3859.337057430364, 3866.4007078902814, 3876.341022026262, 3417.3848707232687, 3417.6411476795074, 3418.3505134024704, 3421.623621401644, 3428.5885693716664, 4830.0, 4837.685550439211, 4855.708657480563, 4859.764508326174, 4863.003084367731, 4106.958930410688, 4370.235208838472, 4390.846320378803, 4400.0, 4402.273624851896, 5066.442691303953, 5070.31550740649, 5132.255822905658, 5171.922421163686, 5173.715445650488, 3609.4946707460713, 3616.945745813815, 3620.0, 3663.303972245265, 3673.2653469306247, 5068.062408454411, 5341.7297648499625, 5382.327209098863, 5387.919181212285, 5403.729813509309, 3666.156783939709, 3692.2800053989213, 3692.9076773080888, 3697.9630203698157, 3700.833462494194, 3741.513603231617, 3770.0763312988493, 3788.6969042476535, 3811.6188381162215, 3812.390017597171, 4364.4980827204645, 4372.825086996548, 4375.5405682403525, 4378.978105109454, 4379.4525684289465, 5015.548600625962, 5074.594032477393, 5077.695338279641, 5084.6440749147205, 5141.305923700253, 1260.5273022616518, 1268.3277862732766, 1273.1342686972948, 1282.7113899372566, 1282.9422675979604, 835.2649668291986, 840.3991146330403, 850.5158498420296, 876.6318146378536, 887.8845750052581, 4499.257622492318, 4507.729536227836, 4509.864704058883, 4543.136804007228, 4548.408706868086, 5178.042062218502, 5187.144121220032, 5189.6886186828915, 5191.377034755778, 5203.8178663746585, 4365.1229971112725, 4500.89728016638, 4507.639388848885, 4508.977455112769, 4515.909681806345, 2749.748864266754, 2765.7372549607753, 2775.195193393893, 2783.7216278372002, 2786.5680819473014, 4939.481354457802, 4949.628777841676, 4962.950370496321, 4963.181075122637, 4969.583668654416, 5133.589312854962, 5266.710330931759, 5273.0, 5312.814051508179, 5330.522361216596, 4851.563359297751, 4874.95125048745, 4877.853664390074, 4900.779464924087, 4923.433805112386, 5171.379434467888, 5173.870653233699, 5176.0, 5214.357477394608, 5221.712805795718, 4931.5315045070665, 5055.393352797688, 5058.974705126598, 5061.063703214917, 5096.847094587169, 4866.296796121329, 4886.486918873467, 4889.315495830516, 4912.140375434356, 4942.75286235694, 3707.128824726241, 3707.4253490708984, 3710.4063349864973, 3713.9814300928324, 3715.5912849587066, 4958.7024778513405, 5179.482051794941, 5232.529072383504, 5244.816431424882, 5259.815906443256, 4988.800447982186, 4995.225740010304, 5034.270030845581, 5034.59723222134, 5039.84880453587, 5022.623303252344, 5036.345275114211, 5048.192289233705, 5057.342545469065, 5084.618653601069, 4799.496052914394, 4908.852734417973, 4959.156943319572, 5135.663273210605, 5150.6137039721425, 4966.255061740623, 5005.798608334047, 5197.376314842243, 5206.271122042841, 5217.191335343028, 5081.0, 5093.974530127474, 5094.847154585368, 5104.540591346797, 5140.151874940593], "value": 3851.0602983844133, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.7632018841657, 634.3307810260173, 643.3212960326854, 716.3409663109942, 721.3507842941353, 12913.354332283383, 13855.0, 13879.236641984688, 13885.305734713262, 13895.0, 12887.291198984052, 13633.659158521043, 13645.590632281048, 13670.111442756239, 13702.383392747326, 627.4227710506345, 786.3787607789839, 801.7434420985287, 808.6522795198063, 812.0580127052621, 763.8243204063069, 797.4378063465272, 800.4756884240832, 804.452971979054, 806.6007326373453, 835.0980940584185, 835.2357592802608, 842.7219017724136, 844.2486187293314, 845.1337379186322, 626.6302881300055, 664.4949838123061, 830.0661755525034, 832.2301870769575, 832.6003518311184, 491.07432489757065, 492.49273248553686, 565.5334349161917, 606.3875485759371, 608.8660494691161, 13127.0811043227, 13160.341982900913, 13177.275249861254, 13202.603921882263, 13217.867821321759, 12641.620751377473, 13139.46210171779, 13206.0, 13328.533501327407, 13507.25710085945, 11792.528298868036, 11807.527698892034, 11931.40342982856, 12157.574484893075, 12224.388780560936, 4131.566185550504, 4163.292240319122, 4215.831366745327, 4225.535191128974, 4240.512341080785, 58133.418665813646, 58233.41766582365, 58328.708356457944, 58917.0, 59035.40964590385, 10187.134093602126, 10214.08073273409, 10318.896811031793, 10330.638427654996, 10401.479926003822, 18642.161102750408, 18726.625467490572, 18737.81262187388, 18744.812551874307, 19311.806881931, 6695.230048544382, 6834.794956151323, 6871.690773915186, 6888.758893438706, 6893.4829887758615, 3532.876349327761, 3583.1511209176865, 3583.4624806278744, 3589.6410358963894, 3640.2355505344176, 2741.8080734348805, 2844.9189308062805, 2845.9573106403423, 2855.7858160638034, 2876.6548014238424, 453.5396572478937, 457.0310940805514, 463.60130287952336, 470.57883194540693, 473.09638590293065, 474.60133487870354, 477.98805029873836, 481.60575134984026, 494.38942905511664, 502.7938545196525, 7120.216776154619, 7241.8551628967125, 7519.172890981988, 7521.0974683038385, 7723.9613801931755, 421.6184353160395, 462.8310666606664, 469.0993292877683, 483.9346688197119, 484.38483126429236, 3430.1767575781632, 3459.5329630500064, 3468.4797280408143, 3470.8264586771065, 3576.5171701819922, 75108.0, 77335.61332193416, 78490.0, 89170.55414722885, 92367.0, 77777.61111194408, 77835.0, 78463.0, 82424.17575824165, 82975.585122074, 44285.557144428145, 51299.0, 71534.0, 74013.62993185107, 74385.0758874231, 8312.83374332522, 8330.583470826556, 8490.448120872123, 8553.0, 8671.869921951049, 36300.63699362973, 43488.78255608702, 44848.0, 44885.10229795451, 45045.32432013588, 63172.0, 65094.0, 66671.33328666652, 67041.32958670545, 67311.66344168248, 10993.890061099286, 11128.777424451628, 11149.832752508557, 11275.210735248455, 11678.416079196177, 11967.461464233957, 12124.27254364741, 12403.13178077562, 12459.12786104964, 12667.30329831868, 11571.363575003455, 12263.570775022832, 12369.0, 12514.624561263177, 12926.676833078873, 11178.832317515082, 11305.943470282597, 11323.15076369259, 11493.597724079616, 11741.76516469683, 11183.0, 11339.71650708706, 11434.309924457306, 11445.771084578095, 11479.139064570023, 9379.155875971195, 9597.9040209597, 9614.95192524033, 9800.215982721507, 10009.349392289478, 9623.171597396473, 9989.400635961865, 10085.495725213857, 10115.269334579321, 10137.64518241858], "value": 6400.962002215156, "unit": "score"}], "name": "dromaeo_css", "value": 6396.201988969433, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 115.0, 113.0, 114.0, 113.0, 112.0, 112.0, 112.0, 113.0, 113.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 121.0, 125.0, 174.0, 123.0, 124.0, 144.0, 127.0, 160.0, 127.0], "value": 137.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 160.0, 160.0, 162.0, 162.0, 161.0, 162.0, 160.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 110.0, 77.0, 77.0, 74.0, 76.0, 104.0, 78.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 125.0, 85.0, 85.0, 86.0, 120.0, 83.0, 85.0, 134.0], "value": 97.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 146.0, 148.0, 148.0, 146.0, 147.0, 146.0, 145.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 67.0, 68.0, 67.0, 68.0, 66.0, 66.0, 66.0, 65.0], "value": 66.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0, 69.0, 66.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 78.0, 81.0, 84.0, 83.0, 83.0, 79.0, 81.0, 82.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 126.0, 129.0, 131.0, 128.0, 141.0, 127.0, 132.0, 173.0, 137.0], "value": 135.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 167.0, 164.0, 166.0, 168.0, 165.0, 165.0, 164.0, 162.0, 170.0], "value": 165.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 66.0, 65.0, 65.0, 68.0, 67.0, 68.0, 65.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1529.6, "alertThreshold": 2.0}]} 05:59:51 INFO - Return code: 0 05:59:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:59:51 INFO - # TBPL SUCCESS # 05:59:51 INFO - Running post-action listener: _resource_record_post_action 05:59:51 INFO - ##### 05:59:51 INFO - ##### Finished run-tests step (success) 05:59:51 INFO - ##### 05:59:51 INFO - Running post-run listener: _resource_record_post_run 05:59:51 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 8192; Write bytes: 535535616; Read time: 20; Write time: 689436 05:59:51 INFO - TinderboxPrint: CPU usage
13.0% 05:59:51 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 05:59:51 INFO - TinderboxPrint: I/O write bytes / time
535,535,616 / 689,436 05:59:51 INFO - TinderboxPrint: CPU idle
8,333.6 (87.0%) 05:59:51 INFO - TinderboxPrint: CPU user
1,200.4 (12.5%) 05:59:51 INFO - TinderboxPrint: Swap in / out
0 / 0 05:59:51 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247054336; Read time: 0; Write time: 364288 05:59:51 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 8192; Write bytes: 288481280; Read time: 20; Write time: 325148 05:59:51 INFO - Running post-run listener: _upload_blobber_files 05:59:51 INFO - Blob upload gear active. 05:59:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:59:51 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 05:59:51 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'] 05:59:51 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 05:59:52 INFO - (blobuploader) - INFO - Open directory for files ... 05:59:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:59:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:59:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:59:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:59:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:59:55 INFO - (blobuploader) - INFO - Done attempting. 05:59:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:59:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:59:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:59:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:59:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:59:56 INFO - (blobuploader) - INFO - Done attempting. 05:59:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:59:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:59:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:59:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:59:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:59:57 INFO - (blobuploader) - INFO - Done attempting. 05:59:57 INFO - (blobuploader) - INFO - Iteration through files over. 05:59:57 INFO - Return code: 0 05:59:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:59:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:59:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ed52887371f20e979003d64750294f7e0a15784f0f290f75671f2e0d5fa62058f6315af87173c7d0bef988a6dccbc3cfb203e20d5912a44b9afce52ad3220276", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c404c4b149a8beb5f620e247152e5b2b0965c4829f7f59889c7020d72e7ba4d3ced551694f4ea7b9c3e5c503fa40f2668454886b1a4821488baf1c51bccc2152", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/af7d0eee3f31ead200c39a25999c405fdda30203f3480798df7fa8aea6f562cd4e996161d80e8e6168c470c9997ac24794afc1366aa027def7dc7c4f5fb81225"} 05:59:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:59:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:59:57 INFO - Contents: 05:59:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ed52887371f20e979003d64750294f7e0a15784f0f290f75671f2e0d5fa62058f6315af87173c7d0bef988a6dccbc3cfb203e20d5912a44b9afce52ad3220276", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c404c4b149a8beb5f620e247152e5b2b0965c4829f7f59889c7020d72e7ba4d3ced551694f4ea7b9c3e5c503fa40f2668454886b1a4821488baf1c51bccc2152", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/af7d0eee3f31ead200c39a25999c405fdda30203f3480798df7fa8aea6f562cd4e996161d80e8e6168c470c9997ac24794afc1366aa027def7dc7c4f5fb81225"} 05:59:57 INFO - Running post-run listener: copy_logs_to_upload_dir 05:59:57 INFO - Copying logs to upload dir... 05:59:57 INFO - mkdir: /builds/slave/test/build/upload/logs 05:59:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.642709 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-07-14 05:59:57.351773) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 05:59:57.354868) ========= 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-1468499776.15777-104712317 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/ed52887371f20e979003d64750294f7e0a15784f0f290f75671f2e0d5fa62058f6315af87173c7d0bef988a6dccbc3cfb203e20d5912a44b9afce52ad3220276", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c404c4b149a8beb5f620e247152e5b2b0965c4829f7f59889c7020d72e7ba4d3ced551694f4ea7b9c3e5c503fa40f2668454886b1a4821488baf1c51bccc2152", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/af7d0eee3f31ead200c39a25999c405fdda30203f3480798df7fa8aea6f562cd4e996161d80e8e6168c470c9997ac24794afc1366aa027def7dc7c4f5fb81225"} build_url:https://queue.taskcluster.net/v1/task/XqURWo3kR-OpIRp74Ia9vA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011262 build_url: 'https://queue.taskcluster.net/v1/task/XqURWo3kR-OpIRp74Ia9vA/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/ed52887371f20e979003d64750294f7e0a15784f0f290f75671f2e0d5fa62058f6315af87173c7d0bef988a6dccbc3cfb203e20d5912a44b9afce52ad3220276", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c404c4b149a8beb5f620e247152e5b2b0965c4829f7f59889c7020d72e7ba4d3ced551694f4ea7b9c3e5c503fa40f2668454886b1a4821488baf1c51bccc2152", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/af7d0eee3f31ead200c39a25999c405fdda30203f3480798df7fa8aea6f562cd4e996161d80e8e6168c470c9997ac24794afc1366aa027def7dc7c4f5fb81225"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 05:59:57.379306) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 05:59:57.379609) ========= 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-1468499776.15777-104712317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004584 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 05:59:57.463039) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 05:59:57.463327) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 05:59:57.463657) ========= ========= Total master_lag: 0.16 =========