builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-043 starttime: 1468622876.27 results: success (0) buildid: 20160715152151 builduid: c94c4f63e2f448b194d0dff9c7707fa7 revision: 48d6706662c08c0aef5a657259fbaaf9c3176d1f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 15:47:56.275143) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 15:47:56.275641) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 15:47:56.275916) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 15:47:56.290618) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 15:47:56.290973) ========= 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=d2a8c569965ab8367867b893000001a1-1468622503.917993-2010076320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-15 15:47:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 41.2M=0s 2016-07-15 15:47:56 (41.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086675 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 15:47:56.392519) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 15:47:56.392827) ========= 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=d2a8c569965ab8367867b893000001a1-1468622503.917993-2010076320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020264 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 15:47:56.442273) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 15:47:56.442706) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 48d6706662c08c0aef5a657259fbaaf9c3176d1f --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 48d6706662c08c0aef5a657259fbaaf9c3176d1f --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=d2a8c569965ab8367867b893000001a1-1468622503.917993-2010076320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-15 15:47:57,012 truncating revision to first 12 chars 2016-07-15 15:47:57,012 Setting DEBUG logging. 2016-07-15 15:47:57,012 attempt 1/10 2016-07-15 15:47:57,012 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/48d6706662c0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-15 15:47:57,317 unpacking tar archive at: fx-team-48d6706662c0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.641385 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 15:47:57.098677) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 15:47:57.099149) ========= script_repo_revision: 48d6706662c08c0aef5a657259fbaaf9c3176d1f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 15:47:57.099710) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 15:47:57.100079) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 15:47:57.111350) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-07-15 15:47:57.111969) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=d2a8c569965ab8367867b893000001a1-1468622503.917993-2010076320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:47:57 INFO - MultiFileLogger online at 20160715 15:47:57 in /builds/slave/test 15:47:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 15:47:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:47:57 INFO - {'append_to_log': False, 15:47:57 INFO - 'base_work_dir': '/builds/slave/test', 15:47:57 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:47:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:47:57 INFO - 'branch': 'Fx-Team-Non-PGO', 15:47:57 INFO - 'buildbot_json_path': 'buildprops.json', 15:47:57 INFO - 'config_files': ('talos/linux_config.py',), 15:47:57 INFO - 'default_actions': ('clobber', 15:47:57 INFO - 'read-buildbot-config', 15:47:57 INFO - 'download-and-extract', 15:47:57 INFO - 'populate-webroot', 15:47:57 INFO - 'create-virtualenv', 15:47:57 INFO - 'install', 15:47:57 INFO - 'run-tests'), 15:47:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:47:57 INFO - 'download_minidump_stackwalk': True, 15:47:57 INFO - 'download_symbols': 'ondemand', 15:47:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:47:57 INFO - 'tooltool.py': '/tools/tooltool.py', 15:47:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:47:57 INFO - '/tools/misc-python/virtualenv.py')}, 15:47:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:47:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:47:57 INFO - 'installer_path': 'installer.exe', 15:47:57 INFO - 'log_level': 'info', 15:47:57 INFO - 'log_name': 'talos', 15:47:57 INFO - 'log_to_console': True, 15:47:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:47:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:47:57 INFO - 'opt_config_files': (), 15:47:57 INFO - 'pip_index': False, 15:47:57 INFO - 'sps_profile': False, 15:47:57 INFO - 'sps_profile_interval': 0, 15:47:57 INFO - 'suite': 'dromaeojs-e10s', 15:47:57 INFO - 'system_bits': '32', 15:47:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:47:57 INFO - 'title': 'talos-linux64-ix-043', 15:47:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:47:57 INFO - 'use_talos_json': True, 15:47:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:47:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:47:57 INFO - 'work_dir': 'build'} 15:47:57 INFO - ##### 15:47:57 INFO - ##### Running clobber step. 15:47:57 INFO - ##### 15:47:57 INFO - Running pre-action listener: _resource_record_pre_action 15:47:57 INFO - Running main action method: clobber 15:47:57 INFO - rmtree: /builds/slave/test/build 15:47:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:47:58 INFO - Running post-action listener: _resource_record_post_action 15:47:58 INFO - ##### 15:47:58 INFO - ##### Finished clobber step (success) 15:47:58 INFO - ##### 15:47:58 INFO - ##### 15:47:58 INFO - ##### Running read-buildbot-config step. 15:47:58 INFO - ##### 15:47:58 INFO - Running pre-action listener: _resource_record_pre_action 15:47:58 INFO - Running main action method: read_buildbot_config 15:47:58 INFO - Using buildbot properties: 15:47:58 INFO - { 15:47:58 INFO - "project": "", 15:47:58 INFO - "product": "firefox", 15:47:58 INFO - "script_repo_revision": "production", 15:47:58 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 15:47:58 INFO - "repository": "", 15:47:58 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 15:47:58 INFO - "buildid": "20160715152151", 15:47:58 INFO - "pgo_build": "False", 15:47:58 INFO - "basedir": "/builds/slave/test", 15:47:58 INFO - "buildnumber": 1473, 15:47:58 INFO - "slavename": "talos-linux64-ix-043", 15:47:58 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:47:58 INFO - "platform": "ubuntu64_hw", 15:47:58 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:47:58 INFO - "branch": "fx-team", 15:47:58 INFO - "repo_path": "integration/fx-team", 15:47:58 INFO - "revision": "48d6706662c08c0aef5a657259fbaaf9c3176d1f", 15:47:58 INFO - "stage_platform": "linux64", 15:47:58 INFO - "builduid": "c94c4f63e2f448b194d0dff9c7707fa7", 15:47:58 INFO - "slavebuilddir": "test" 15:47:58 INFO - } 15:47:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/UcFkgxABQ1GdGMe1PvB1rw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 15:47:58 INFO - Running post-action listener: _resource_record_post_action 15:47:58 INFO - ##### 15:47:58 INFO - ##### Finished read-buildbot-config step (success) 15:47:58 INFO - ##### 15:47:58 INFO - ##### 15:47:58 INFO - ##### Running download-and-extract step. 15:47:58 INFO - ##### 15:47:58 INFO - Running pre-action listener: _resource_record_pre_action 15:47:58 INFO - Running main action method: download_and_extract 15:47:58 INFO - mkdir: /builds/slave/test/build/tests 15:47:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:58 INFO - https://queue.taskcluster.net/v1/task/UcFkgxABQ1GdGMe1PvB1rw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:47:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UcFkgxABQ1GdGMe1PvB1rw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:47:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UcFkgxABQ1GdGMe1PvB1rw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:47:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UcFkgxABQ1GdGMe1PvB1rw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:47:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UcFkgxABQ1GdGMe1PvB1rw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:48:00 INFO - Downloaded 1361 bytes. 15:48:00 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:48:00 INFO - Using the following test package requirements: 15:48:00 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:48:00 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:48:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:48:00 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:48:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:48:00 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:48:00 INFO - u'jsshell-linux-x86_64.zip'], 15:48:00 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:48:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:48:00 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:48:00 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:48:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:48:00 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:48:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:48:00 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:48:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:48:00 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:48:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:48:00 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:48:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:00 INFO - https://queue.taskcluster.net/v1/task/UcFkgxABQ1GdGMe1PvB1rw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:48:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UcFkgxABQ1GdGMe1PvB1rw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:48:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UcFkgxABQ1GdGMe1PvB1rw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:48:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UcFkgxABQ1GdGMe1PvB1rw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:48:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UcFkgxABQ1GdGMe1PvB1rw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:48:02 INFO - Downloaded 22757261 bytes. 15:48:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:48:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:48:04 INFO - Return code: 0 15:48:04 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:04 INFO - https://queue.taskcluster.net/v1/task/UcFkgxABQ1GdGMe1PvB1rw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:48:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UcFkgxABQ1GdGMe1PvB1rw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:48:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UcFkgxABQ1GdGMe1PvB1rw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:48:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UcFkgxABQ1GdGMe1PvB1rw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:48:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UcFkgxABQ1GdGMe1PvB1rw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:48:23 INFO - Downloaded 22757261 bytes. 15:48: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'] 15:48: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 15:48:24 INFO - Return code: 0 15:48: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')]} 15:48:24 INFO - https://queue.taskcluster.net/v1/task/UcFkgxABQ1GdGMe1PvB1rw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:48:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UcFkgxABQ1GdGMe1PvB1rw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:48:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UcFkgxABQ1GdGMe1PvB1rw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:48:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UcFkgxABQ1GdGMe1PvB1rw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:48:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UcFkgxABQ1GdGMe1PvB1rw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:48:25 INFO - Downloaded 14403317 bytes. 15:48: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'] 15:48: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 15:48:25 INFO - Return code: 0 15:48:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:25 INFO - https://queue.taskcluster.net/v1/task/UcFkgxABQ1GdGMe1PvB1rw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:48:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UcFkgxABQ1GdGMe1PvB1rw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:48:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UcFkgxABQ1GdGMe1PvB1rw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:48:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UcFkgxABQ1GdGMe1PvB1rw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:48:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UcFkgxABQ1GdGMe1PvB1rw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:48:27 INFO - Downloaded 57084574 bytes. 15:48:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UcFkgxABQ1GdGMe1PvB1rw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:48:27 INFO - mkdir: /builds/slave/test/properties 15:48:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:48:27 INFO - Writing to file /builds/slave/test/properties/build_url 15:48:27 INFO - Contents: 15:48:27 INFO - build_url:https://queue.taskcluster.net/v1/task/UcFkgxABQ1GdGMe1PvB1rw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:48:27 INFO - Running post-action listener: _resource_record_post_action 15:48:27 INFO - Running post-action listener: set_extra_try_arguments 15:48:27 INFO - ##### 15:48:27 INFO - ##### Finished download-and-extract step (success) 15:48:27 INFO - ##### 15:48:27 INFO - ##### 15:48:27 INFO - ##### Running populate-webroot step. 15:48:27 INFO - ##### 15:48:27 INFO - Running pre-action listener: _resource_record_pre_action 15:48:27 INFO - Running main action method: populate_webroot 15:48:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:48:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:48:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:48:27 INFO - '--tppagecycles', 15:48:27 INFO - '7'], 15:48:27 INFO - 'tests': ['tsvgm']}}, 15:48:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:48:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:48:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:48:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:48:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:48:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:48:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:27 INFO - 'talos_options': ['--disable-e10s'], 15:48:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:48:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:48:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:27 INFO - 'talos_options': ['--disable-e10s'], 15:48:27 INFO - 'tests': ['damp', 'tps']}, 15:48:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:27 INFO - 'tests': ['damp', 'tps']}, 15:48:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:48:27 INFO - 'tests': ['dromaeo_dom']}, 15:48:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:48:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:48:27 INFO - 'tests': ['basic_compositor_video']}, 15:48:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:48:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:48:27 INFO - 'tests': ['a11yr', 15:48:27 INFO - 'ts_paint', 15:48:27 INFO - 'tpaint', 15:48:27 INFO - 'sessionrestore', 15:48:27 INFO - 'sessionrestore_no_auto_restore', 15:48:27 INFO - 'tabpaint']}, 15:48:27 INFO - 'other-e10s': {'tests': ['a11yr', 15:48:27 INFO - 'ts_paint', 15:48:27 INFO - 'tpaint', 15:48:27 INFO - 'sessionrestore', 15:48:27 INFO - 'sessionrestore_no_auto_restore', 15:48:27 INFO - 'tabpaint']}, 15:48:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:48:27 INFO - 'ts_paint', 15:48:27 INFO - 'tpaint', 15:48:27 INFO - 'sessionrestore', 15:48:27 INFO - 'sessionrestore_no_auto_restore', 15:48:27 INFO - 'tabpaint']}, 15:48:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:48:27 INFO - 'ts_paint', 15:48:27 INFO - 'tpaint', 15:48:27 INFO - 'sessionrestore', 15:48:27 INFO - 'sessionrestore_no_auto_restore', 15:48:27 INFO - 'tabpaint']}, 15:48:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:48:27 INFO - 'tests': ['a11yr', 15:48:27 INFO - 'ts_paint', 15:48:27 INFO - 'tpaint', 15:48:27 INFO - 'sessionrestore', 15:48:27 INFO - 'sessionrestore_no_auto_restore', 15:48:27 INFO - 'tabpaint']}, 15:48:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:48:27 INFO - 'tests': ['a11yr', 15:48:27 INFO - 'ts_paint', 15:48:27 INFO - 'tpaint', 15:48:27 INFO - 'sessionrestore', 15:48:27 INFO - 'sessionrestore_no_auto_restore', 15:48:27 INFO - 'tabpaint']}, 15:48:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:48:27 INFO - 'tests': ['tsvgx', 15:48:27 INFO - 'tsvgr_opacity', 15:48:27 INFO - 'tart', 15:48:27 INFO - 'tscrollx', 15:48:27 INFO - 'cart']}, 15:48:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:48:27 INFO - 'tsvgr_opacity', 15:48:27 INFO - 'tart', 15:48:27 INFO - 'tscrollx', 15:48:27 INFO - 'cart']}, 15:48:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:27 INFO - 'talos_options': ['--disable-e10s'], 15:48:27 INFO - 'tests': ['tp5o']}, 15:48:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:27 INFO - 'tests': ['tp5o']}, 15:48:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:27 INFO - 'talos_options': ['--disable-e10s', 15:48:27 INFO - '--xperf_path', 15:48:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:48:27 INFO - 'tests': ['tp5n']}, 15:48:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:27 INFO - 'talos_options': ['--xperf_path', 15:48:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:48:27 INFO - 'tests': ['tp5n']}}, 15:48:27 INFO - 'talos.zip': {'path': '', 15:48:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:48:27 INFO - Running post-action listener: _resource_record_post_action 15:48:27 INFO - ##### 15:48:27 INFO - ##### Finished populate-webroot step (success) 15:48:27 INFO - ##### 15:48:27 INFO - ##### 15:48:27 INFO - ##### Running create-virtualenv step. 15:48:27 INFO - ##### 15:48:27 INFO - Running pre-action listener: _resource_record_pre_action 15:48:27 INFO - Running main action method: create_virtualenv 15:48:27 INFO - Creating virtualenv /builds/slave/test/build/venv 15:48:27 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:48:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:48:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:48:28 INFO - Using real prefix '/usr' 15:48:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:48:28 INFO - Installing distribute.............................................................................................................................................................................................done. 15:48:30 INFO - Installing pip.................done. 15:48:30 INFO - Return code: 0 15:48:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:48: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')]} 15:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48: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')]} 15:48:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48: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 0x10bf030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ee400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137d570>, '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 0x137e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137e900>, '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': 'd2a8c569965ab8367867b893000001a1-1468622503.917993-2010076320', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:48: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 15:48: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 15:48:30 INFO - Using env: {'DISPLAY': ':0', 15:48:30 INFO - 'HOME': '/home/cltbld', 15:48:30 INFO - 'LANG': 'en_US.UTF-8', 15:48:30 INFO - 'LANGUAGE': 'en_US:en', 15:48:30 INFO - 'LOGNAME': 'cltbld', 15:48:30 INFO - 'MAIL': '/var/mail/cltbld', 15:48:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:30 INFO - 'MOZ_NO_REMOTE': '1', 15:48:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:30 INFO - 'NO_EM_RESTART': '1', 15:48:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:30 INFO - 'PWD': '/builds/slave/test', 15:48:30 INFO - 'SHELL': '/bin/bash', 15:48:30 INFO - 'SHLVL': '1', 15:48:30 INFO - 'TERM': 'linux', 15:48:30 INFO - 'TMOUT': '86400', 15:48:30 INFO - 'USER': 'cltbld', 15:48:30 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468622503.917993-2010076320', 15:48:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:30 INFO - '_': '/tools/buildbot/bin/python'} 15:48:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:30 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:48:30 INFO - Cleaning up... 15:48:30 INFO - Return code: 0 15:48:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:48: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')]} 15:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48: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')]} 15:48:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48: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', '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 0x10bf030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ee400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137d570>, '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 0x137e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137e900>, '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': 'd2a8c569965ab8367867b893000001a1-1468622503.917993-2010076320', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:48: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', 'psutil>=3.1.1'] in /builds/slave/test/build 15:48: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 psutil>=3.1.1 15:48:30 INFO - Using env: {'DISPLAY': ':0', 15:48:30 INFO - 'HOME': '/home/cltbld', 15:48:30 INFO - 'LANG': 'en_US.UTF-8', 15:48:30 INFO - 'LANGUAGE': 'en_US:en', 15:48:30 INFO - 'LOGNAME': 'cltbld', 15:48:30 INFO - 'MAIL': '/var/mail/cltbld', 15:48:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:30 INFO - 'MOZ_NO_REMOTE': '1', 15:48:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:30 INFO - 'NO_EM_RESTART': '1', 15:48:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:30 INFO - 'PWD': '/builds/slave/test', 15:48:30 INFO - 'SHELL': '/bin/bash', 15:48:30 INFO - 'SHLVL': '1', 15:48:30 INFO - 'TERM': 'linux', 15:48:30 INFO - 'TMOUT': '86400', 15:48:30 INFO - 'USER': 'cltbld', 15:48:30 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468622503.917993-2010076320', 15:48:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:30 INFO - '_': '/tools/buildbot/bin/python'} 15:48:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:31 INFO - Downloading/unpacking psutil>=3.1.1 15:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:48:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:48:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:48:33 INFO - Installing collected packages: psutil 15:48:33 INFO - Running setup.py install for psutil 15:48:33 INFO - building 'psutil._psutil_linux' extension 15:48: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 15:48: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 15:48:33 INFO - building 'psutil._psutil_posix' extension 15:48: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 15:48: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 15:48:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:48:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:48:33 INFO - Successfully installed psutil 15:48:33 INFO - Cleaning up... 15:48:33 INFO - Return code: 0 15:48:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:48:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48: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 0x10bf030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ee400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137d570>, '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 0x137e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137e900>, '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': 'd2a8c569965ab8367867b893000001a1-1468622503.917993-2010076320', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:48: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 15:48: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 15:48:33 INFO - Using env: {'DISPLAY': ':0', 15:48:33 INFO - 'HOME': '/home/cltbld', 15:48:33 INFO - 'LANG': 'en_US.UTF-8', 15:48:33 INFO - 'LANGUAGE': 'en_US:en', 15:48:33 INFO - 'LOGNAME': 'cltbld', 15:48:33 INFO - 'MAIL': '/var/mail/cltbld', 15:48:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:33 INFO - 'MOZ_NO_REMOTE': '1', 15:48:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:33 INFO - 'NO_EM_RESTART': '1', 15:48:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:33 INFO - 'PWD': '/builds/slave/test', 15:48:33 INFO - 'SHELL': '/bin/bash', 15:48:33 INFO - 'SHLVL': '1', 15:48:33 INFO - 'TERM': 'linux', 15:48:33 INFO - 'TMOUT': '86400', 15:48:33 INFO - 'USER': 'cltbld', 15:48:33 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468622503.917993-2010076320', 15:48:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:33 INFO - '_': '/tools/buildbot/bin/python'} 15:48:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:48:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:48:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:48:35 INFO - Installing collected packages: mozsystemmonitor 15:48:35 INFO - Running setup.py install for mozsystemmonitor 15:48:35 INFO - Successfully installed mozsystemmonitor 15:48:35 INFO - Cleaning up... 15:48:35 INFO - Return code: 0 15:48:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:35 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 0x10bf030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ee400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137d570>, '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 0x137e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137e900>, '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': 'd2a8c569965ab8367867b893000001a1-1468622503.917993-2010076320', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:48:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:48:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:48:35 INFO - Using env: {'DISPLAY': ':0', 15:48:35 INFO - 'HOME': '/home/cltbld', 15:48:35 INFO - 'LANG': 'en_US.UTF-8', 15:48:35 INFO - 'LANGUAGE': 'en_US:en', 15:48:35 INFO - 'LOGNAME': 'cltbld', 15:48:35 INFO - 'MAIL': '/var/mail/cltbld', 15:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:35 INFO - 'MOZ_NO_REMOTE': '1', 15:48:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:35 INFO - 'NO_EM_RESTART': '1', 15:48:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:35 INFO - 'PWD': '/builds/slave/test', 15:48:35 INFO - 'SHELL': '/bin/bash', 15:48:35 INFO - 'SHLVL': '1', 15:48:35 INFO - 'TERM': 'linux', 15:48:35 INFO - 'TMOUT': '86400', 15:48:35 INFO - 'USER': 'cltbld', 15:48:35 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468622503.917993-2010076320', 15:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:35 INFO - '_': '/tools/buildbot/bin/python'} 15:48:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:36 INFO - Downloading/unpacking jsonschema==2.5.1 15:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:48:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:38 INFO - Downloading functools32-3.2.3-2.tar.gz 15:48:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:48:38 INFO - warning: no files found matching '*.txt' 15:48:38 INFO - no previously-included directories found matching 'build' 15:48:38 INFO - no previously-included directories found matching 'dist' 15:48:38 INFO - no previously-included directories found matching '.git*' 15:48:38 INFO - Installing collected packages: jsonschema, functools32 15:48:38 INFO - Running setup.py install for functools32 15:48:38 INFO - warning: no files found matching '*.txt' 15:48:38 INFO - no previously-included directories found matching 'build' 15:48:38 INFO - no previously-included directories found matching 'dist' 15:48:38 INFO - no previously-included directories found matching '.git*' 15:48:38 INFO - Successfully installed jsonschema functools32 15:48:38 INFO - Cleaning up... 15:48:38 INFO - Return code: 0 15:48:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:48:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:38 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 0x10bf030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ee400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137d570>, '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 0x137e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137e900>, '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': 'd2a8c569965ab8367867b893000001a1-1468622503.917993-2010076320', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:48:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:48:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:48:38 INFO - Using env: {'DISPLAY': ':0', 15:48:38 INFO - 'HOME': '/home/cltbld', 15:48:38 INFO - 'LANG': 'en_US.UTF-8', 15:48:38 INFO - 'LANGUAGE': 'en_US:en', 15:48:38 INFO - 'LOGNAME': 'cltbld', 15:48:38 INFO - 'MAIL': '/var/mail/cltbld', 15:48:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:38 INFO - 'MOZ_NO_REMOTE': '1', 15:48:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:38 INFO - 'NO_EM_RESTART': '1', 15:48:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:38 INFO - 'PWD': '/builds/slave/test', 15:48:38 INFO - 'SHELL': '/bin/bash', 15:48:38 INFO - 'SHLVL': '1', 15:48:38 INFO - 'TERM': 'linux', 15:48:38 INFO - 'TMOUT': '86400', 15:48:38 INFO - 'USER': 'cltbld', 15:48:38 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468622503.917993-2010076320', 15:48:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:38 INFO - '_': '/tools/buildbot/bin/python'} 15:48:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:38 INFO - Downloading/unpacking blobuploader==1.2.4 15:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:40 INFO - Downloading blobuploader-1.2.4.tar.gz 15:48:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:48:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:48: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 15:48: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 15:48: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 15:48: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 15:48: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 15:48: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 15:48:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:48:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:41 INFO - Downloading docopt-0.6.1.tar.gz 15:48:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:48:41 INFO - Installing collected packages: blobuploader, requests, docopt 15:48:41 INFO - Running setup.py install for blobuploader 15:48:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:48:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:48:41 INFO - Running setup.py install for requests 15:48:41 INFO - Running setup.py install for docopt 15:48:42 INFO - Successfully installed blobuploader requests docopt 15:48:42 INFO - Cleaning up... 15:48:42 INFO - Return code: 0 15:48:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:48:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:42 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 0x10bf030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ee400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137d570>, '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 0x137e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137e900>, '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': 'd2a8c569965ab8367867b893000001a1-1468622503.917993-2010076320', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:48:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:48:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:48:42 INFO - Using env: {'DISPLAY': ':0', 15:48:42 INFO - 'HOME': '/home/cltbld', 15:48:42 INFO - 'LANG': 'en_US.UTF-8', 15:48:42 INFO - 'LANGUAGE': 'en_US:en', 15:48:42 INFO - 'LOGNAME': 'cltbld', 15:48:42 INFO - 'MAIL': '/var/mail/cltbld', 15:48:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:42 INFO - 'MOZ_NO_REMOTE': '1', 15:48:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:42 INFO - 'NO_EM_RESTART': '1', 15:48:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:42 INFO - 'PWD': '/builds/slave/test', 15:48:42 INFO - 'SHELL': '/bin/bash', 15:48:42 INFO - 'SHLVL': '1', 15:48:42 INFO - 'TERM': 'linux', 15:48:42 INFO - 'TMOUT': '86400', 15:48:42 INFO - 'USER': 'cltbld', 15:48:42 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468622503.917993-2010076320', 15:48:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:42 INFO - '_': '/tools/buildbot/bin/python'} 15:48:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:48:42 INFO - Running setup.py (path:/tmp/pip-fwQuUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:48:42 INFO - Running setup.py (path:/tmp/pip-wjxF8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:48:42 INFO - Running setup.py (path:/tmp/pip-qlt9Zf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:48:42 INFO - Running setup.py (path:/tmp/pip-CrtOea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:48:42 INFO - Running setup.py (path:/tmp/pip-LYuZsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:48:42 INFO - Running setup.py (path:/tmp/pip-qtpFgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:48:42 INFO - Running setup.py (path:/tmp/pip-pESwFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:48:42 INFO - Running setup.py (path:/tmp/pip-9WA0a6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:48:42 INFO - Running setup.py (path:/tmp/pip-xExaSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:48:42 INFO - Running setup.py (path:/tmp/pip-_FPM0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:48:43 INFO - Running setup.py (path:/tmp/pip-b0mntr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:48:43 INFO - Running setup.py (path:/tmp/pip-xXUVml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:48:43 INFO - Running setup.py (path:/tmp/pip-aHwikY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:48:43 INFO - Running setup.py (path:/tmp/pip-jQ23J8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:43 INFO - Running setup.py (path:/tmp/pip-3bl224-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:48:43 INFO - Running setup.py (path:/tmp/pip-QAddWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:48:43 INFO - Running setup.py (path:/tmp/pip-IMCQc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:48:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:48:43 INFO - Running setup.py install for manifestparser 15:48:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:48:43 INFO - Running setup.py install for mozcrash 15:48:43 INFO - Running setup.py install for mozdebug 15:48:43 INFO - Running setup.py install for mozdevice 15:48:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:48:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:48:43 INFO - Running setup.py install for mozfile 15:48:44 INFO - Running setup.py install for mozhttpd 15:48:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:48:44 INFO - Running setup.py install for mozinfo 15:48:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:48:44 INFO - Running setup.py install for mozInstall 15:48:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:48:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:48:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:48:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:48:44 INFO - Running setup.py install for mozleak 15:48:44 INFO - Running setup.py install for mozlog 15:48:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:48:44 INFO - Running setup.py install for moznetwork 15:48:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:48:44 INFO - Running setup.py install for mozprocess 15:48:44 INFO - Running setup.py install for mozprofile 15:48:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:48:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:48:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:48:44 INFO - Running setup.py install for mozrunner 15:48:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:48:45 INFO - Running setup.py install for mozscreenshot 15:48:45 INFO - Running setup.py install for moztest 15:48:45 INFO - Running setup.py install for mozversion 15:48:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:48:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:48:45 INFO - Cleaning up... 15:48:45 INFO - Return code: 0 15:48:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:48:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:45 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 0x10bf030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ee400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137d570>, '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 0x137e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137e900>, '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': 'd2a8c569965ab8367867b893000001a1-1468622503.917993-2010076320', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:48:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:48:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:48:45 INFO - Using env: {'DISPLAY': ':0', 15:48:45 INFO - 'HOME': '/home/cltbld', 15:48:45 INFO - 'LANG': 'en_US.UTF-8', 15:48:45 INFO - 'LANGUAGE': 'en_US:en', 15:48:45 INFO - 'LOGNAME': 'cltbld', 15:48:45 INFO - 'MAIL': '/var/mail/cltbld', 15:48:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:45 INFO - 'MOZ_NO_REMOTE': '1', 15:48:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:45 INFO - 'NO_EM_RESTART': '1', 15:48:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:45 INFO - 'PWD': '/builds/slave/test', 15:48:45 INFO - 'SHELL': '/bin/bash', 15:48:45 INFO - 'SHLVL': '1', 15:48:45 INFO - 'TERM': 'linux', 15:48:45 INFO - 'TMOUT': '86400', 15:48:45 INFO - 'USER': 'cltbld', 15:48:45 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468622503.917993-2010076320', 15:48:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:45 INFO - '_': '/tools/buildbot/bin/python'} 15:48:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:48:45 INFO - Running setup.py (path:/tmp/pip-llvMle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:48:45 INFO - Running setup.py (path:/tmp/pip-qB3jdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:48:45 INFO - Running setup.py (path:/tmp/pip-FfI84h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:48:45 INFO - Running setup.py (path:/tmp/pip-DotywO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:48:45 INFO - Running setup.py (path:/tmp/pip-k2hVGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:48:45 INFO - Running setup.py (path:/tmp/pip-c7hQO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:48:46 INFO - Running setup.py (path:/tmp/pip-qiUsvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:48:46 INFO - Running setup.py (path:/tmp/pip-PB38Gv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:48:46 INFO - Running setup.py (path:/tmp/pip-a1oUYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:48:46 INFO - Running setup.py (path:/tmp/pip-8GFgfw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:48:46 INFO - Running setup.py (path:/tmp/pip-Tr24qA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:48:46 INFO - Running setup.py (path:/tmp/pip-_C76TN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:48:46 INFO - Running setup.py (path:/tmp/pip-ok6vk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:48:46 INFO - Running setup.py (path:/tmp/pip-UhUOG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:46 INFO - Running setup.py (path:/tmp/pip-lXbkc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:48:46 INFO - Running setup.py (path:/tmp/pip-A3KEO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:48:46 INFO - Running setup.py (path:/tmp/pip-gwtsj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:48:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:48 INFO - Downloading blessings-1.6.tar.gz 15:48:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:48:48 INFO - Installing collected packages: blessings 15:48:48 INFO - Running setup.py install for blessings 15:48:49 INFO - Successfully installed blessings 15:48:49 INFO - Cleaning up... 15:48:49 INFO - Return code: 0 15:48:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:48:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:48:49 INFO - Reading from file tmpfile_stdout 15:48:49 INFO - Current package versions: 15:48:49 INFO - argparse == 1.2.1 15:48:49 INFO - blessings == 1.6 15:48:49 INFO - blobuploader == 1.2.4 15:48:49 INFO - docopt == 0.6.1 15:48:49 INFO - functools32 == 3.2.3-2 15:48:49 INFO - jsonschema == 2.5.1 15:48:49 INFO - manifestparser == 1.1 15:48:49 INFO - mozInstall == 1.12 15:48:49 INFO - mozcrash == 0.17 15:48:49 INFO - mozdebug == 0.1 15:48:49 INFO - mozdevice == 0.48 15:48:49 INFO - mozfile == 1.2 15:48:49 INFO - mozhttpd == 0.7 15:48:49 INFO - mozinfo == 0.9 15:48:49 INFO - mozleak == 0.1 15:48:49 INFO - mozlog == 3.2 15:48:49 INFO - moznetwork == 0.27 15:48:49 INFO - mozprocess == 0.23 15:48:49 INFO - mozprofile == 0.28 15:48:49 INFO - mozrunner == 6.12 15:48:49 INFO - mozscreenshot == 0.1 15:48:49 INFO - mozsystemmonitor == 0.3 15:48:49 INFO - moztest == 0.7 15:48:49 INFO - mozversion == 1.4 15:48:49 INFO - psutil == 3.1.1 15:48:49 INFO - requests == 1.2.3 15:48:49 INFO - wsgiref == 0.1.2 15:48:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:49 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 0x10bf030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ee400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137d570>, '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 0x137e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137e900>, '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': 'd2a8c569965ab8367867b893000001a1-1468622503.917993-2010076320', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:48:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:48:49 INFO - Using env: {'DISPLAY': ':0', 15:48:49 INFO - 'HOME': '/home/cltbld', 15:48:49 INFO - 'LANG': 'en_US.UTF-8', 15:48:49 INFO - 'LANGUAGE': 'en_US:en', 15:48:49 INFO - 'LOGNAME': 'cltbld', 15:48:49 INFO - 'MAIL': '/var/mail/cltbld', 15:48:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:49 INFO - 'MOZ_NO_REMOTE': '1', 15:48:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:49 INFO - 'NO_EM_RESTART': '1', 15:48:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:49 INFO - 'PWD': '/builds/slave/test', 15:48:49 INFO - 'SHELL': '/bin/bash', 15:48:49 INFO - 'SHLVL': '1', 15:48:49 INFO - 'TERM': 'linux', 15:48:49 INFO - 'TMOUT': '86400', 15:48:49 INFO - 'USER': 'cltbld', 15:48:49 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468622503.917993-2010076320', 15:48:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:49 INFO - '_': '/tools/buildbot/bin/python'} 15:48:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:48:49 INFO - Cleaning up... 15:48:49 INFO - Return code: 0 15:48:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bf030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ee400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137d570>, '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 0x137e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137e900>, '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': 'd2a8c569965ab8367867b893000001a1-1468622503.917993-2010076320', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:48:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:48:49 INFO - Using env: {'DISPLAY': ':0', 15:48:49 INFO - 'HOME': '/home/cltbld', 15:48:49 INFO - 'LANG': 'en_US.UTF-8', 15:48:49 INFO - 'LANGUAGE': 'en_US:en', 15:48:49 INFO - 'LOGNAME': 'cltbld', 15:48:49 INFO - 'MAIL': '/var/mail/cltbld', 15:48:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:49 INFO - 'MOZ_NO_REMOTE': '1', 15:48:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:49 INFO - 'NO_EM_RESTART': '1', 15:48:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:49 INFO - 'PWD': '/builds/slave/test', 15:48:49 INFO - 'SHELL': '/bin/bash', 15:48:49 INFO - 'SHLVL': '1', 15:48:49 INFO - 'TERM': 'linux', 15:48:49 INFO - 'TMOUT': '86400', 15:48:49 INFO - 'USER': 'cltbld', 15:48:49 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468622503.917993-2010076320', 15:48:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:49 INFO - '_': '/tools/buildbot/bin/python'} 15:48:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:48:49 INFO - Cleaning up... 15:48:49 INFO - Return code: 0 15:48:49 INFO - Running post-action listener: _resource_record_post_action 15:48:49 INFO - Running post-action listener: _start_resource_monitoring 15:48:49 INFO - Starting resource monitoring. 15:48:49 INFO - ##### 15:48:49 INFO - ##### Finished create-virtualenv step (success) 15:48:49 INFO - ##### 15:48:49 INFO - ##### 15:48:49 INFO - ##### Running install step. 15:48:49 INFO - ##### 15:48:49 INFO - Running pre-action listener: _resource_record_pre_action 15:48:49 INFO - Running main action method: install 15:48:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:48:50 INFO - Reading from file tmpfile_stdout 15:48:50 INFO - Detecting whether we're running mozinstall >=1.0... 15:48:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:48:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:48:50 INFO - Reading from file tmpfile_stdout 15:48:50 INFO - Output received: 15:48:50 INFO - Usage: mozinstall [options] installer 15:48:50 INFO - Options: 15:48:50 INFO - -h, --help show this help message and exit 15:48:50 INFO - -d DEST, --destination=DEST 15:48:50 INFO - Directory to install application into. [default: 15:48:50 INFO - "/builds/slave/test"] 15:48:50 INFO - --app=APP Application being installed. [default: firefox] 15:48:50 INFO - mkdir: /builds/slave/test/build/application 15:48:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:48:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:49:06 INFO - Reading from file tmpfile_stdout 15:49:06 INFO - Output received: 15:49:06 INFO - /builds/slave/test/build/application/firefox/firefox 15:49:06 INFO - Running post-action listener: _resource_record_post_action 15:49:06 INFO - ##### 15:49:06 INFO - ##### Finished install step (success) 15:49:06 INFO - ##### 15:49:06 INFO - ##### 15:49:06 INFO - ##### Running run-tests step. 15:49:06 INFO - ##### 15:49:06 INFO - Running pre-action listener: _resource_record_pre_action 15:49:06 INFO - Running main action method: run_tests 15:49:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:49:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:49:06 INFO - Python 2.7.3 15:49:06 INFO - Return code: 0 15:49:06 INFO - grabbing minidump binary from tooltool 15:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:49:06 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 0x137d570>, '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 0x137e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x137e900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:49:06 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:49:06 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:49:06 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:49:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:49:06 INFO - Return code: 0 15:49:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:49:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:49:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:49:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:49:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:49:06 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UcFkgxABQ1GdGMe1PvB1rw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:49:06 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UcFkgxABQ1GdGMe1PvB1rw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:49:06 INFO - Using env: {'DISPLAY': ':0', 15:49:06 INFO - 'HOME': '/home/cltbld', 15:49:06 INFO - 'LANG': 'en_US.UTF-8', 15:49:06 INFO - 'LANGUAGE': 'en_US:en', 15:49:06 INFO - 'LOGNAME': 'cltbld', 15:49:06 INFO - 'MAIL': '/var/mail/cltbld', 15:49:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:49:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:49:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:06 INFO - 'MOZ_NO_REMOTE': '1', 15:49:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:49:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:06 INFO - 'NO_EM_RESTART': '1', 15:49:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:06 INFO - 'PWD': '/builds/slave/test', 15:49:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:49:06 INFO - 'SHELL': '/bin/bash', 15:49:06 INFO - 'SHLVL': '1', 15:49:06 INFO - 'TERM': 'linux', 15:49:06 INFO - 'TMOUT': '86400', 15:49:06 INFO - 'USER': 'cltbld', 15:49:06 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468622503.917993-2010076320', 15:49:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:06 INFO - '_': '/tools/buildbot/bin/python'} 15:49:06 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UcFkgxABQ1GdGMe1PvB1rw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:49:06 INFO - mozversion application_buildid: 20160715152151 15:49:06 INFO - mozversion application_changeset: 48d6706662c08c0aef5a657259fbaaf9c3176d1f 15:49:06 INFO - mozversion application_display_name: Nightly 15:49:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:49:06 INFO - mozversion application_name: Firefox 15:49:06 INFO - mozversion application_remotingname: firefox 15:49:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:49:06 INFO - mozversion application_vendor: Mozilla 15:49:06 INFO - mozversion application_version: 50.0a1 15:49:06 INFO - mozversion platform_buildid: 20160715152151 15:49:06 INFO - mozversion platform_changeset: 48d6706662c08c0aef5a657259fbaaf9c3176d1f 15:49:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:49:06 INFO - mozversion platform_version: 50.0a1 15:49:06 INFO - using testdate: 1468622946 15:49:06 INFO - actual date: 1468622946 15:49:06 INFO - starting webserver on 'localhost:49356' 15:49:06 INFO - SUITE-START | Running 2 tests 15:49:06 INFO - TEST-START | dromaeo_css 15:49:06 INFO - operating with platform_type : linux_ 15:49:06 INFO - Initialising browser for dromaeo_css test... 15:49:06 INFO - TEST-INFO | started process 27680 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj0ypMq/profile http://localhost:49356/getInfo.html) 15:49:12 INFO - PROCESS | 27680 | __metrics Screen width/height:1600/1200 15:49:12 INFO - PROCESS | 27680 | colorDepth:24 15:49:12 INFO - PROCESS | 27680 | Browser inner width/height: 1024/697 15:49:12 INFO - PROCESS | 27680 | __metrics 15:49:12 ERROR - PROCESS | 27680 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 15:49:13 INFO - TEST-INFO | 27680: exit 0 15:49:13 INFO - Browser initialized. 15:49:13 INFO - Running cycle 1/1 for dromaeo_css test... 15:49:13 INFO - TEST-INFO | started process 27799 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj0ypMq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:49:25 INFO - PROCESS | 27799 | RSS: Main: 168779776 15:49:25 INFO - PROCESS | 27799 | 15:50:15 INFO - PROCESS | 27799 | 1468623015270 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:52:28 INFO - PROCESS | 27799 | Cycle 1(1): loaded http://localhost:49356/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49356/tests/dromaeo/cssquery-ext.html) 15:52:29 INFO - PROCESS | 27799 | RSS: Main: 170057728 15:52:29 INFO - PROCESS | 27799 | 15:55:31 INFO - PROCESS | 27799 | Cycle 1(1): loaded http://localhost:49356/tests/dromaeo/cssquery-ext.html (next: http://localhost:49356/tests/dromaeo/cssquery-jquery.html) 15:55:32 INFO - PROCESS | 27799 | RSS: Main: 169549824 15:55:32 INFO - PROCESS | 27799 | 15:58:34 INFO - PROCESS | 27799 | Cycle 1(1): loaded http://localhost:49356/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49356/tests/dromaeo/cssquery-mootools.html) 15:58:35 INFO - PROCESS | 27799 | RSS: Main: 172318720 15:58:35 INFO - PROCESS | 27799 | 16:01:36 INFO - PROCESS | 27799 | Cycle 1(1): loaded http://localhost:49356/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49356/tests/dromaeo/cssquery-prototype.html) 16:01:37 INFO - PROCESS | 27799 | RSS: Main: 167051264 16:01:37 INFO - PROCESS | 27799 | 16:04:40 INFO - PROCESS | 27799 | Cycle 1(1): loaded http://localhost:49356/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49356/tests/dromaeo/cssquery-yui.html) 16:04:41 INFO - PROCESS | 27799 | RSS: Main: 168480768 16:04:41 INFO - PROCESS | 27799 | 16:07:44 INFO - PROCESS | 27799 | Cycle 1(1): loaded http://localhost:49356/tests/dromaeo/cssquery-yui.html (next: http://localhost:49356/tests/dromaeo/cssquery-dojo.html) 16:07:44 INFO - PROCESS | 27799 | RSS: Main: 170332160 16:07:44 INFO - PROCESS | 27799 | 16:07:44 INFO - PROCESS | 27799 | __start_tp_report 16:07:44 INFO - PROCESS | 27799 | _x_x_mozilla_page_load 16:07:44 INFO - PROCESS | 27799 | _x_x_mozilla_page_load_details 16:07:44 INFO - PROCESS | 27799 | |i|pagename|runs| 16:07:44 INFO - PROCESS | 27799 | |0;dojo.html;2629.1718108795735;2635.8945642174313;2656.0836511403563;2673.2648521656556;2678.4107496350807;4806.182948898687;4835.613150947929;4878.536539028795;4882.755862206889;4921.384826896638;4700.717956922578;4826.155422801014;4838.419389673244;4845.951540484594;4866.367372241603;4437.622802061836;4454.37638730578;4550.954490455103;4572.405587273666;4581.015081757421;4449.688521803475;4536.478304994935;4540.114677637862;4586.977065114686;4624.907501849961;4256.829726810924;4383.408239887606;4401.229784787682;4447.355133505656;4516.909661806778;4456;4472.552744725502;4522.728636281834;4542.931856022163;4549.545045495424;4491.73049617024;4497.617702495292;4502.527234640348;4516.458025036984;4527.1624749421135;4782.23484242523;4841.95158048422;4847.175980083394;4851.708897466128;4863.051704917542;5213.4004589472315;5213.687178769286;5222.582193424517;5234.1887007513515;5250.159974404077;5064.18972964324;5143.922841157386;5159.432462429129;5163.66436181647;5197.428282888879;4780.569748722597;4818.469968303484;4826.8793280168275;4834.105690447279;4872.171730805771;5318.654287471302;5321.973390133102;5322.733863306819;5323.574114070865;5371.677699338053;4858.149823780825;5087.542121209109;5098.107831129538;5130.9230361544605;5168.457311982188;5018.799248030111;5143.048536020848;5174.172132458789;5196.246544251062;5201.635885487979;5075.441701412841;5088.338515992971;5137.51193636604;5156.20078887773;5159.948400516022;4989.301497790312;5084.313617661643;5103.5661968733075;5104.566111880532;5151.150060240018;4000.3599424092004;4034.0519977805193;4039.5354534228354;4083.959160408358;4088.7342322748927;3554.8222588870453;3581.516495273157;3589.533360663097;3605.837737301828;3623.1123374772824;4444.333349997526;4474.821007159677;4476.731396116178;4494.258447356149;4498.527654596286;5177.042247184283;5180.559652429511;5215.739213039409;5224.869378265497;5317.069512835238;4470.6870519064005;4486.461624605068;4516.187086324493;4518.570735780096;4540.72755634663;4464.732116073046;4630.74530900797;4645.9303110453375;4663.976680116645;4669.603083737852;4890.462049174588;4906.116898958222;4924.113659541317;4926.113299606105;4927.310176575354;5140.331756871583;5218.295530103387;5223.294855194652;5230.163173892159;5266.605004624746;4827.710337379768;4841.830535931225;4867.878303042452;4887.975560122177;4891.608671306358;5084.3644544431945;5119.078565858182;5119.590432765444;5121.8719532012;5167.379914410295;5155;5177.974110129425;5190.247414124855;5248.737563121752;5256.763445644879;4881.80472781099;5087.4149472811105;5186.040582492251;5188.09208388523;5212.713300768494;5102.948970510248;5111.1311077117725;5119.513646203604;5138.049460849755;5141.331626888481;4833.9606984498505;4886.267059941038;5042.520960508746;5059.0135666789065;5095.235714642833;5010.599152067753;5019.0463811875625;5066.392032956069;5075.644704870623;5115.820946266863;4885.5847252983895;4886.438059623047;4934.481879402611;4967.652264341461;4973.577245933991 16:07:44 INFO - PROCESS | 27799 | |1;ext.html;520.3183829183772;553.3304701311413;564.6160610784666;578.1587789765891;578.2656026845906;39133;40458.393124103124;40459.19081618366;40505.18989620213;44272.3359149613;40672;41300.380494292534;41447.58552414475;41467.58532414675;41489;7895.842083158348;8017.158198389173;8018.879716804253;8022.959885200566;8034.638441270157;7913.802154946115;7956.6817327306835;8034.39742019348;8043.276105150535;8061.798455038642;8010.1589333120055;8043.195680431969;8077.8788318175275;8087.31257843084;8099.797505062362;8003.759887203364;8023.157568455315;8027.15714849944;8066.354691624656;8068.273855353017;7950.56271905045;8005.479643823133;8008.559529225949;8019.398545109082;8022.1175670676175;38905.61094389048;39161.216775664325;39414;39481.210375792325;39507.8024609878;3050.2039582269877;3202.8078315301154;3211.2614098757417;3379.1721028347965;3482.146874015857;29217.269568260752;29470.41059178826;29544.968066624373;29805;30022.84988575065;3432.5387918780325;3458.2046129390383;3482.82585870708;3526.7354948378716;3556.6621170988715;261395;263410;263986.6800666004;267126;268798;32651.67348326534;53895;54226;54228.457715422344;54364;32497.86257480977;33661.326773464396;33981;34045.14887127842;34182.145446363545;12739.36303184837;13137.883279921123;13142.080054396101;13160.934195328962;13219.801702974462;11054.668359949053;11074.723131921604;11089.112870970303;11115.388653623966;11194.888051119548;7922.286994170552;7956.124826269106;7990.960045199737;8044.637991290406;8059.43583949118;3110.0825256549374;3116.1586371679973;3150.5116706910467;3178.0783572764103;3217.2117831131523;865.7662431143682;902.0933961368783;921.5622579274925;970.8640790289365;991.1921783746224;28506.71493285082;28571.285717856805;28623.284417889718;29048;29397.559036614468;944.390867890207;990.3117333453325;994.1500017485091;1055.8046761349176;1079.9298045627008;14633.048851824597;14840.851591483946;14926;14934.70130597382;15085.698286034218;198852;199984;200085;200194;398042;50077.239572657956;50186.49813501891;50555;50666.74666626717;50688.2259120929;1193.6358828296004;1197.3534291482677;1206.4088596587608;1210.915235933494;1233.6114124050896;26500.204993850217;27456.588151177348;27544.17367478979;27665.861670691516;28070.71929280763;41742.582574173866;41922.58077419187;41961.79019104885;42058.36912446377;42335.729928102206;321668;322553;322901;323218;324170;23534.349238071445;23655.172068977503;23739.40651483727;23964.88017559901;25732.356691082874;41990.58009419867;42187.578124219595;42470.36294455647;42910.57089429066;43177;36868;37589.812050940665;37813;38033.80983095067;38348.80825595854;37089;37714.622853772205;37825.432618511295;37899.242015160096;38332.42501362426;35475.46786798148;35568.82215588906;36529.63470365262;37048;39660.20679586334;31603.841980789948;33367.49948750819;33727;33842.66157338494;34064;25014.249572512854;25836.483270334866;25918.870405647853;25956.740432596187;26144.68068191408 16:07:44 INFO - PROCESS | 27799 | |2;jquery.html;375.1502846053687;381.6698555749276;382.43972580170043;384.3869028898907;397.0292634508626;17181.398651047217;17861.910690446563;18388.816111838878;18539.16573754181;18568.99999999998;17274;17432.651346973085;17815.109244537754;18154.90922545389;18168.36410725625;5102.54077133057;5245.606579506533;5251.343582052244;5276.314079169702;5277.815276465305;3790.260899124658;5748.42515748426;6052.394760523956;6061.242344706911;6187;6024.3674414186535;6026.126211699301;6069.939300606981;6104.694765261741;6121.449069583737;6118.938810611881;6122;6134.17188679527;6145.969270153643;6151.907721384183;5179.974100129513;5293;5331.280277162572;5333.040052790496;5341.946580534183;21041.158353665836;21483.57032859334;21870.343889683336;21871.562568748694;21995.450113747283;1961.225316000172;2025.0988310201967;2146.731658542682;2363.137454828975;2370.7629237076326;13667;13713.725725485434;13852.792208116887;13908;13958.58124256274;1754.1580041580114;1792.6504331655333;1801.4325487471403;1805.0613680885997;1821.3807305516189;70516.29483705148;72108.27891721121;72137;73023;74258.62870685666;9536.380135291183;9720.222382209548;9770.218382529381;9914.99292857117;9938.652147174815;13403.731925361439;13434.865651343556;13455.663608409868;13528.188308701509;13555.661108472366;7490.925090749131;7522.811929701801;7560.508566943131;7637.389008879276;7669.501482403626;7188.712451501881;7229.783106506813;7274.345308922222;7364.5581265124265;7378.077740282465;5406.270153529302;6135.6932153393045;6216.844578885473;6224.128621992924;6259.71831267594;1719.243532845544;1788.937387191442;1819.8908065516111;1831.230883029131;1838.6322735452964;841.9601791787138;886.7029545102334;904.968326108583;956.8995255498212;963.6627180486773;17306.625208084304;17618.735718964224;17629.82370176282;17780;18271.451856444328;902.0753727429307;907.2605826251583;909.5088652127777;928.6007016982762;939.2251392601131;9869.950650246847;10278.023587759151;10312.948435257777;10341.63804266847;10399.53202105907;367264;376696;383253;384176;384526;71147;71640;71813;72325.27674723185;74794;863.2317237658489;917.2891009467716;922.0687106022831;928.4661319741176;929.1034152043176;14006.789898151332;14554.053986490844;15777.50113739193;16115;16461.25924333384;34084;35150.29699406049;36594.8170259147;37040.6295937048;38834.6116538831;46158.76920615375;47589.52410475851;51243;53182.46817531775;53979;7577.696892124473;7630;7648;7755.418343624138;7862.449628525948;10589.364638121737;11404.600838970597;11430.771384572095;12020.519179232733;12239.877601223874;10267.127294180078;10301.175905927657;10462.110720588531;10741.838872417076;10822.891771082188;5079.6952182869145;9630;10060.245481588763;10414.254118933486;10888.836667450152;10971.396573188551;10992.780144397228;11042.834357484484;11092.168087393638;11427.257228280136;7591.202923693154;7755.418343624138;7765.53406795594;7839.568823714751;7912.525248485109;10563.1021363185;10615.575376985144;10625.468726563486;10707.57169713234;10760.946195268974 16:07:44 INFO - PROCESS | 27799 | |3;mootools.html;1398.9440422383104;1417.340936464544;1520.1639098495832;1683.6127690631163;1719.3724290633922;6908.585484870899;7613.467057305991;7701.0758708955;8127.9593602032055;8143.185681431862;7772.68909243631;7950.1652326505755;7954.443188976774;8055.31529819966;8063.354931605472;2178.6405243134864;2220.811231045363;2228.4651683595903;2229.487217939875;2230.6654001899765;2170.9565808683815;2187.8796666183352;2188.6607575825774;2195.2316689158824;2203.867767933929;2148.4199266198193;2160.470684682255;2160.7083043789044;2160.7299087614047;2189.386971647933;2113.820325272354;2119.014658183944;2120.777318381563;2127.351157896841;2129.946751331214;2049.7232873562175;2098.181709133439;2110.430183850352;2111.6621340585584;2123.692064650617;7886.526808391457;8010.5594192319395;8021.759347219593;8023.67905283788;8040.638171282248;4392.297232442826;4498.797554110073;4616.215243408628;4620.214563524209;4622.029373831466;2877.784166187544;2902.6516817981765;2984.85075746214;3008.849557522115;3009.473342165112;994.3487016004528;1010.9090181883665;1011.7521207304258;1012.5899010900597;1021.0810270756305;10622.73443163927;10658.893411065868;10664.520096595672;10708.625198118107;10821.783564328747;3932.1545867638597;4130.855420060284;4284.528701842794;4286.207051695384;4350.086481838786;8571.22858942698;8578.914210857936;8651.740447786577;8668.60991255395;8677.045524992245;4544.250198717241;4552.499225085238;4574.656900732459;4583.2666773316105;4597.977010114928;3559.4126969049817;4061.5126184857413;4211.43145675336;4268.103698223345;4288.442502474658;3421.0592087176224;3456.0668619472603;3474.913127171841;3552.378333791576;3638.4178531435373;996.7209181429212;1018.8369860822232;1037.4242295526055;1040.193849766437;1047.5914393386586;646.4828137489989;787.047672316492;790.7588185603331;806.891069705594;810.2464707821664;4655.790489427984;4791;4831.299461578052;4913.238448040559;4924;379.61089882869726;380.3780818361998;382.92341531693774;386.5979381443324;392.1666458775103;3287.2439338951694;3343.8328083595725;3386.796792192427;3388.2207092368894;3394.219329554167;9551.856722149174;9849.359791613522;9855.11303982645;9910;9964.800703986024;9725.61097556104;9759.804803903882;9837.852432213522;9889.258305627107;9941;7234.529755565872;7266.164391095092;7383.446241531907;7420.591867447234;7432.665530051161;5071.594272458121;5074.391073071255;5099.770510327118;5328.573714102785;5393.757280922447;9172.12864777845;9205.815883682422;9278.95360523193;9322;9340.065993400605;9145.314101442285;9311.348205625542;9358.391704539183;9469.763255918657;9511.286653500876;6795.422389096784;6952.5480843745;7055.2591977841585;7076.858462830612;7200.531965422231;7795.766127016199;7822.765317040498;7844.254795794391;7852.685892564234;7860.253275938777;7009;7070.68181931804;7136.179339376038;7198.2801719829695;7230.674619642024;6750.35871592198;6943.79168624942;6966.686499107654;6974.163100427981;7016.36852683261;6216.098665693539;6233.875322493434;6286.811395658137;6293.590916590407;6295.213098362705;4082.101937573729;4190.245755763992;4197.265478541182;4263.850765223202;4293.806778694904;4682.719036857799;4686.92969605463;4689.343491911067;4707.270373092176;4714.269288260325 16:07:44 INFO - PROCESS | 27799 | |4;prototype.html;292.3918250039917;293.2697583018284;295.57289716359855;298.8356403977812;302.5114440179111;5113.3097031900725;5160.561352285055;5163.793448262069;5170.9482905170935;5173.301604283421;5020.472850350716;5035.295058691786;5058.468860769622;5082.440931497532;5085.296425697386;3680.429533422317;3812.5512305323937;3918.1380096378753;3920.1179734559782;3939.6454319111276;3865.40086286626;3889.6386264807234;3902.804859757015;3916.647501724844;3924.82338294776;3889.4749208856724;3901.4537964684823;3936.921261574767;3942.329803933324;3944.881653550384;3807.866724664651;3896.201278737852;3917;3927.273454410929;3932.2135572885536;3401.7448691348;3410.5907291125222;3412.2663627320244;3420.0936751760555;3428;4931.630127740434;4942.406911170647;4942.604591632697;4962.503749625044;4992.550670439678;4360.918694904614;4478.977605111953;4483.170613436525;4483.708558943691;4518.073794872043;5306.681599104066;5330.413654498041;5330.546903513206;5350.3312085989255;5361.705106219157;3718.7025037996896;3725.18046029873;3735.719821013408;3742.4760533525327;3762.059485128718;5462.644928079622;5564.33228012637;5615.831525054214;5628.43715628438;5652.717364131818;3803.896869907751;3813.1992281620614;3823.9617603824163;3824.827882745283;3826.368649172911;3872.5477945770335;3896.357101078347;3896.5908579598736;3908.785016824045;3909.569947305794;4457.554244575516;4471.8434854779925;4477.417935668343;4493.247633422968;4495.662825288116;5134.306868572769;5171;5280.867978300496;5286.117018645843;5367.275417818544;1324.4569726412126;1347.6091933339221;1355.8169647097714;1357.9932100339634;1362.3324570960356;834.9039860416129;850.5067061104545;866.657670220272;872.3762509805392;874.6195404998846;4476.35092911526;4627.5603817637275;4643.3963584733765;4651.279051746985;4656.185167595725;5486.862828429242;5513.476219759116;5539.086050801573;5546;5546.195801608825;4469.217886869785;4661.487236403993;4673.966824431383;4683.531646835358;4692.249240121564;2941.735243828066;2949.705029497033;2961.526155815059;2968.8960886368873;2970.495015847311;5175.45657705943;5181.637285389987;5186.092433824066;5209.791608335624;5233.162693968947;5351.816803575132;5608.831735047955;5629.831105066854;5642.294713160855;5677.886442271214;5172.715500647425;5174.741262936914;5185.455527169668;5204.141316682705;5204.583633309402;5480.835574932758;5490.972545137249;5502.174673798962;5515.117581186991;5572.91640625399;5123.257127716386;5376.838694839161;5434.701091440009;5437.4018857926385;5458.399576046552;5177.741112944263;5188.143956247328;5202.297689811827;5220.381681678692;5246.475352464723;3828.330042242541;3844.2119365530557;3863.2080423512552;3866.2460820139804;3888.3778595424596;5270.683758974474;5529.28592136439;5540.612157148961;5558.694271815089;5683.431656834284;5367.275417818544;5377.408485066561;5392.649477783932;5399.541039011728;5445.428230035947;5233.659812112201;5363.345144153513;5425.457454254543;5473.698946557818;5475.4250803665045;5262.263453060557;5293.682379057269;5293.8766127983135;5307.442718514655;5308.840734777963;5179.974100129475;5291.550218231493;5412.350517937873;5418.268533747893;5428.430014848542;5313.256144139901;5329.973350133225;5344.4922732340365;5351.331083614548;5358.303420555303 16:07:44 INFO - PROCESS | 27799 | |5;yui.html;613.4295105551835;616.8180386785898;630.7760744935548;723.2478222648446;744.6053591596456;12159.331236781973;12907.096503244777;13327.733445331087;13378.464861405544;13417.194968301908;13001.869981300184;13090.08369414139;13135.474581016748;13137.146085504435;13138.868611313885;627.3538255596743;768.0437854870694;769.3883362726632;791.7545560876147;792.2750683124934;784.0434669702953;793.7896457438783;794.6702118620766;794.964226609801;796.5897562755157;824.0688022534528;829.1376967953321;829.6100832608664;831.6340810043591;832.5129799067553;826.8842362069315;827.7971896885272;829.1211316005054;829.2785276809154;831.3930830493713;602.9487493563053;610.4170517156106;610.4201009041428;610.4353473037467;610.6732897899647;14333.856661433461;14506.27468626575;14573.344199511048;14575;14585.781213281809;13682.794758078637;13805.723885522233;13899.79150312746;13932.094413863066;14153.787693184508;10683.732906677318;10694.839577406345;10697.465126743631;10728.624498142528;10731.78536429275;3309.7683162178655;3332.900012999614;3355.5302257683943;3357.4460214064893;3422.2984288220855;63824.361756382306;64948.67525662389;65333.02000470044;66035;66724.66637666781;8950;9127.771805704777;9155.81688366229;9164.266858651292;9441.527923603793;18497.815021849878;18707.15817788203;18739.34412295563;18779.81220187808;18817.529561761065;6288.968555157195;6357.745690172434;6430.7749228776765;6476.514261430411;6552.705128269239;3590;3590.676839084495;3694.5012423323046;3704.8518059277867;3739.569949455793;2772.80590358677;2867.856607169675;2872.6840047594746;2873.985630071878;2889.422115576851;457.5493139257828;518.271828081546;537.5323468582359;546.3634865381786;552.6601140298768;440.25816499198953;480.1453412924999;521.5801279969585;532.4382776171177;549.1460778489487;7719.150893401721;8133.837323253501;8388.11924747905;8420.957895210608;8457.815905773197;499.79008816297244;566.1740688317252;600.753690986702;606.5056978562458;612.3233826621608;3699.8705045323286;3902.3951287550476;3974.423708562242;4045.615666511677;4105.507339119325;98255;101257.49371253097;101611;103026;103644.48177759214;86007.56996214979;87137;87720;88877.55561222152;89373;47271.29093063607;47629;58720.7063964686;76066.23933760702;76608.61695691486;7547.471676982778;7548.962255188909;7754.418418618513;7821.530708157528;7840.451168418156;38038.42942355812;38126;38273.808630956664;38638.613613863505;39762.40356394714;41056.79471602623;50019.49980500294;59768.70115649394;60189.69905150621;61711.38288617236;11410.315381077162;11520.251183673034;11638.767224655629;11688.649340519798;12037.157398981988;12396.504139834666;12423.937880310541;12466.812997804858;12519.436625351698;12568.30874301922;11773.823392648947;12195.51217951272;12344.95682090844;12561.811572826233;12609.55780289503;10754.73113172177;10759.30064545802;10853.565857365616;11205.831912521482;11292.096632269235;11437.199396042197;12038.277703337477;12060.155789094679;12499.375031248583;12520.060995425198;9982;10086.243531735296;10344.260087673449;10572;10891.945540272249;9877;10272.743181420525;10419.218558607983;10450.790984180427;10477.214208934209 16:07:44 INFO - PROCESS | 27799 | __end_tp_report 16:07:44 INFO - PROCESS | 27799 | __start_cc_report 16:07:44 INFO - PROCESS | 27799 | _x_x_mozilla_cycle_collect,412 16:07:44 INFO - PROCESS | 27799 | __end_cc_report 16:07:44 INFO - PROCESS | 27799 | __startTimestamp1468624064261__endTimestamp 16:07:44 INFO - PROCESS | 27799 | 16:07:44 INFO - PROCESS | 27799 | ------- Summary: start ------- 16:07:44 INFO - PROCESS | 27799 | Number of tests: 6 16:07:44 INFO - PROCESS | 27799 | 16:07:44 INFO - PROCESS | 27799 | [#0] dojo.html Cycles:165 Average:4775.80 Median:4886.44 stddev:533.10 (10.9%) stddev-sans-first:507.44 16:07:44 INFO - PROCESS | 27799 | Values: 2629.2 2635.9 2656.1 2673.3 2678.4 4806.2 4835.6 4878.5 4882.8 4921.4 4700.7 4826.2 4838.4 4846.0 4866.4 4437.6 4454.4 4551.0 4572.4 4581.0 4449.7 4536.5 4540.1 4587.0 4624.9 4256.8 4383.4 4401.2 4447.4 4516.9 4456.0 4472.6 4522.7 4542.9 4549.5 4491.7 4497.6 4502.5 4516.5 4527.2 4782.2 4842.0 4847.2 4851.7 4863.1 5213.4 5213.7 5222.6 5234.2 5250.2 5064.2 5143.9 5159.4 5163.7 5197.4 4780.6 4818.5 4826.9 4834.1 4872.2 5318.7 5322.0 5322.7 5323.6 5371.7 4858.1 5087.5 5098.1 5130.9 5168.5 5018.8 5143.0 5174.2 5196.2 5201.6 5075.4 5088.3 5137.5 5156.2 5159.9 4989.3 5084.3 5103.6 5104.6 5151.2 4000.4 4034.1 4039.5 4084.0 4088.7 3554.8 3581.5 3589.5 3605.8 3623.1 4444.3 4474.8 4476.7 4494.3 4498.5 5177.0 5180.6 5215.7 5224.9 5317.1 4470.7 4486.5 4516.2 4518.6 4540.7 4464.7 4630.7 4645.9 4664.0 4669.6 4890.5 4906.1 4924.1 4926.1 4927.3 5140.3 5218.3 5223.3 5230.2 5266.6 4827.7 4841.8 4867.9 4888.0 4891.6 5084.4 5119.1 5119.6 5121.9 5167.4 5155.0 5178.0 5190.2 5248.7 5256.8 4881.8 5087.4 5186.0 5188.1 5212.7 5102.9 5111.1 5119.5 5138.0 5141.3 4834.0 4886.3 5042.5 5059.0 5095.2 5010.6 5019.0 5066.4 5075.6 5115.8 4885.6 4886.4 4934.5 4967.7 4973.6 16:07:44 INFO - PROCESS | 27799 | 16:07:44 INFO - PROCESS | 27799 | [#1] ext.html Cycles:180 Average:43044.48 Median:36958.00 stddev:74010.51 (200.3%) stddev-sans-first:74149.25 16:07:44 INFO - PROCESS | 27799 | Values: 520.3 553.3 564.6 578.2 578.3 39133.0 40458.4 40459.2 40505.2 44272.3 40672.0 41300.4 41447.6 41467.6 41489.0 7895.8 8017.2 8018.9 8023.0 8034.6 7913.8 7956.7 8034.4 8043.3 8061.8 8010.2 8043.2 8077.9 8087.3 8099.8 8003.8 8023.2 8027.2 8066.4 8068.3 7950.6 8005.5 8008.6 8019.4 8022.1 38905.6 39161.2 39414.0 39481.2 39507.8 3050.2 3202.8 3211.3 3379.2 3482.1 29217.3 29470.4 29545.0 29805.0 30022.8 3432.5 3458.2 3482.8 3526.7 3556.7 261395.0 263410.0 263986.7 267126.0 268798.0 32651.7 53895.0 54226.0 54228.5 54364.0 32497.9 33661.3 33981.0 34045.1 34182.1 12739.4 13137.9 13142.1 13160.9 13219.8 11054.7 11074.7 11089.1 11115.4 11194.9 7922.3 7956.1 7991.0 8044.6 8059.4 3110.1 3116.2 3150.5 3178.1 3217.2 865.8 902.1 921.6 970.9 991.2 28506.7 28571.3 28623.3 29048.0 29397.6 944.4 990.3 994.2 1055.8 1079.9 14633.0 14840.9 14926.0 14934.7 15085.7 198852.0 199984.0 200085.0 200194.0 398042.0 50077.2 50186.5 50555.0 50666.7 50688.2 1193.6 1197.4 1206.4 1210.9 1233.6 26500.2 27456.6 27544.2 27665.9 28070.7 41742.6 41922.6 41961.8 42058.4 42335.7 321668.0 322553.0 322901.0 323218.0 324170.0 23534.3 23655.2 23739.4 23964.9 25732.4 41990.6 42187.6 42470.4 42910.6 43177.0 36868.0 37589.8 37813.0 38033.8 38348.8 37089.0 37714.6 37825.4 37899.2 38332.4 35475.5 35568.8 36529.6 37048.0 39660.2 31603.8 33367.5 33727.0 33842.7 34064.0 25014.2 25836.5 25918.9 25956.7 26144.7 16:07:44 INFO - PROCESS | 27799 | 16:07:44 INFO - PROCESS | 27799 | [#2] jquery.html Cycles:180 Average:24312.59 Median:211680.31 stddev:62568.41 (29.6%) stddev-sans-first:62718.12 16:07:44 INFO - PROCESS | 27799 | Values: 375.2 381.7 382.4 384.4 397.0 17181.4 17861.9 18388.8 18539.2 18569.0 17274.0 17432.7 17815.1 18154.9 18168.4 5102.5 5245.6 5251.3 5276.3 5277.8 3790.3 5748.4 6052.4 6061.2 6187.0 6024.4 6026.1 6069.9 6104.7 6121.4 6118.9 6122.0 6134.2 6146.0 6151.9 5180.0 5293.0 5331.3 5333.0 5341.9 21041.2 21483.6 21870.3 21871.6 21995.5 1961.2 2025.1 2146.7 2363.1 2370.8 13667.0 13713.7 13852.8 13908.0 13958.6 1754.2 1792.7 1801.4 1805.1 1821.4 70516.3 72108.3 72137.0 73023.0 74258.6 9536.4 9720.2 9770.2 9915.0 9938.7 13403.7 13434.9 13455.7 13528.2 13555.7 7490.9 7522.8 7560.5 7637.4 7669.5 7188.7 7229.8 7274.3 7364.6 7378.1 5406.3 6135.7 6216.8 6224.1 6259.7 1719.2 1788.9 1819.9 1831.2 1838.6 842.0 886.7 905.0 956.9 963.7 17306.6 17618.7 17629.8 17780.0 18271.5 902.1 907.3 909.5 928.6 939.2 9870.0 10278.0 10312.9 10341.6 10399.5 367264.0 376696.0 383253.0 384176.0 384526.0 71147.0 71640.0 71813.0 72325.3 74794.0 863.2 917.3 922.1 928.5 929.1 14006.8 14554.1 15777.5 16115.0 16461.3 34084.0 35150.3 36594.8 37040.6 38834.6 46158.8 47589.5 51243.0 53182.5 53979.0 7577.7 7630.0 7648.0 7755.4 7862.4 10589.4 11404.6 11430.8 12020.5 12239.9 10267.1 10301.2 10462.1 10741.8 10822.9 5079.7 9630.0 10060.2 10414.3 10888.8 10971.4 10992.8 11042.8 11092.2 11427.3 7591.2 7755.4 7765.5 7839.6 7912.5 10563.1 10615.6 10625.5 10707.6 10760.9 16:07:44 INFO - PROCESS | 27799 | 16:07:44 INFO - PROCESS | 27799 | [#3] mootools.html Cycles:180 Average:5151.44 Median:4688.14 stddev:2973.56 (63.4%) stddev-sans-first:2968.53 16:07:44 INFO - PROCESS | 27799 | Values: 1398.9 1417.3 1520.2 1683.6 1719.4 6908.6 7613.5 7701.1 8128.0 8143.2 7772.7 7950.2 7954.4 8055.3 8063.4 2178.6 2220.8 2228.5 2229.5 2230.7 2171.0 2187.9 2188.7 2195.2 2203.9 2148.4 2160.5 2160.7 2160.7 2189.4 2113.8 2119.0 2120.8 2127.4 2129.9 2049.7 2098.2 2110.4 2111.7 2123.7 7886.5 8010.6 8021.8 8023.7 8040.6 4392.3 4498.8 4616.2 4620.2 4622.0 2877.8 2902.7 2984.9 3008.8 3009.5 994.3 1010.9 1011.8 1012.6 1021.1 10622.7 10658.9 10664.5 10708.6 10821.8 3932.2 4130.9 4284.5 4286.2 4350.1 8571.2 8578.9 8651.7 8668.6 8677.0 4544.3 4552.5 4574.7 4583.3 4598.0 3559.4 4061.5 4211.4 4268.1 4288.4 3421.1 3456.1 3474.9 3552.4 3638.4 996.7 1018.8 1037.4 1040.2 1047.6 646.5 787.0 790.8 806.9 810.2 4655.8 4791.0 4831.3 4913.2 4924.0 379.6 380.4 382.9 386.6 392.2 3287.2 3343.8 3386.8 3388.2 3394.2 9551.9 9849.4 9855.1 9910.0 9964.8 9725.6 9759.8 9837.9 9889.3 9941.0 7234.5 7266.2 7383.4 7420.6 7432.7 5071.6 5074.4 5099.8 5328.6 5393.8 9172.1 9205.8 9279.0 9322.0 9340.1 9145.3 9311.3 9358.4 9469.8 9511.3 6795.4 6952.5 7055.3 7076.9 7200.5 7795.8 7822.8 7844.3 7852.7 7860.3 7009.0 7070.7 7136.2 7198.3 7230.7 6750.4 6943.8 6966.7 6974.2 7016.4 6216.1 6233.9 6286.8 6293.6 6295.2 4082.1 4190.2 4197.3 4263.9 4293.8 4682.7 4686.9 4689.3 4707.3 4714.3 16:07:44 INFO - PROCESS | 27799 | 16:07:44 INFO - PROCESS | 27799 | [#4] prototype.html Cycles:180 Average:4420.97 Median:5118.28 stddev:1306.88 (25.5%) stddev-sans-first:1273.28 16:07:44 INFO - PROCESS | 27799 | Values: 292.4 293.3 295.6 298.8 302.5 5113.3 5160.6 5163.8 5170.9 5173.3 5020.5 5035.3 5058.5 5082.4 5085.3 3680.4 3812.6 3918.1 3920.1 3939.6 3865.4 3889.6 3902.8 3916.6 3924.8 3889.5 3901.5 3936.9 3942.3 3944.9 3807.9 3896.2 3917.0 3927.3 3932.2 3401.7 3410.6 3412.3 3420.1 3428.0 4931.6 4942.4 4942.6 4962.5 4992.6 4360.9 4479.0 4483.2 4483.7 4518.1 5306.7 5330.4 5330.5 5350.3 5361.7 3718.7 3725.2 3735.7 3742.5 3762.1 5462.6 5564.3 5615.8 5628.4 5652.7 3803.9 3813.2 3824.0 3824.8 3826.4 3872.5 3896.4 3896.6 3908.8 3909.6 4457.6 4471.8 4477.4 4493.2 4495.7 5134.3 5171.0 5280.9 5286.1 5367.3 1324.5 1347.6 1355.8 1358.0 1362.3 834.9 850.5 866.7 872.4 874.6 4476.4 4627.6 4643.4 4651.3 4656.2 5486.9 5513.5 5539.1 5546.0 5546.2 4469.2 4661.5 4674.0 4683.5 4692.2 2941.7 2949.7 2961.5 2968.9 2970.5 5175.5 5181.6 5186.1 5209.8 5233.2 5351.8 5608.8 5629.8 5642.3 5677.9 5172.7 5174.7 5185.5 5204.1 5204.6 5480.8 5491.0 5502.2 5515.1 5572.9 5123.3 5376.8 5434.7 5437.4 5458.4 5177.7 5188.1 5202.3 5220.4 5246.5 3828.3 3844.2 3863.2 3866.2 3888.4 5270.7 5529.3 5540.6 5558.7 5683.4 5367.3 5377.4 5392.6 5399.5 5445.4 5233.7 5363.3 5425.5 5473.7 5475.4 5262.3 5293.7 5293.9 5307.4 5308.8 5180.0 5291.6 5412.4 5418.3 5428.4 5313.3 5330.0 5344.5 5351.3 5358.3 16:07:44 INFO - PROCESS | 27799 | 16:07:44 INFO - PROCESS | 27799 | [#5] yui.html Cycles:180 Average:17352.81 Median:4075.56 stddev:24987.75 (613.1%) stddev-sans-first:25026.24 16:07:44 INFO - PROCESS | 27799 | Values: 613.4 616.8 630.8 723.2 744.6 12159.3 12907.1 13327.7 13378.5 13417.2 13001.9 13090.1 13135.5 13137.1 13138.9 627.4 768.0 769.4 791.8 792.3 784.0 793.8 794.7 795.0 796.6 824.1 829.1 829.6 831.6 832.5 826.9 827.8 829.1 829.3 831.4 602.9 610.4 610.4 610.4 610.7 14333.9 14506.3 14573.3 14575.0 14585.8 13682.8 13805.7 13899.8 13932.1 14153.8 10683.7 10694.8 10697.5 10728.6 10731.8 3309.8 3332.9 3355.5 3357.4 3422.3 63824.4 64948.7 65333.0 66035.0 66724.7 8950.0 9127.8 9155.8 9164.3 9441.5 18497.8 18707.2 18739.3 18779.8 18817.5 6289.0 6357.7 6430.8 6476.5 6552.7 3590.0 3590.7 3694.5 3704.9 3739.6 2772.8 2867.9 2872.7 2874.0 2889.4 457.5 518.3 537.5 546.4 552.7 440.3 480.1 521.6 532.4 549.1 7719.2 8133.8 8388.1 8421.0 8457.8 499.8 566.2 600.8 606.5 612.3 3699.9 3902.4 3974.4 4045.6 4105.5 98255.0 101257.5 101611.0 103026.0 103644.5 86007.6 87137.0 87720.0 88877.6 89373.0 47271.3 47629.0 58720.7 76066.2 76608.6 7547.5 7549.0 7754.4 7821.5 7840.5 38038.4 38126.0 38273.8 38638.6 39762.4 41056.8 50019.5 59768.7 60189.7 61711.4 11410.3 11520.3 11638.8 11688.6 12037.2 12396.5 12423.9 12466.8 12519.4 12568.3 11773.8 12195.5 12345.0 12561.8 12609.6 10754.7 10759.3 10853.6 11205.8 11292.1 11437.2 12038.3 12060.2 12499.4 12520.1 9982.0 10086.2 10344.3 10572.0 10891.9 9877.0 10272.7 10419.2 10450.8 10477.2 16:07:44 INFO - PROCESS | 27799 | -------- Summary: end -------- 16:07:44 INFO - PROCESS | 27799 | 16:07:45 INFO - TEST-INFO | 27799: exit 0 16:07:45 INFO - TEST-OK | dromaeo_css | took 1118274ms 16:07:45 INFO - TEST-START | kraken 16:07:45 INFO - operating with platform_type : linux_ 16:07:45 INFO - Initialising browser for kraken test... 16:07:45 INFO - TEST-INFO | started process 28045 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRxVOmW/profile http://localhost:49356/getInfo.html) 16:07:50 INFO - PROCESS | 28045 | __metrics Screen width/height:1600/1200 16:07:50 INFO - PROCESS | 28045 | colorDepth:24 16:07:50 INFO - PROCESS | 28045 | Browser inner width/height: 1024/697 16:07:50 INFO - PROCESS | 28045 | __metrics 16:07:50 ERROR - PROCESS | 28045 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 16:07:51 INFO - TEST-INFO | 28045: exit 0 16:07:51 INFO - Browser initialized. 16:07:51 INFO - Running cycle 1/1 for kraken test... 16:07:51 INFO - TEST-INFO | started process 28168 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRxVOmW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:08:03 INFO - PROCESS | 28168 | RSS: Main: 168468480 16:08:03 INFO - PROCESS | 28168 | 16:08:06 INFO - PROCESS | 28168 | Cycle 1(1): loaded http://localhost:49356/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49356/tests/kraken/driver.html?testName=audio-beat-detection) 16:08:07 INFO - PROCESS | 28168 | RSS: Main: 173670400 16:08:07 INFO - PROCESS | 28168 | 16:08:10 INFO - PROCESS | 28168 | Cycle 1(1): loaded http://localhost:49356/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49356/tests/kraken/driver.html?testName=audio-dft) 16:08:10 INFO - PROCESS | 28168 | RSS: Main: 173555712 16:08:10 INFO - PROCESS | 28168 | 16:08:13 INFO - PROCESS | 28168 | Cycle 1(1): loaded http://localhost:49356/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49356/tests/kraken/driver.html?testName=audio-fft) 16:08:14 INFO - PROCESS | 28168 | RSS: Main: 169250816 16:08:14 INFO - PROCESS | 28168 | 16:08:16 INFO - PROCESS | 28168 | Cycle 1(1): loaded http://localhost:49356/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49356/tests/kraken/driver.html?testName=audio-oscillator) 16:08:17 INFO - PROCESS | 28168 | RSS: Main: 169324544 16:08:17 INFO - PROCESS | 28168 | 16:08:19 INFO - PROCESS | 28168 | Cycle 1(1): loaded http://localhost:49356/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49356/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:08:19 INFO - PROCESS | 28168 | RSS: Main: 169852928 16:08:19 INFO - PROCESS | 28168 | 16:08:23 INFO - PROCESS | 28168 | Cycle 1(1): loaded http://localhost:49356/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49356/tests/kraken/driver.html?testName=imaging-darkroom) 16:08:23 INFO - PROCESS | 28168 | RSS: Main: 169902080 16:08:23 INFO - PROCESS | 28168 | 16:08:27 INFO - PROCESS | 28168 | Cycle 1(1): loaded http://localhost:49356/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49356/tests/kraken/driver.html?testName=imaging-desaturate) 16:08:27 INFO - PROCESS | 28168 | RSS: Main: 167153664 16:08:27 INFO - PROCESS | 28168 | 16:08:30 INFO - PROCESS | 28168 | Cycle 1(1): loaded http://localhost:49356/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49356/tests/kraken/driver.html?testName=json-parse-financial) 16:08:31 INFO - PROCESS | 28168 | RSS: Main: 169082880 16:08:31 INFO - PROCESS | 28168 | 16:08:33 INFO - PROCESS | 28168 | Cycle 1(1): loaded http://localhost:49356/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49356/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:08:33 INFO - PROCESS | 28168 | RSS: Main: 169320448 16:08:33 INFO - PROCESS | 28168 | 16:08:35 INFO - PROCESS | 28168 | Cycle 1(1): loaded http://localhost:49356/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49356/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:08:36 INFO - PROCESS | 28168 | RSS: Main: 169725952 16:08:36 INFO - PROCESS | 28168 | 16:08:38 INFO - PROCESS | 28168 | Cycle 1(1): loaded http://localhost:49356/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49356/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:08:39 INFO - PROCESS | 28168 | RSS: Main: 170041344 16:08:39 INFO - PROCESS | 28168 | 16:08:42 INFO - PROCESS | 28168 | Cycle 1(1): loaded http://localhost:49356/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49356/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:08:42 INFO - PROCESS | 28168 | RSS: Main: 170283008 16:08:42 INFO - PROCESS | 28168 | 16:08:45 INFO - PROCESS | 28168 | Cycle 1(1): loaded http://localhost:49356/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49356/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:08:46 INFO - PROCESS | 28168 | RSS: Main: 169680896 16:08:46 INFO - PROCESS | 28168 | 16:08:48 INFO - PROCESS | 28168 | Cycle 1(1): loaded http://localhost:49356/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49356/tests/kraken/driver.html?testName=ai-astar) 16:08:48 INFO - PROCESS | 28168 | RSS: Main: 170713088 16:08:48 INFO - PROCESS | 28168 | 16:08:48 INFO - PROCESS | 28168 | __start_tp_report 16:08:48 INFO - PROCESS | 28168 | _x_x_mozilla_page_load 16:08:48 INFO - PROCESS | 28168 | _x_x_mozilla_page_load_details 16:08:48 INFO - PROCESS | 28168 | |i|pagename|runs| 16:08:48 INFO - PROCESS | 28168 | |0;ai-astar;106;117;109;115;116;116;117;115;114;116 16:08:48 INFO - PROCESS | 28168 | |1;audio-beat-detection;155;124;147;180;126;159;156;128;198;123 16:08:48 INFO - PROCESS | 28168 | |2;audio-dft;164;166;169;168;169;163;164;165;165;163 16:08:48 INFO - PROCESS | 28168 | |3;audio-fft;75;76;76;153;77;78;77;76;163;76 16:08:48 INFO - PROCESS | 28168 | |4;audio-oscillator;86;86;139;86;87;85;147;86;90;136 16:08:48 INFO - PROCESS | 28168 | |5;imaging-gaussian-blur;117;122;118;119;118;119;117;118;119;118 16:08:48 INFO - PROCESS | 28168 | |6;imaging-darkroom;150;149;147;151;149;148;149;149;148;148 16:08:48 INFO - PROCESS | 28168 | |7;imaging-desaturate;96;95;96;96;95;95;95;97;95;97 16:08:48 INFO - PROCESS | 28168 | |8;json-parse-financial;66;68;65;66;67;66;75;67;65;66 16:08:48 INFO - PROCESS | 28168 | |9;json-stringify-tinderbox;65;66;67;67;66;66;66;65;69;65 16:08:48 INFO - PROCESS | 28168 | |10;stanford-crypto-aes;80;80;82;81;80;80;81;79;89;85 16:08:48 INFO - PROCESS | 28168 | |11;stanford-crypto-ccm;131;142;128;149;135;150;130;131;186;132 16:08:48 INFO - PROCESS | 28168 | |12;stanford-crypto-pbkdf2;166;166;167;166;165;167;166;166;172;168 16:08:48 INFO - PROCESS | 28168 | |13;stanford-crypto-sha256-iterative;75;72;77;73;71;67;68;67;66;69 16:08:48 INFO - PROCESS | 28168 | __end_tp_report 16:08:48 INFO - PROCESS | 28168 | __start_cc_report 16:08:48 INFO - PROCESS | 28168 | _x_x_mozilla_cycle_collect,971 16:08:48 INFO - PROCESS | 28168 | __end_cc_report 16:08:48 INFO - PROCESS | 28168 | __startTimestamp1468624128281__endTimestamp 16:08:48 INFO - PROCESS | 28168 | 16:08:48 INFO - PROCESS | 28168 | ------- Summary: start ------- 16:08:48 INFO - PROCESS | 28168 | Number of tests: 14 16:08:48 INFO - PROCESS | 28168 | 16:08:48 INFO - PROCESS | 28168 | [#0] ai-astar Cycles:10 Average:114.10 Median:116.00 stddev:3.67 (3.2%) stddev-sans-first:2.45 16:08:48 INFO - PROCESS | 28168 | Values: 106.0 117.0 109.0 115.0 116.0 116.0 117.0 115.0 114.0 116.0 16:08:48 INFO - PROCESS | 28168 | 16:08:48 INFO - PROCESS | 28168 | [#1] audio-beat-detection Cycles:10 Average:149.60 Median:155.50 stddev:25.43 (16.4%) stddev-sans-first:26.89 16:08:48 INFO - PROCESS | 28168 | Values: 155.0 124.0 147.0 180.0 126.0 159.0 156.0 128.0 198.0 123.0 16:08:48 INFO - PROCESS | 28168 | 16:08:48 INFO - PROCESS | 28168 | [#2] audio-dft Cycles:10 Average:165.60 Median:165.50 stddev:2.32 (1.4%) stddev-sans-first:2.39 16:08:48 INFO - PROCESS | 28168 | Values: 164.0 166.0 169.0 168.0 169.0 163.0 164.0 165.0 165.0 163.0 16:08:48 INFO - PROCESS | 28168 | 16:08:48 INFO - PROCESS | 28168 | [#3] audio-fft Cycles:10 Average:92.70 Median:76.00 stddev:34.51 (45.4%) stddev-sans-first:36.00 16:08:48 INFO - PROCESS | 28168 | Values: 75.0 76.0 76.0 153.0 77.0 78.0 77.0 76.0 163.0 76.0 16:08:48 INFO - PROCESS | 28168 | 16:08:48 INFO - PROCESS | 28168 | [#4] audio-oscillator Cycles:10 Average:102.80 Median:86.00 stddev:26.30 (30.6%) stddev-sans-first:27.18 16:08:48 INFO - PROCESS | 28168 | Values: 86.0 86.0 139.0 86.0 87.0 85.0 147.0 86.0 90.0 136.0 16:08:48 INFO - PROCESS | 28168 | 16:08:48 INFO - PROCESS | 28168 | [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:118.50 stddev:1.43 (1.2%) stddev-sans-first:1.41 16:08:48 INFO - PROCESS | 28168 | Values: 117.0 122.0 118.0 119.0 118.0 119.0 117.0 118.0 119.0 118.0 16:08:48 INFO - PROCESS | 28168 | 16:08:48 INFO - PROCESS | 28168 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:149.00 stddev:1.14 (0.8%) stddev-sans-first:1.12 16:08:48 INFO - PROCESS | 28168 | Values: 150.0 149.0 147.0 151.0 149.0 148.0 149.0 149.0 148.0 148.0 16:08:48 INFO - PROCESS | 28168 | 16:08:48 INFO - PROCESS | 28168 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 16:08:48 INFO - PROCESS | 28168 | Values: 96.0 95.0 96.0 96.0 95.0 95.0 95.0 97.0 95.0 97.0 16:08:48 INFO - PROCESS | 28168 | 16:08:48 INFO - PROCESS | 28168 | [#8] json-parse-financial Cycles:10 Average:67.10 Median:66.50 stddev:2.92 (4.4%) stddev-sans-first:3.07 16:08:48 INFO - PROCESS | 28168 | Values: 66.0 68.0 65.0 66.0 67.0 66.0 75.0 67.0 65.0 66.0 16:08:48 INFO - PROCESS | 28168 | 16:08:48 INFO - PROCESS | 28168 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.00 stddev:1.23 (1.9%) stddev-sans-first:1.22 16:08:48 INFO - PROCESS | 28168 | Values: 65.0 66.0 67.0 67.0 66.0 66.0 66.0 65.0 69.0 65.0 16:08:48 INFO - PROCESS | 28168 | 16:08:48 INFO - PROCESS | 28168 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:81.00 stddev:3.06 (3.8%) stddev-sans-first:3.18 16:08:48 INFO - PROCESS | 28168 | Values: 80.0 80.0 82.0 81.0 80.0 80.0 81.0 79.0 89.0 85.0 16:08:48 INFO - PROCESS | 28168 | 16:08:48 INFO - PROCESS | 28168 | [#11] stanford-crypto-ccm Cycles:10 Average:141.40 Median:138.50 stddev:17.56 (12.7%) stddev-sans-first:18.22 16:08:48 INFO - PROCESS | 28168 | Values: 131.0 142.0 128.0 149.0 135.0 150.0 130.0 131.0 186.0 132.0 16:08:48 INFO - PROCESS | 28168 | 16:08:48 INFO - PROCESS | 28168 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.90 Median:166.50 stddev:1.97 (1.2%) stddev-sans-first:2.06 16:08:48 INFO - PROCESS | 28168 | Values: 166.0 166.0 167.0 166.0 165.0 167.0 166.0 166.0 172.0 168.0 16:08:48 INFO - PROCESS | 28168 | 16:08:48 INFO - PROCESS | 28168 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:71.50 stddev:3.72 (5.2%) stddev-sans-first:3.57 16:08:48 INFO - PROCESS | 28168 | Values: 75.0 72.0 77.0 73.0 71.0 67.0 68.0 67.0 66.0 69.0 16:08:48 INFO - PROCESS | 28168 | -------- Summary: end -------- 16:08:48 INFO - PROCESS | 28168 | 16:08:49 INFO - TEST-INFO | 28168: exit 0 16:08:49 INFO - TEST-OK | kraken | took 64267ms 16:08:49 INFO - SUITE-END | took 1182s 16:08:49 INFO - Completed test suite (00:19:42) 16:08:49 INFO - javascript benchmark 16:08:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6424.314820242556, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2629.1718108795735, 2635.8945642174313, 2656.0836511403563, 2673.2648521656556, 2678.4107496350807, 4806.182948898687, 4835.613150947929, 4878.536539028795, 4882.755862206889, 4921.384826896638, 4700.717956922578, 4826.155422801014, 4838.419389673244, 4845.951540484594, 4866.367372241603, 4437.622802061836, 4454.37638730578, 4550.954490455103, 4572.405587273666, 4581.015081757421, 4449.688521803475, 4536.478304994935, 4540.114677637862, 4586.977065114686, 4624.907501849961, 4256.829726810924, 4383.408239887606, 4401.229784787682, 4447.355133505656, 4516.909661806778, 4456.0, 4472.552744725502, 4522.728636281834, 4542.931856022163, 4549.545045495424, 4491.73049617024, 4497.617702495292, 4502.527234640348, 4516.458025036984, 4527.1624749421135, 4782.23484242523, 4841.95158048422, 4847.175980083394, 4851.708897466128, 4863.051704917542, 5213.4004589472315, 5213.687178769286, 5222.582193424517, 5234.1887007513515, 5250.159974404077, 5064.18972964324, 5143.922841157386, 5159.432462429129, 5163.66436181647, 5197.428282888879, 4780.569748722597, 4818.469968303484, 4826.8793280168275, 4834.105690447279, 4872.171730805771, 5318.654287471302, 5321.973390133102, 5322.733863306819, 5323.574114070865, 5371.677699338053, 4858.149823780825, 5087.542121209109, 5098.107831129538, 5130.9230361544605, 5168.457311982188, 5018.799248030111, 5143.048536020848, 5174.172132458789, 5196.246544251062, 5201.635885487979, 5075.441701412841, 5088.338515992971, 5137.51193636604, 5156.20078887773, 5159.948400516022, 4989.301497790312, 5084.313617661643, 5103.5661968733075, 5104.566111880532, 5151.150060240018, 4000.3599424092004, 4034.0519977805193, 4039.5354534228354, 4083.959160408358, 4088.7342322748927, 3554.8222588870453, 3581.516495273157, 3589.533360663097, 3605.837737301828, 3623.1123374772824, 4444.333349997526, 4474.821007159677, 4476.731396116178, 4494.258447356149, 4498.527654596286, 5177.042247184283, 5180.559652429511, 5215.739213039409, 5224.869378265497, 5317.069512835238, 4470.6870519064005, 4486.461624605068, 4516.187086324493, 4518.570735780096, 4540.72755634663, 4464.732116073046, 4630.74530900797, 4645.9303110453375, 4663.976680116645, 4669.603083737852, 4890.462049174588, 4906.116898958222, 4924.113659541317, 4926.113299606105, 4927.310176575354, 5140.331756871583, 5218.295530103387, 5223.294855194652, 5230.163173892159, 5266.605004624746, 4827.710337379768, 4841.830535931225, 4867.878303042452, 4887.975560122177, 4891.608671306358, 5084.3644544431945, 5119.078565858182, 5119.590432765444, 5121.8719532012, 5167.379914410295, 5155.0, 5177.974110129425, 5190.247414124855, 5248.737563121752, 5256.763445644879, 4881.80472781099, 5087.4149472811105, 5186.040582492251, 5188.09208388523, 5212.713300768494, 5102.948970510248, 5111.1311077117725, 5119.513646203604, 5138.049460849755, 5141.331626888481, 4833.9606984498505, 4886.267059941038, 5042.520960508746, 5059.0135666789065, 5095.235714642833, 5010.599152067753, 5019.0463811875625, 5066.392032956069, 5075.644704870623, 5115.820946266863, 4885.5847252983895, 4886.438059623047, 4934.481879402611, 4967.652264341461, 4973.577245933991], "value": 4739.410742032955, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [520.3183829183772, 553.3304701311413, 564.6160610784666, 578.1587789765891, 578.2656026845906, 39133.0, 40458.393124103124, 40459.19081618366, 40505.18989620213, 44272.3359149613, 40672.0, 41300.380494292534, 41447.58552414475, 41467.58532414675, 41489.0, 7895.842083158348, 8017.158198389173, 8018.879716804253, 8022.959885200566, 8034.638441270157, 7913.802154946115, 7956.6817327306835, 8034.39742019348, 8043.276105150535, 8061.798455038642, 8010.1589333120055, 8043.195680431969, 8077.8788318175275, 8087.31257843084, 8099.797505062362, 8003.759887203364, 8023.157568455315, 8027.15714849944, 8066.354691624656, 8068.273855353017, 7950.56271905045, 8005.479643823133, 8008.559529225949, 8019.398545109082, 8022.1175670676175, 38905.61094389048, 39161.216775664325, 39414.0, 39481.210375792325, 39507.8024609878, 3050.2039582269877, 3202.8078315301154, 3211.2614098757417, 3379.1721028347965, 3482.146874015857, 29217.269568260752, 29470.41059178826, 29544.968066624373, 29805.0, 30022.84988575065, 3432.5387918780325, 3458.2046129390383, 3482.82585870708, 3526.7354948378716, 3556.6621170988715, 261395.0, 263410.0, 263986.6800666004, 267126.0, 268798.0, 32651.67348326534, 53895.0, 54226.0, 54228.457715422344, 54364.0, 32497.86257480977, 33661.326773464396, 33981.0, 34045.14887127842, 34182.145446363545, 12739.36303184837, 13137.883279921123, 13142.080054396101, 13160.934195328962, 13219.801702974462, 11054.668359949053, 11074.723131921604, 11089.112870970303, 11115.388653623966, 11194.888051119548, 7922.286994170552, 7956.124826269106, 7990.960045199737, 8044.637991290406, 8059.43583949118, 3110.0825256549374, 3116.1586371679973, 3150.5116706910467, 3178.0783572764103, 3217.2117831131523, 865.7662431143682, 902.0933961368783, 921.5622579274925, 970.8640790289365, 991.1921783746224, 28506.71493285082, 28571.285717856805, 28623.284417889718, 29048.0, 29397.559036614468, 944.390867890207, 990.3117333453325, 994.1500017485091, 1055.8046761349176, 1079.9298045627008, 14633.048851824597, 14840.851591483946, 14926.0, 14934.70130597382, 15085.698286034218, 198852.0, 199984.0, 200085.0, 200194.0, 398042.0, 50077.239572657956, 50186.49813501891, 50555.0, 50666.74666626717, 50688.2259120929, 1193.6358828296004, 1197.3534291482677, 1206.4088596587608, 1210.915235933494, 1233.6114124050896, 26500.204993850217, 27456.588151177348, 27544.17367478979, 27665.861670691516, 28070.71929280763, 41742.582574173866, 41922.58077419187, 41961.79019104885, 42058.36912446377, 42335.729928102206, 321668.0, 322553.0, 322901.0, 323218.0, 324170.0, 23534.349238071445, 23655.172068977503, 23739.40651483727, 23964.88017559901, 25732.356691082874, 41990.58009419867, 42187.578124219595, 42470.36294455647, 42910.57089429066, 43177.0, 36868.0, 37589.812050940665, 37813.0, 38033.80983095067, 38348.80825595854, 37089.0, 37714.622853772205, 37825.432618511295, 37899.242015160096, 38332.42501362426, 35475.46786798148, 35568.82215588906, 36529.63470365262, 37048.0, 39660.20679586334, 31603.841980789948, 33367.49948750819, 33727.0, 33842.66157338494, 34064.0, 25014.249572512854, 25836.483270334866, 25918.870405647853, 25956.740432596187, 26144.68068191408], "value": 16512.040442558195, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.1502846053687, 381.6698555749276, 382.43972580170043, 384.3869028898907, 397.0292634508626, 17181.398651047217, 17861.910690446563, 18388.816111838878, 18539.16573754181, 18568.99999999998, 17274.0, 17432.651346973085, 17815.109244537754, 18154.90922545389, 18168.36410725625, 5102.54077133057, 5245.606579506533, 5251.343582052244, 5276.314079169702, 5277.815276465305, 3790.260899124658, 5748.42515748426, 6052.394760523956, 6061.242344706911, 6187.0, 6024.3674414186535, 6026.126211699301, 6069.939300606981, 6104.694765261741, 6121.449069583737, 6118.938810611881, 6122.0, 6134.17188679527, 6145.969270153643, 6151.907721384183, 5179.974100129513, 5293.0, 5331.280277162572, 5333.040052790496, 5341.946580534183, 21041.158353665836, 21483.57032859334, 21870.343889683336, 21871.562568748694, 21995.450113747283, 1961.225316000172, 2025.0988310201967, 2146.731658542682, 2363.137454828975, 2370.7629237076326, 13667.0, 13713.725725485434, 13852.792208116887, 13908.0, 13958.58124256274, 1754.1580041580114, 1792.6504331655333, 1801.4325487471403, 1805.0613680885997, 1821.3807305516189, 70516.29483705148, 72108.27891721121, 72137.0, 73023.0, 74258.62870685666, 9536.380135291183, 9720.222382209548, 9770.218382529381, 9914.99292857117, 9938.652147174815, 13403.731925361439, 13434.865651343556, 13455.663608409868, 13528.188308701509, 13555.661108472366, 7490.925090749131, 7522.811929701801, 7560.508566943131, 7637.389008879276, 7669.501482403626, 7188.712451501881, 7229.783106506813, 7274.345308922222, 7364.5581265124265, 7378.077740282465, 5406.270153529302, 6135.6932153393045, 6216.844578885473, 6224.128621992924, 6259.71831267594, 1719.243532845544, 1788.937387191442, 1819.8908065516111, 1831.230883029131, 1838.6322735452964, 841.9601791787138, 886.7029545102334, 904.968326108583, 956.8995255498212, 963.6627180486773, 17306.625208084304, 17618.735718964224, 17629.82370176282, 17780.0, 18271.451856444328, 902.0753727429307, 907.2605826251583, 909.5088652127777, 928.6007016982762, 939.2251392601131, 9869.950650246847, 10278.023587759151, 10312.948435257777, 10341.63804266847, 10399.53202105907, 367264.0, 376696.0, 383253.0, 384176.0, 384526.0, 71147.0, 71640.0, 71813.0, 72325.27674723185, 74794.0, 863.2317237658489, 917.2891009467716, 922.0687106022831, 928.4661319741176, 929.1034152043176, 14006.789898151332, 14554.053986490844, 15777.50113739193, 16115.0, 16461.25924333384, 34084.0, 35150.29699406049, 36594.8170259147, 37040.6295937048, 38834.6116538831, 46158.76920615375, 47589.52410475851, 51243.0, 53182.46817531775, 53979.0, 7577.696892124473, 7630.0, 7648.0, 7755.418343624138, 7862.449628525948, 10589.364638121737, 11404.600838970597, 11430.771384572095, 12020.519179232733, 12239.877601223874, 10267.127294180078, 10301.175905927657, 10462.110720588531, 10741.838872417076, 10822.891771082188, 5079.6952182869145, 9630.0, 10060.245481588763, 10414.254118933486, 10888.836667450152, 10971.396573188551, 10992.780144397228, 11042.834357484484, 11092.168087393638, 11427.257228280136, 7591.202923693154, 7755.418343624138, 7765.53406795594, 7839.568823714751, 7912.525248485109, 10563.1021363185, 10615.575376985144, 10625.468726563486, 10707.57169713234, 10760.946195268974], "value": 8580.709832801724, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1398.9440422383104, 1417.340936464544, 1520.1639098495832, 1683.6127690631163, 1719.3724290633922, 6908.585484870899, 7613.467057305991, 7701.0758708955, 8127.9593602032055, 8143.185681431862, 7772.68909243631, 7950.1652326505755, 7954.443188976774, 8055.31529819966, 8063.354931605472, 2178.6405243134864, 2220.811231045363, 2228.4651683595903, 2229.487217939875, 2230.6654001899765, 2170.9565808683815, 2187.8796666183352, 2188.6607575825774, 2195.2316689158824, 2203.867767933929, 2148.4199266198193, 2160.470684682255, 2160.7083043789044, 2160.7299087614047, 2189.386971647933, 2113.820325272354, 2119.014658183944, 2120.777318381563, 2127.351157896841, 2129.946751331214, 2049.7232873562175, 2098.181709133439, 2110.430183850352, 2111.6621340585584, 2123.692064650617, 7886.526808391457, 8010.5594192319395, 8021.759347219593, 8023.67905283788, 8040.638171282248, 4392.297232442826, 4498.797554110073, 4616.215243408628, 4620.214563524209, 4622.029373831466, 2877.784166187544, 2902.6516817981765, 2984.85075746214, 3008.849557522115, 3009.473342165112, 994.3487016004528, 1010.9090181883665, 1011.7521207304258, 1012.5899010900597, 1021.0810270756305, 10622.73443163927, 10658.893411065868, 10664.520096595672, 10708.625198118107, 10821.783564328747, 3932.1545867638597, 4130.855420060284, 4284.528701842794, 4286.207051695384, 4350.086481838786, 8571.22858942698, 8578.914210857936, 8651.740447786577, 8668.60991255395, 8677.045524992245, 4544.250198717241, 4552.499225085238, 4574.656900732459, 4583.2666773316105, 4597.977010114928, 3559.4126969049817, 4061.5126184857413, 4211.43145675336, 4268.103698223345, 4288.442502474658, 3421.0592087176224, 3456.0668619472603, 3474.913127171841, 3552.378333791576, 3638.4178531435373, 996.7209181429212, 1018.8369860822232, 1037.4242295526055, 1040.193849766437, 1047.5914393386586, 646.4828137489989, 787.047672316492, 790.7588185603331, 806.891069705594, 810.2464707821664, 4655.790489427984, 4791.0, 4831.299461578052, 4913.238448040559, 4924.0, 379.61089882869726, 380.3780818361998, 382.92341531693774, 386.5979381443324, 392.1666458775103, 3287.2439338951694, 3343.8328083595725, 3386.796792192427, 3388.2207092368894, 3394.219329554167, 9551.856722149174, 9849.359791613522, 9855.11303982645, 9910.0, 9964.800703986024, 9725.61097556104, 9759.804803903882, 9837.852432213522, 9889.258305627107, 9941.0, 7234.529755565872, 7266.164391095092, 7383.446241531907, 7420.591867447234, 7432.665530051161, 5071.594272458121, 5074.391073071255, 5099.770510327118, 5328.573714102785, 5393.757280922447, 9172.12864777845, 9205.815883682422, 9278.95360523193, 9322.0, 9340.065993400605, 9145.314101442285, 9311.348205625542, 9358.391704539183, 9469.763255918657, 9511.286653500876, 6795.422389096784, 6952.5480843745, 7055.2591977841585, 7076.858462830612, 7200.531965422231, 7795.766127016199, 7822.765317040498, 7844.254795794391, 7852.685892564234, 7860.253275938777, 7009.0, 7070.68181931804, 7136.179339376038, 7198.2801719829695, 7230.674619642024, 6750.35871592198, 6943.79168624942, 6966.686499107654, 6974.163100427981, 7016.36852683261, 6216.098665693539, 6233.875322493434, 6286.811395658137, 6293.590916590407, 6295.213098362705, 4082.101937573729, 4190.245755763992, 4197.265478541182, 4263.850765223202, 4293.806778694904, 4682.719036857799, 4686.92969605463, 4689.343491911067, 4707.270373092176, 4714.269288260325], "value": 4035.379256477429, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.3918250039917, 293.2697583018284, 295.57289716359855, 298.8356403977812, 302.5114440179111, 5113.3097031900725, 5160.561352285055, 5163.793448262069, 5170.9482905170935, 5173.301604283421, 5020.472850350716, 5035.295058691786, 5058.468860769622, 5082.440931497532, 5085.296425697386, 3680.429533422317, 3812.5512305323937, 3918.1380096378753, 3920.1179734559782, 3939.6454319111276, 3865.40086286626, 3889.6386264807234, 3902.804859757015, 3916.647501724844, 3924.82338294776, 3889.4749208856724, 3901.4537964684823, 3936.921261574767, 3942.329803933324, 3944.881653550384, 3807.866724664651, 3896.201278737852, 3917.0, 3927.273454410929, 3932.2135572885536, 3401.7448691348, 3410.5907291125222, 3412.2663627320244, 3420.0936751760555, 3428.0, 4931.630127740434, 4942.406911170647, 4942.604591632697, 4962.503749625044, 4992.550670439678, 4360.918694904614, 4478.977605111953, 4483.170613436525, 4483.708558943691, 4518.073794872043, 5306.681599104066, 5330.413654498041, 5330.546903513206, 5350.3312085989255, 5361.705106219157, 3718.7025037996896, 3725.18046029873, 3735.719821013408, 3742.4760533525327, 3762.059485128718, 5462.644928079622, 5564.33228012637, 5615.831525054214, 5628.43715628438, 5652.717364131818, 3803.896869907751, 3813.1992281620614, 3823.9617603824163, 3824.827882745283, 3826.368649172911, 3872.5477945770335, 3896.357101078347, 3896.5908579598736, 3908.785016824045, 3909.569947305794, 4457.554244575516, 4471.8434854779925, 4477.417935668343, 4493.247633422968, 4495.662825288116, 5134.306868572769, 5171.0, 5280.867978300496, 5286.117018645843, 5367.275417818544, 1324.4569726412126, 1347.6091933339221, 1355.8169647097714, 1357.9932100339634, 1362.3324570960356, 834.9039860416129, 850.5067061104545, 866.657670220272, 872.3762509805392, 874.6195404998846, 4476.35092911526, 4627.5603817637275, 4643.3963584733765, 4651.279051746985, 4656.185167595725, 5486.862828429242, 5513.476219759116, 5539.086050801573, 5546.0, 5546.195801608825, 4469.217886869785, 4661.487236403993, 4673.966824431383, 4683.531646835358, 4692.249240121564, 2941.735243828066, 2949.705029497033, 2961.526155815059, 2968.8960886368873, 2970.495015847311, 5175.45657705943, 5181.637285389987, 5186.092433824066, 5209.791608335624, 5233.162693968947, 5351.816803575132, 5608.831735047955, 5629.831105066854, 5642.294713160855, 5677.886442271214, 5172.715500647425, 5174.741262936914, 5185.455527169668, 5204.141316682705, 5204.583633309402, 5480.835574932758, 5490.972545137249, 5502.174673798962, 5515.117581186991, 5572.91640625399, 5123.257127716386, 5376.838694839161, 5434.701091440009, 5437.4018857926385, 5458.399576046552, 5177.741112944263, 5188.143956247328, 5202.297689811827, 5220.381681678692, 5246.475352464723, 3828.330042242541, 3844.2119365530557, 3863.2080423512552, 3866.2460820139804, 3888.3778595424596, 5270.683758974474, 5529.28592136439, 5540.612157148961, 5558.694271815089, 5683.431656834284, 5367.275417818544, 5377.408485066561, 5392.649477783932, 5399.541039011728, 5445.428230035947, 5233.659812112201, 5363.345144153513, 5425.457454254543, 5473.698946557818, 5475.4250803665045, 5262.263453060557, 5293.682379057269, 5293.8766127983135, 5307.442718514655, 5308.840734777963, 5179.974100129475, 5291.550218231493, 5412.350517937873, 5418.268533747893, 5428.430014848542, 5313.256144139901, 5329.973350133225, 5344.4922732340365, 5351.331083614548, 5358.303420555303], "value": 3997.447489647409, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [613.4295105551835, 616.8180386785898, 630.7760744935548, 723.2478222648446, 744.6053591596456, 12159.331236781973, 12907.096503244777, 13327.733445331087, 13378.464861405544, 13417.194968301908, 13001.869981300184, 13090.08369414139, 13135.474581016748, 13137.146085504435, 13138.868611313885, 627.3538255596743, 768.0437854870694, 769.3883362726632, 791.7545560876147, 792.2750683124934, 784.0434669702953, 793.7896457438783, 794.6702118620766, 794.964226609801, 796.5897562755157, 824.0688022534528, 829.1376967953321, 829.6100832608664, 831.6340810043591, 832.5129799067553, 826.8842362069315, 827.7971896885272, 829.1211316005054, 829.2785276809154, 831.3930830493713, 602.9487493563053, 610.4170517156106, 610.4201009041428, 610.4353473037467, 610.6732897899647, 14333.856661433461, 14506.27468626575, 14573.344199511048, 14575.0, 14585.781213281809, 13682.794758078637, 13805.723885522233, 13899.79150312746, 13932.094413863066, 14153.787693184508, 10683.732906677318, 10694.839577406345, 10697.465126743631, 10728.624498142528, 10731.78536429275, 3309.7683162178655, 3332.900012999614, 3355.5302257683943, 3357.4460214064893, 3422.2984288220855, 63824.361756382306, 64948.67525662389, 65333.02000470044, 66035.0, 66724.66637666781, 8950.0, 9127.771805704777, 9155.81688366229, 9164.266858651292, 9441.527923603793, 18497.815021849878, 18707.15817788203, 18739.34412295563, 18779.81220187808, 18817.529561761065, 6288.968555157195, 6357.745690172434, 6430.7749228776765, 6476.514261430411, 6552.705128269239, 3590.0, 3590.676839084495, 3694.5012423323046, 3704.8518059277867, 3739.569949455793, 2772.80590358677, 2867.856607169675, 2872.6840047594746, 2873.985630071878, 2889.422115576851, 457.5493139257828, 518.271828081546, 537.5323468582359, 546.3634865381786, 552.6601140298768, 440.25816499198953, 480.1453412924999, 521.5801279969585, 532.4382776171177, 549.1460778489487, 7719.150893401721, 8133.837323253501, 8388.11924747905, 8420.957895210608, 8457.815905773197, 499.79008816297244, 566.1740688317252, 600.753690986702, 606.5056978562458, 612.3233826621608, 3699.8705045323286, 3902.3951287550476, 3974.423708562242, 4045.615666511677, 4105.507339119325, 98255.0, 101257.49371253097, 101611.0, 103026.0, 103644.48177759214, 86007.56996214979, 87137.0, 87720.0, 88877.55561222152, 89373.0, 47271.29093063607, 47629.0, 58720.7063964686, 76066.23933760702, 76608.61695691486, 7547.471676982778, 7548.962255188909, 7754.418418618513, 7821.530708157528, 7840.451168418156, 38038.42942355812, 38126.0, 38273.808630956664, 38638.613613863505, 39762.40356394714, 41056.79471602623, 50019.49980500294, 59768.70115649394, 60189.69905150621, 61711.38288617236, 11410.315381077162, 11520.251183673034, 11638.767224655629, 11688.649340519798, 12037.157398981988, 12396.504139834666, 12423.937880310541, 12466.812997804858, 12519.436625351698, 12568.30874301922, 11773.823392648947, 12195.51217951272, 12344.95682090844, 12561.811572826233, 12609.55780289503, 10754.73113172177, 10759.30064545802, 10853.565857365616, 11205.831912521482, 11292.096632269235, 11437.199396042197, 12038.277703337477, 12060.155789094679, 12499.375031248583, 12520.060995425198, 9982.0, 10086.243531735296, 10344.260087673449, 10572.0, 10891.945540272249, 9877.0, 10272.743181420525, 10419.218558607983, 10450.790984180427, 10477.214208934209], "value": 6489.322287088924, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1581.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 117.0, 109.0, 115.0, 116.0, 116.0, 117.0, 115.0, 114.0, 116.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 124.0, 147.0, 180.0, 126.0, 159.0, 156.0, 128.0, 198.0, 123.0], "value": 149.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 169.0, 168.0, 169.0, 163.0, 164.0, 165.0, 165.0, 163.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 153.0, 77.0, 78.0, 77.0, 76.0, 163.0, 76.0], "value": 92.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 139.0, 86.0, 87.0, 85.0, 147.0, 86.0, 90.0, 136.0], "value": 102.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 122.0, 118.0, 119.0, 118.0, 119.0, 117.0, 118.0, 119.0, 118.0], "value": 118.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 147.0, 151.0, 149.0, 148.0, 149.0, 149.0, 148.0, 148.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 97.0, 95.0, 97.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 65.0, 66.0, 67.0, 66.0, 75.0, 67.0, 65.0, 66.0], "value": 67.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 67.0, 67.0, 66.0, 66.0, 66.0, 65.0, 69.0, 65.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 82.0, 81.0, 80.0, 80.0, 81.0, 79.0, 89.0, 85.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 142.0, 128.0, 149.0, 135.0, 150.0, 130.0, 131.0, 186.0, 132.0], "value": 141.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 167.0, 166.0, 165.0, 167.0, 166.0, 166.0, 172.0, 168.0], "value": 166.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 72.0, 77.0, 73.0, 71.0, 67.0, 68.0, 67.0, 66.0, 69.0], "value": 70.5, "unit": "score"}]}]} 16:08:49 INFO - Return code: 0 16:08:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:08:49 ERROR - # TBPL SUCCESS # 16:08:49 INFO - Running post-action listener: _resource_record_post_action 16:08:49 INFO - ##### 16:08:49 INFO - ##### Finished run-tests step (success) 16:08:49 INFO - ##### 16:08:49 INFO - Running post-run listener: _resource_record_post_run 16:08:49 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535924736; Read time: 12; Write time: 507632 16:08:49 INFO - TinderboxPrint: CPU usage
13.3% 16:08:49 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 16:08:49 INFO - TinderboxPrint: I/O write bytes / time
535,924,736 / 507,632 16:08:49 INFO - TinderboxPrint: CPU idle
8,293.0 (86.7%) 16:08:49 INFO - TinderboxPrint: CPU user
1,220.1 (12.8%) 16:08:49 INFO - TinderboxPrint: Swap in / out
0 / 0 16:08:49 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247074816; Read time: 0; Write time: 301900 16:08:49 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 288415744; Read time: 0; Write time: 205708 16:08:50 INFO - Running post-run listener: _upload_blobber_files 16:08:50 INFO - Blob upload gear active. 16:08:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:08:50 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 16:08:50 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'] 16:08:50 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 16:08:50 INFO - (blobuploader) - INFO - Open directory for files ... 16:08:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:08:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:08:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:51 INFO - (blobuploader) - INFO - Done attempting. 16:08:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:08:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:08:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:54 INFO - (blobuploader) - INFO - Done attempting. 16:08:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:08:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:08:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:55 INFO - (blobuploader) - INFO - Done attempting. 16:08:55 INFO - (blobuploader) - INFO - Iteration through files over. 16:08:55 INFO - Return code: 0 16:08:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:08:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:08:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0251e0612b8b6ad6e6e022243aea9eee572953c5eb6c96b7a41382a6d0b396842804cb032e23f20f0c8780fe7280ca4a5b1652b8cf23e92c7d853bb929e6525d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c665386c49b3bd4eac0fcec9a2bdfade9c5e1e3fe65fb23cbe7362db3c3a2d77e5c7acf5618e6861566968ba896cb8f9f676b64e236ae617664001933bec928e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3c5eeaaa20a260ae114ce791570d6168ab24d8cf336f4c2d629ab8e3062db5839800796464daa6f3514e118e058f6e70d94d98fa910ea4558866ce42396d1aeb"} 16:08:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:08:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:08:55 INFO - Contents: 16:08:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0251e0612b8b6ad6e6e022243aea9eee572953c5eb6c96b7a41382a6d0b396842804cb032e23f20f0c8780fe7280ca4a5b1652b8cf23e92c7d853bb929e6525d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c665386c49b3bd4eac0fcec9a2bdfade9c5e1e3fe65fb23cbe7362db3c3a2d77e5c7acf5618e6861566968ba896cb8f9f676b64e236ae617664001933bec928e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3c5eeaaa20a260ae114ce791570d6168ab24d8cf336f4c2d629ab8e3062db5839800796464daa6f3514e118e058f6e70d94d98fa910ea4558866ce42396d1aeb"} 16:08:55 INFO - Running post-run listener: copy_logs_to_upload_dir 16:08:55 INFO - Copying logs to upload dir... 16:08:55 INFO - mkdir: /builds/slave/test/build/upload/logs 16:08:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.956997 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-07-15 16:08:55.082866) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 16:08:55.086759) ========= 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=d2a8c569965ab8367867b893000001a1-1468622503.917993-2010076320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0251e0612b8b6ad6e6e022243aea9eee572953c5eb6c96b7a41382a6d0b396842804cb032e23f20f0c8780fe7280ca4a5b1652b8cf23e92c7d853bb929e6525d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c665386c49b3bd4eac0fcec9a2bdfade9c5e1e3fe65fb23cbe7362db3c3a2d77e5c7acf5618e6861566968ba896cb8f9f676b64e236ae617664001933bec928e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3c5eeaaa20a260ae114ce791570d6168ab24d8cf336f4c2d629ab8e3062db5839800796464daa6f3514e118e058f6e70d94d98fa910ea4558866ce42396d1aeb"} build_url:https://queue.taskcluster.net/v1/task/UcFkgxABQ1GdGMe1PvB1rw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011367 build_url: 'https://queue.taskcluster.net/v1/task/UcFkgxABQ1GdGMe1PvB1rw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0251e0612b8b6ad6e6e022243aea9eee572953c5eb6c96b7a41382a6d0b396842804cb032e23f20f0c8780fe7280ca4a5b1652b8cf23e92c7d853bb929e6525d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c665386c49b3bd4eac0fcec9a2bdfade9c5e1e3fe65fb23cbe7362db3c3a2d77e5c7acf5618e6861566968ba896cb8f9f676b64e236ae617664001933bec928e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3c5eeaaa20a260ae114ce791570d6168ab24d8cf336f4c2d629ab8e3062db5839800796464daa6f3514e118e058f6e70d94d98fa910ea4558866ce42396d1aeb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 16:08:55.112443) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 16:08:55.112811) ========= 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=d2a8c569965ab8367867b893000001a1-1468622503.917993-2010076320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004622 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 16:08:55.195418) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 16:08:55.195729) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 16:08:55.196080) ========= ========= Total master_lag: 0.16 =========